builder: graphics_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0009 starttime: 1484192414.59 results: success (0) buildid: 20170111180116 builduid: a05b515c4b454e36a3662fd4d420c900 revision: d9361bf7a173d95afd1f399ca5ab78ecec0f56fd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-11 19:40:14.585681) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-11 19:40:14.586210) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-11 19:40:14.586527) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-11 19:40:14.613175) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 19:40:14.613597) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7MvL0giBCw/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.tKDcAfy8oq/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-11 19:40:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 64.2M=0s 2017-01-11 19:40:14 (64.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.135948 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 19:40:14.773639) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 19:40:14.773999) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7MvL0giBCw/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.tKDcAfy8oq/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.021577 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 19:40:14.823291) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-11 19:40:14.823693) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev d9361bf7a173d95afd1f399ca5ab78ecec0f56fd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev d9361bf7a173d95afd1f399ca5ab78ecec0f56fd --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7MvL0giBCw/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.tKDcAfy8oq/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-11 19:40:14,903 truncating revision to first 12 chars 2017-01-11 19:40:14,903 Setting DEBUG logging. 2017-01-11 19:40:14,903 attempt 1/10 2017-01-11 19:40:14,903 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/d9361bf7a173?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-11 19:40:16,415 unpacking tar archive at: graphics-d9361bf7a173/testing/mozharness/ program finished with exit code 0 elapsedTime=1.771663 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-11 19:40:16.619956) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-11 19:40:16.620351) ========= script_repo_revision: d9361bf7a173d95afd1f399ca5ab78ecec0f56fd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-11 19:40:16.620783) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-11 19:40:16.621105) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-11 19:40:16.641408) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-01-11 19:40:16.641855) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Graphics', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7MvL0giBCw/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.tKDcAfy8oq/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 19:40:16 INFO - MultiFileLogger online at 20170111 19:40:16 in /builds/slave/test 19:40:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 19:40:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:40:16 INFO - {'append_to_log': False, 19:40:16 INFO - 'base_work_dir': '/builds/slave/test', 19:40:16 INFO - 'blob_upload_branch': 'Graphics', 19:40:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:40:16 INFO - 'branch': 'Graphics', 19:40:16 INFO - 'buildbot_json_path': 'buildprops.json', 19:40:16 INFO - 'config_files': ('talos/mac_config.py',), 19:40:16 INFO - 'default_actions': ('clobber', 19:40:16 INFO - 'read-buildbot-config', 19:40:16 INFO - 'download-and-extract', 19:40:16 INFO - 'populate-webroot', 19:40:16 INFO - 'create-virtualenv', 19:40:16 INFO - 'install', 19:40:16 INFO - 'run-tests'), 19:40:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:40:16 INFO - 'download_minidump_stackwalk': True, 19:40:16 INFO - 'download_symbols': 'ondemand', 19:40:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:40:16 INFO - 'tooltool.py': '/tools/tooltool.py', 19:40:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:40:16 INFO - '/tools/misc-python/virtualenv.py')}, 19:40:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:40:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:40:16 INFO - 'installer_path': 'installer.exe', 19:40:16 INFO - 'log_level': 'info', 19:40:16 INFO - 'log_name': 'talos', 19:40:16 INFO - 'log_to_console': True, 19:40:16 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:40:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:40:16 INFO - 'opt_config_files': (), 19:40:16 INFO - 'pip_index': False, 19:40:16 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:40:16 INFO - 'cmd': ('bash', 19:40:16 INFO - '-c', 19:40:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:40:16 INFO - 'enabled': True, 19:40:16 INFO - 'halt_on_failure': False, 19:40:16 INFO - 'name': 'check_screen_resolution'},), 19:40:16 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:40:16 INFO - 'cmd': ('bash', 19:40:16 INFO - '-c', 19:40:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:40:16 INFO - 'enabled': True, 19:40:16 INFO - 'halt_on_failure': False, 19:40:16 INFO - 'name': 'check_screen_resolution'},), 19:40:16 INFO - 'run_cmd_checks_enabled': True, 19:40:16 INFO - 'sps_profile': False, 19:40:16 INFO - 'sps_profile_interval': 0, 19:40:16 INFO - 'suite': 'dromaeojs', 19:40:16 INFO - 'system_bits': '32', 19:40:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:40:16 INFO - 'title': 't-yosemite-r7-0009', 19:40:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:40:16 INFO - 'use_talos_json': True, 19:40:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:40:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:40:16 INFO - 'work_dir': 'build'} 19:40:16 INFO - [mozharness: 2017-01-12 03:40:16.847487Z] Running clobber step. 19:40:16 INFO - Running pre-action listener: _resource_record_pre_action 19:40:16 INFO - Running main action method: clobber 19:40:16 INFO - rmtree: /builds/slave/test/build 19:40:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:40:17 INFO - Running post-action listener: _resource_record_post_action 19:40:17 INFO - [mozharness: 2017-01-12 03:40:17.003799Z] Finished clobber step (success) 19:40:17 INFO - [mozharness: 2017-01-12 03:40:17.003939Z] Running read-buildbot-config step. 19:40:17 INFO - Running pre-action listener: _resource_record_pre_action 19:40:17 INFO - Running main action method: read_buildbot_config 19:40:17 INFO - Using buildbot properties: 19:40:17 INFO - { 19:40:17 INFO - "project": "", 19:40:17 INFO - "product": "firefox", 19:40:17 INFO - "script_repo_revision": "default", 19:40:17 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs", 19:40:17 INFO - "repository": "", 19:40:17 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs", 19:40:17 INFO - "buildid": "20170111180116", 19:40:17 INFO - "pgo_build": "False", 19:40:17 INFO - "basedir": "/builds/slave/test", 19:40:17 INFO - "buildnumber": 8, 19:40:17 INFO - "slavename": "t-yosemite-r7-0009", 19:40:17 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 19:40:17 INFO - "platform": "yosemite_r7", 19:40:17 INFO - "scheduler": "tests-graphics-macosx64-talos", 19:40:17 INFO - "branch": "graphics", 19:40:17 INFO - "repo_path": "projects/graphics", 19:40:17 INFO - "revision": "d9361bf7a173d95afd1f399ca5ab78ecec0f56fd", 19:40:17 INFO - "stage_platform": "macosx64", 19:40:17 INFO - "builduid": "a05b515c4b454e36a3662fd4d420c900", 19:40:17 INFO - "slavebuilddir": "test" 19:40:17 INFO - } 19:40:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/NaUEN1gnQHSjUye_UTWFEQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 19:40:17 INFO - Running post-action listener: _resource_record_post_action 19:40:17 INFO - [mozharness: 2017-01-12 03:40:17.007241Z] Finished read-buildbot-config step (success) 19:40:17 INFO - [mozharness: 2017-01-12 03:40:17.007342Z] Running download-and-extract step. 19:40:17 INFO - Running pre-action listener: _resource_record_pre_action 19:40:17 INFO - Running main action method: download_and_extract 19:40:17 INFO - mkdir: /builds/slave/test/build/tests 19:40:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:40:17 INFO - trying https://queue.taskcluster.net/v1/task/NaUEN1gnQHSjUye_UTWFEQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 19:40:17 INFO - Downloading https://queue.taskcluster.net/v1/task/NaUEN1gnQHSjUye_UTWFEQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 19:40:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NaUEN1gnQHSjUye_UTWFEQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 19:40:17 INFO - Downloaded 1199 bytes. 19:40:17 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 19:40:17 INFO - Using the following test package requirements: 19:40:17 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 19:40:17 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:40:17 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 19:40:17 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:40:17 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 19:40:17 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:40:17 INFO - u'jsshell-mac.zip'], 19:40:17 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:40:17 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 19:40:17 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 19:40:17 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:40:17 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 19:40:17 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:40:17 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 19:40:17 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:40:17 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 19:40:17 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:40:17 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 19:40:17 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:40:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NaUEN1gnQHSjUye_UTWFEQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 19:40:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NaUEN1gnQHSjUye_UTWFEQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:40:17 INFO - Fetch https://queue.taskcluster.net/v1/task/NaUEN1gnQHSjUye_UTWFEQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 19:40:18 INFO - Expected file size: 16311446 19:40:18 INFO - Obtained file size: 16311446 19:40:25 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 19:40:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NaUEN1gnQHSjUye_UTWFEQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 19:40:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NaUEN1gnQHSjUye_UTWFEQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:40:25 INFO - Fetch https://queue.taskcluster.net/v1/task/NaUEN1gnQHSjUye_UTWFEQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 19:40:26 INFO - Expected file size: 16311446 19:40:26 INFO - Obtained file size: 16311446 19:40:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NaUEN1gnQHSjUye_UTWFEQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 19:40:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NaUEN1gnQHSjUye_UTWFEQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 19:40:32 INFO - Fetch https://queue.taskcluster.net/v1/task/NaUEN1gnQHSjUye_UTWFEQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 19:40:34 INFO - Expected file size: 14403529 19:40:34 INFO - Obtained file size: 14403529 19:40:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:40:34 INFO - trying https://queue.taskcluster.net/v1/task/NaUEN1gnQHSjUye_UTWFEQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 19:40:34 INFO - Downloading https://queue.taskcluster.net/v1/task/NaUEN1gnQHSjUye_UTWFEQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 19:40:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NaUEN1gnQHSjUye_UTWFEQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 19:40:36 INFO - Downloaded 69922545 bytes. 19:40:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NaUEN1gnQHSjUye_UTWFEQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 19:40:36 INFO - mkdir: /builds/slave/test/properties 19:40:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:40:36 INFO - Writing to file /builds/slave/test/properties/build_url 19:40:36 INFO - Contents: 19:40:36 INFO - build_url:https://queue.taskcluster.net/v1/task/NaUEN1gnQHSjUye_UTWFEQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 19:40:37 INFO - Running post-action listener: _resource_record_post_action 19:40:37 INFO - Running post-action listener: set_extra_try_arguments 19:40:37 INFO - [mozharness: 2017-01-12 03:40:37.283308Z] Finished download-and-extract step (success) 19:40:37 INFO - [mozharness: 2017-01-12 03:40:37.283403Z] Running populate-webroot step. 19:40:37 INFO - Running pre-action listener: _resource_record_pre_action 19:40:37 INFO - Running main action method: populate_webroot 19:40:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:40:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:40:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:40:37 INFO - '--tppagecycles', 19:40:37 INFO - '7'], 19:40:37 INFO - 'tests': ['tsvgm']}}, 19:40:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:40:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:40:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:40:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:40:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:40:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:40:37 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:40:37 INFO - 'talos_options': ['--disable-e10s'], 19:40:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:40:37 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:40:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:40:37 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:40:37 INFO - 'talos_options': ['--disable-e10s'], 19:40:37 INFO - 'tests': ['damp', 'tps']}, 19:40:37 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:40:37 INFO - 'tests': ['damp', 'tps']}, 19:40:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:40:37 INFO - 'tests': ['dromaeo_dom']}, 19:40:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:40:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:40:37 INFO - 'tests': ['basic_compositor_video']}, 19:40:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:40:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:40:37 INFO - 'tests': ['a11yr', 19:40:37 INFO - 'ts_paint', 19:40:37 INFO - 'tpaint', 19:40:37 INFO - 'sessionrestore', 19:40:37 INFO - 'sessionrestore_no_auto_restore', 19:40:37 INFO - 'tabpaint']}, 19:40:37 INFO - 'other-e10s': {'tests': ['a11yr', 19:40:37 INFO - 'ts_paint', 19:40:37 INFO - 'tpaint', 19:40:37 INFO - 'sessionrestore', 19:40:37 INFO - 'sessionrestore_no_auto_restore', 19:40:37 INFO - 'tabpaint']}, 19:40:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:40:37 INFO - 'ts_paint', 19:40:37 INFO - 'tpaint', 19:40:37 INFO - 'sessionrestore', 19:40:37 INFO - 'sessionrestore_no_auto_restore', 19:40:37 INFO - 'tabpaint']}, 19:40:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:40:37 INFO - 'ts_paint', 19:40:37 INFO - 'tpaint', 19:40:37 INFO - 'sessionrestore', 19:40:37 INFO - 'sessionrestore_no_auto_restore', 19:40:37 INFO - 'tabpaint']}, 19:40:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:40:37 INFO - 'tests': ['a11yr', 19:40:37 INFO - 'ts_paint', 19:40:37 INFO - 'tpaint', 19:40:37 INFO - 'sessionrestore', 19:40:37 INFO - 'sessionrestore_no_auto_restore', 19:40:37 INFO - 'tabpaint']}, 19:40:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:40:37 INFO - 'tests': ['a11yr', 19:40:37 INFO - 'ts_paint', 19:40:37 INFO - 'tpaint', 19:40:37 INFO - 'sessionrestore', 19:40:37 INFO - 'sessionrestore_no_auto_restore', 19:40:37 INFO - 'tabpaint']}, 19:40:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:40:37 INFO - 'tests': ['tsvgx', 19:40:37 INFO - 'tsvgr_opacity', 19:40:37 INFO - 'tart', 19:40:37 INFO - 'tscrollx', 19:40:37 INFO - 'cart', 19:40:37 INFO - 'tsvg_static']}, 19:40:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:40:37 INFO - 'tsvgr_opacity', 19:40:37 INFO - 'tart', 19:40:37 INFO - 'tscrollx', 19:40:37 INFO - 'cart', 19:40:37 INFO - 'tsvg_static']}, 19:40:37 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:40:37 INFO - 'talos_options': ['--disable-e10s'], 19:40:37 INFO - 'tests': ['tp5o']}, 19:40:37 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:40:37 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:40:37 INFO - 'talos_options': ['--disable-e10s', 19:40:37 INFO - '--xperf_path', 19:40:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:40:37 INFO - 'tests': ['tp5n']}, 19:40:37 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:40:37 INFO - 'talos_options': ['--xperf_path', 19:40:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:40:37 INFO - 'tests': ['tp5n']}}, 19:40:37 INFO - 'talos.zip': {'path': '', 19:40:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:40:37 INFO - Running post-action listener: _resource_record_post_action 19:40:37 INFO - [mozharness: 2017-01-12 03:40:37.301946Z] Finished populate-webroot step (success) 19:40:37 INFO - [mozharness: 2017-01-12 03:40:37.302087Z] Running create-virtualenv step. 19:40:37 INFO - Running pre-action listener: _resource_record_pre_action 19:40:37 INFO - Running main action method: create_virtualenv 19:40:37 INFO - Creating virtualenv /builds/slave/test/build/venv 19:40:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:40:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:40:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:40:37 INFO - Using real prefix '/tools/python27' 19:40:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:40:38 INFO - Installing distribute.............................................................................................................................................................................................done. 19:40:40 INFO - Installing pip.................done. 19:40:41 INFO - Return code: 0 19:40:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:40:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:40:41 INFO - Reading from file tmpfile_stdout 19:40:41 INFO - Output received: 19:40:41 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 19:40:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:40:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:40:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:40:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108676b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108679768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb46b4b5700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108454d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10837bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108449be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MvL0giBCw/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tKDcAfy8oq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:40:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:40:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:40:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MvL0giBCw/Render', 19:40:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:40:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:40:41 INFO - 'HOME': '/Users/cltbld', 19:40:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:40:41 INFO - 'LOGNAME': 'cltbld', 19:40:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:41 INFO - 'MOZ_NO_REMOTE': '1', 19:40:41 INFO - 'NO_EM_RESTART': '1', 19:40:41 INFO - 'PAGER': '/bin/cat', 19:40:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:40:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:41 INFO - 'PWD': '/builds/slave/test', 19:40:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:40:41 INFO - 'SHELL': '/bin/bash', 19:40:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tKDcAfy8oq/Listeners', 19:40:41 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 19:40:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:40:41 INFO - 'USER': 'cltbld', 19:40:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:40:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:40:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:41 INFO - 'XPC_FLAGS': '0x0', 19:40:41 INFO - 'XPC_SERVICE_NAME': '0', 19:40:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:40:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:41 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:40:41 INFO - Cleaning up... 19:40:41 INFO - Return code: 0 19:40:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:40:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:40:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:40:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108676b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108679768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb46b4b5700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108454d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10837bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108449be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MvL0giBCw/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tKDcAfy8oq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:40:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:40:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:40:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MvL0giBCw/Render', 19:40:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:40:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:40:41 INFO - 'HOME': '/Users/cltbld', 19:40:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:40:41 INFO - 'LOGNAME': 'cltbld', 19:40:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:41 INFO - 'MOZ_NO_REMOTE': '1', 19:40:41 INFO - 'NO_EM_RESTART': '1', 19:40:41 INFO - 'PAGER': '/bin/cat', 19:40:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:40:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:41 INFO - 'PWD': '/builds/slave/test', 19:40:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:40:41 INFO - 'SHELL': '/bin/bash', 19:40:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tKDcAfy8oq/Listeners', 19:40:41 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 19:40:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:40:41 INFO - 'USER': 'cltbld', 19:40:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:40:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:40:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:41 INFO - 'XPC_FLAGS': '0x0', 19:40:41 INFO - 'XPC_SERVICE_NAME': '0', 19:40:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:40:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:41 INFO - Downloading/unpacking psutil>=3.1.1 19:40:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:40:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:40:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:40:45 INFO - Installing collected packages: psutil 19:40:45 INFO - Running setup.py install for psutil 19:40:45 INFO - building 'psutil._psutil_osx' extension 19:40:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 19:40:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 19:40:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 19:40:45 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 19:40:45 INFO - building 'psutil._psutil_posix' extension 19:40:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 19:40:45 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:40:45 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:40:45 INFO - ^ 19:40:46 INFO - 1 warning generated. 19:40:46 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 19:40:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:40:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:40:46 INFO - Successfully installed psutil 19:40:46 INFO - Cleaning up... 19:40:46 INFO - Return code: 0 19:40:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:40:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:40:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:40:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108676b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108679768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb46b4b5700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108454d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10837bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108449be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MvL0giBCw/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tKDcAfy8oq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:40:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:40:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:40:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MvL0giBCw/Render', 19:40:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:40:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:40:46 INFO - 'HOME': '/Users/cltbld', 19:40:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:40:46 INFO - 'LOGNAME': 'cltbld', 19:40:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:46 INFO - 'MOZ_NO_REMOTE': '1', 19:40:46 INFO - 'NO_EM_RESTART': '1', 19:40:46 INFO - 'PAGER': '/bin/cat', 19:40:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:40:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:46 INFO - 'PWD': '/builds/slave/test', 19:40:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:40:46 INFO - 'SHELL': '/bin/bash', 19:40:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tKDcAfy8oq/Listeners', 19:40:46 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 19:40:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:40:46 INFO - 'USER': 'cltbld', 19:40:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:40:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:40:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:46 INFO - 'XPC_FLAGS': '0x0', 19:40:46 INFO - 'XPC_SERVICE_NAME': '0', 19:40:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:40:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:40:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:40:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:40:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:40:49 INFO - Installing collected packages: mozsystemmonitor 19:40:49 INFO - Running setup.py install for mozsystemmonitor 19:40:49 INFO - Successfully installed mozsystemmonitor 19:40:49 INFO - Cleaning up... 19:40:49 INFO - Return code: 0 19:40:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:40:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:40:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108676b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108679768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb46b4b5700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108454d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10837bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108449be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MvL0giBCw/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tKDcAfy8oq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:40:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:40:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:40:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MvL0giBCw/Render', 19:40:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:40:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:40:49 INFO - 'HOME': '/Users/cltbld', 19:40:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:40:49 INFO - 'LOGNAME': 'cltbld', 19:40:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:49 INFO - 'MOZ_NO_REMOTE': '1', 19:40:49 INFO - 'NO_EM_RESTART': '1', 19:40:49 INFO - 'PAGER': '/bin/cat', 19:40:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:40:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:49 INFO - 'PWD': '/builds/slave/test', 19:40:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:40:49 INFO - 'SHELL': '/bin/bash', 19:40:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tKDcAfy8oq/Listeners', 19:40:49 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 19:40:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:40:49 INFO - 'USER': 'cltbld', 19:40:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:40:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:40:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:49 INFO - 'XPC_FLAGS': '0x0', 19:40:49 INFO - 'XPC_SERVICE_NAME': '0', 19:40:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:40:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:49 INFO - Downloading/unpacking jsonschema==2.5.1 19:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:40:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:52 INFO - Downloading functools32-3.2.3-2.tar.gz 19:40:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:40:52 INFO - warning: no files found matching '*.txt' 19:40:52 INFO - no previously-included directories found matching 'build' 19:40:52 INFO - no previously-included directories found matching 'dist' 19:40:52 INFO - no previously-included directories found matching '.git*' 19:40:52 INFO - Installing collected packages: jsonschema, functools32 19:40:52 INFO - Running setup.py install for functools32 19:40:53 INFO - warning: no files found matching '*.txt' 19:40:53 INFO - no previously-included directories found matching 'build' 19:40:53 INFO - no previously-included directories found matching 'dist' 19:40:53 INFO - no previously-included directories found matching '.git*' 19:40:53 INFO - Successfully installed jsonschema functools32 19:40:53 INFO - Cleaning up... 19:40:53 INFO - Return code: 0 19:40:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:40:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:40:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:40:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108676b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108679768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb46b4b5700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108454d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10837bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108449be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MvL0giBCw/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tKDcAfy8oq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:40:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:40:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:40:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MvL0giBCw/Render', 19:40:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:40:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:40:53 INFO - 'HOME': '/Users/cltbld', 19:40:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:40:53 INFO - 'LOGNAME': 'cltbld', 19:40:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:53 INFO - 'MOZ_NO_REMOTE': '1', 19:40:53 INFO - 'NO_EM_RESTART': '1', 19:40:53 INFO - 'PAGER': '/bin/cat', 19:40:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:40:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:53 INFO - 'PWD': '/builds/slave/test', 19:40:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:40:53 INFO - 'SHELL': '/bin/bash', 19:40:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tKDcAfy8oq/Listeners', 19:40:53 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 19:40:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:40:53 INFO - 'USER': 'cltbld', 19:40:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:40:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:40:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:53 INFO - 'XPC_FLAGS': '0x0', 19:40:53 INFO - 'XPC_SERVICE_NAME': '0', 19:40:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:40:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:40:53 INFO - Cleaning up... 19:40:53 INFO - Return code: 0 19:40:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:40:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:40:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:40:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108676b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108679768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb46b4b5700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108454d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10837bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108449be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MvL0giBCw/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tKDcAfy8oq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:40:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:40:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:40:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MvL0giBCw/Render', 19:40:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:40:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:40:53 INFO - 'HOME': '/Users/cltbld', 19:40:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:40:53 INFO - 'LOGNAME': 'cltbld', 19:40:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:53 INFO - 'MOZ_NO_REMOTE': '1', 19:40:53 INFO - 'NO_EM_RESTART': '1', 19:40:53 INFO - 'PAGER': '/bin/cat', 19:40:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:40:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:53 INFO - 'PWD': '/builds/slave/test', 19:40:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:40:53 INFO - 'SHELL': '/bin/bash', 19:40:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tKDcAfy8oq/Listeners', 19:40:53 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 19:40:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:40:53 INFO - 'USER': 'cltbld', 19:40:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:40:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:40:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:53 INFO - 'XPC_FLAGS': '0x0', 19:40:53 INFO - 'XPC_SERVICE_NAME': '0', 19:40:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:40:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:53 INFO - Downloading/unpacking blobuploader==1.2.4 19:40:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:56 INFO - Downloading blobuploader-1.2.4.tar.gz 19:40:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:40:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:40:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:40:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:57 INFO - Downloading docopt-0.6.1.tar.gz 19:40:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:40:57 INFO - Installing collected packages: blobuploader, requests, docopt 19:40:57 INFO - Running setup.py install for blobuploader 19:40:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:40:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:40:57 INFO - Running setup.py install for requests 19:40:58 INFO - Running setup.py install for docopt 19:40:58 INFO - Successfully installed blobuploader requests docopt 19:40:58 INFO - Cleaning up... 19:40:58 INFO - Return code: 0 19:40:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:40:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:40:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108676b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108679768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb46b4b5700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108454d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10837bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108449be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MvL0giBCw/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tKDcAfy8oq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:40:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:40:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:40:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MvL0giBCw/Render', 19:40:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:40:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:40:58 INFO - 'HOME': '/Users/cltbld', 19:40:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:40:58 INFO - 'LOGNAME': 'cltbld', 19:40:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:58 INFO - 'MOZ_NO_REMOTE': '1', 19:40:58 INFO - 'NO_EM_RESTART': '1', 19:40:58 INFO - 'PAGER': '/bin/cat', 19:40:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:40:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:58 INFO - 'PWD': '/builds/slave/test', 19:40:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:40:58 INFO - 'SHELL': '/bin/bash', 19:40:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tKDcAfy8oq/Listeners', 19:40:58 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 19:40:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:40:58 INFO - 'USER': 'cltbld', 19:40:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:40:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:40:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:58 INFO - 'XPC_FLAGS': '0x0', 19:40:58 INFO - 'XPC_SERVICE_NAME': '0', 19:40:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:40:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:40:58 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-zrbMFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:40:58 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-tGOIJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:40:59 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-VJYugH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:40:59 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-x4ohvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:40:59 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-12zQbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:40:59 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-3zcBpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:40:59 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-BE_ovQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:40:59 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-Z9vGmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:40:59 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-tmsEzy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:40:59 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-U8jWlz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:40:59 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-Y31uSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:40:59 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-tsftDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:41:00 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-4wRmFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:41:00 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-bDfj5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:41:00 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-2mDSF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:41:00 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-QlJSye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:41:00 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-VSmdc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:41:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:41:00 INFO - Running setup.py install for manifestparser 19:41:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:41:00 INFO - Running setup.py install for mozcrash 19:41:00 INFO - Running setup.py install for mozdebug 19:41:01 INFO - Running setup.py install for mozdevice 19:41:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:41:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:41:01 INFO - Running setup.py install for mozfile 19:41:01 INFO - Running setup.py install for mozhttpd 19:41:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:41:01 INFO - Running setup.py install for mozinfo 19:41:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:41:01 INFO - Running setup.py install for mozInstall 19:41:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:41:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:41:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:41:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:41:01 INFO - Running setup.py install for mozleak 19:41:01 INFO - Running setup.py install for mozlog 19:41:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:41:02 INFO - Running setup.py install for moznetwork 19:41:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:41:02 INFO - Running setup.py install for mozprocess 19:41:02 INFO - Running setup.py install for mozprofile 19:41:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:41:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:41:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:41:02 INFO - Running setup.py install for mozrunner 19:41:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:41:02 INFO - Running setup.py install for mozscreenshot 19:41:02 INFO - Running setup.py install for moztest 19:41:03 INFO - Running setup.py install for mozversion 19:41:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:41:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:41:03 INFO - Cleaning up... 19:41:03 INFO - Return code: 0 19:41:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:41:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:41:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:41:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:41:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108676b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108679768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb46b4b5700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108454d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10837bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108449be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MvL0giBCw/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tKDcAfy8oq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:41:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:41:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:41:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MvL0giBCw/Render', 19:41:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:41:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:41:03 INFO - 'HOME': '/Users/cltbld', 19:41:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:41:03 INFO - 'LOGNAME': 'cltbld', 19:41:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:41:03 INFO - 'MOZ_NO_REMOTE': '1', 19:41:03 INFO - 'NO_EM_RESTART': '1', 19:41:03 INFO - 'PAGER': '/bin/cat', 19:41:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:41:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:41:03 INFO - 'PWD': '/builds/slave/test', 19:41:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:41:03 INFO - 'SHELL': '/bin/bash', 19:41:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tKDcAfy8oq/Listeners', 19:41:03 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 19:41:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:41:03 INFO - 'USER': 'cltbld', 19:41:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:41:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:41:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:41:03 INFO - 'XPC_FLAGS': '0x0', 19:41:03 INFO - 'XPC_SERVICE_NAME': '0', 19:41:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:41:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:41:03 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-c5Pbjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:41:03 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-_F1bFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:41:03 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-5BnreH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:41:03 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-npPfVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:41:03 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-cY54Zi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:41:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 19:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:41:04 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-yI5lmH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:41:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 19:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:41:04 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-R9qagP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:41:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:41:04 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-uVNrnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:41:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:41:04 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-mv8K03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:41:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:41:04 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-tzrhhK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:41:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:41:04 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-LCKND_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:41:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:41:04 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-ac0C6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:41:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:41:04 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-Q4RA1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:41:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:41:04 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-h4HTic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:41:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:41:04 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-OlVE0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:41:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:41:05 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-vJskiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:41:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:41:05 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-kgJ7bB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:41:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 19:41:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:41:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:41:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:41:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:41:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:41:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:41:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:41:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:41:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:41:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:41:07 INFO - Downloading blessings-1.6.tar.gz 19:41:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:41:07 INFO - Installing collected packages: blessings 19:41:07 INFO - Running setup.py install for blessings 19:41:08 INFO - Successfully installed blessings 19:41:08 INFO - Cleaning up... 19:41:08 INFO - Return code: 0 19:41:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:41:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:41:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:41:08 INFO - Reading from file tmpfile_stdout 19:41:08 INFO - Current package versions: 19:41:08 INFO - blessings == 1.6 19:41:08 INFO - blobuploader == 1.2.4 19:41:08 INFO - docopt == 0.6.1 19:41:08 INFO - functools32 == 3.2.3-2 19:41:08 INFO - jsonschema == 2.5.1 19:41:08 INFO - manifestparser == 1.1 19:41:08 INFO - mozInstall == 1.12 19:41:08 INFO - mozcrash == 1.0 19:41:08 INFO - mozdebug == 0.1 19:41:08 INFO - mozdevice == 0.49 19:41:08 INFO - mozfile == 1.2 19:41:08 INFO - mozhttpd == 0.7 19:41:08 INFO - mozinfo == 0.9 19:41:08 INFO - mozleak == 0.1 19:41:08 INFO - mozlog == 3.4 19:41:08 INFO - moznetwork == 0.27 19:41:08 INFO - mozprocess == 0.24 19:41:08 INFO - mozprofile == 0.28 19:41:08 INFO - mozrunner == 6.13 19:41:08 INFO - mozscreenshot == 0.1 19:41:08 INFO - mozsystemmonitor == 0.3 19:41:08 INFO - moztest == 0.8 19:41:08 INFO - mozversion == 1.4 19:41:08 INFO - psutil == 3.1.1 19:41:08 INFO - requests == 1.2.3 19:41:08 INFO - wsgiref == 0.1.2 19:41:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:41:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:41:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:41:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:41:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:41:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108676b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108679768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb46b4b5700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108454d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10837bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108449be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MvL0giBCw/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tKDcAfy8oq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:41:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:41:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:41:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MvL0giBCw/Render', 19:41:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:41:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:41:08 INFO - 'HOME': '/Users/cltbld', 19:41:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:41:08 INFO - 'LOGNAME': 'cltbld', 19:41:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:41:08 INFO - 'MOZ_NO_REMOTE': '1', 19:41:08 INFO - 'NO_EM_RESTART': '1', 19:41:08 INFO - 'PAGER': '/bin/cat', 19:41:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:41:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:41:08 INFO - 'PWD': '/builds/slave/test', 19:41:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:41:08 INFO - 'SHELL': '/bin/bash', 19:41:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tKDcAfy8oq/Listeners', 19:41:08 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 19:41:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:41:08 INFO - 'USER': 'cltbld', 19:41:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:41:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:41:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:41:08 INFO - 'XPC_FLAGS': '0x0', 19:41:08 INFO - 'XPC_SERVICE_NAME': '0', 19:41:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:41:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:41:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:41:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 19:41:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:41:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:41:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 19:41:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 19:41:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 19:41:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 19:41:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 19:41:08 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:41:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:41:08 INFO - Cleaning up... 19:41:08 INFO - Return code: 0 19:41:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:41:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:41:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:41:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:41:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:41:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108676b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108679768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb46b4b5700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108454d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10837bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108449be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MvL0giBCw/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tKDcAfy8oq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:41:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:41:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:41:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MvL0giBCw/Render', 19:41:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:41:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:41:08 INFO - 'HOME': '/Users/cltbld', 19:41:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:41:08 INFO - 'LOGNAME': 'cltbld', 19:41:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:41:08 INFO - 'MOZ_NO_REMOTE': '1', 19:41:08 INFO - 'NO_EM_RESTART': '1', 19:41:08 INFO - 'PAGER': '/bin/cat', 19:41:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:41:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:41:08 INFO - 'PWD': '/builds/slave/test', 19:41:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:41:08 INFO - 'SHELL': '/bin/bash', 19:41:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tKDcAfy8oq/Listeners', 19:41:08 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 19:41:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:41:08 INFO - 'USER': 'cltbld', 19:41:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:41:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:41:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:41:08 INFO - 'XPC_FLAGS': '0x0', 19:41:08 INFO - 'XPC_SERVICE_NAME': '0', 19:41:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:41:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:41:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:41:09 INFO - Cleaning up... 19:41:09 INFO - Return code: 0 19:41:09 INFO - Running post-action listener: _resource_record_post_action 19:41:09 INFO - Running post-action listener: _start_resource_monitoring 19:41:09 INFO - Starting resource monitoring. 19:41:09 INFO - [mozharness: 2017-01-12 03:41:09.135917Z] Finished create-virtualenv step (success) 19:41:09 INFO - [mozharness: 2017-01-12 03:41:09.136747Z] Running install step. 19:41:09 INFO - Running pre-action listener: _resource_record_pre_action 19:41:09 INFO - Running main action method: install 19:41:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:41:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:41:09 INFO - Reading from file tmpfile_stdout 19:41:09 INFO - Detecting whether we're running mozinstall >=1.0... 19:41:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:41:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:41:09 INFO - Reading from file tmpfile_stdout 19:41:09 INFO - Output received: 19:41:09 INFO - Usage: mozinstall [options] installer 19:41:09 INFO - Options: 19:41:09 INFO - -h, --help show this help message and exit 19:41:09 INFO - -d DEST, --destination=DEST 19:41:09 INFO - Directory to install application into. [default: 19:41:09 INFO - "/builds/slave/test"] 19:41:09 INFO - --app=APP Application being installed. [default: firefox] 19:41:09 INFO - mkdir: /builds/slave/test/build/application 19:41:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:41:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 19:41:31 INFO - Reading from file tmpfile_stdout 19:41:31 INFO - Output received: 19:41:31 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:41:31 INFO - Running post-action listener: _resource_record_post_action 19:41:31 INFO - [mozharness: 2017-01-12 03:41:31.206455Z] Finished install step (success) 19:41:31 INFO - [mozharness: 2017-01-12 03:41:31.206588Z] Running run-tests step. 19:41:31 INFO - Running pre-action listener: _resource_record_pre_action 19:41:31 INFO - Running main action method: run_tests 19:41:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:41:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:41:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:41:31 INFO - 2017-01-11 19:41:31.219 screenresolution[1891:8995] starting screenresolution argv=screenresolution get 19:41:31 INFO - 2017-01-11 19:41:31.222 screenresolution[1891:8995] Display 0: 1600x1200x32@60 19:41:31 INFO - 2017-01-11 19:41:31.227 screenresolution[1892:8997] starting screenresolution argv=screenresolution list 19:41:31 INFO - Available Modes on Display 0 19:41:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:41:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:41:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:41:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:41:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:41:31 INFO - Intel Iris: 19:41:31 INFO - Chipset Model: Intel Iris 19:41:31 INFO - Type: GPU 19:41:31 INFO - Bus: Built-In 19:41:31 INFO - VRAM (Dynamic, Max): 1536 MB 19:41:31 INFO - Vendor: Intel (0x8086) 19:41:31 INFO - Device ID: 0x0a2e 19:41:31 INFO - Revision ID: 0x0009 19:41:31 INFO - Displays: 19:41:31 INFO - Display: 19:41:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:41:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:41:31 INFO - Display Serial Number: 1600x1200 60 19:41:31 INFO - Main Display: Yes 19:41:31 INFO - Mirror: Off 19:41:31 INFO - Online: Yes 19:41:31 INFO - Rotation: Supported 19:41:31 INFO - Return code: 0 19:41:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:41:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:41:31 INFO - Python 2.7.3 19:41:31 INFO - Return code: 0 19:41:31 INFO - grabbing minidump binary from tooltool 19:41:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:41:31 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108454d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10837bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108449be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:41:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:41:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 19:41:31 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 19:41:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:41:31 INFO - Return code: 0 19:41:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:41:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:41:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:41:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:41:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:41:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NaUEN1gnQHSjUye_UTWFEQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 19:41:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NaUEN1gnQHSjUye_UTWFEQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0009 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 19:41:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MvL0giBCw/Render', 19:41:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:41:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:41:31 INFO - 'HOME': '/Users/cltbld', 19:41:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:41:31 INFO - 'LOGNAME': 'cltbld', 19:41:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:41:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:41:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:41:31 INFO - 'MOZ_NO_REMOTE': '1', 19:41:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:41:31 INFO - 'NO_EM_RESTART': '1', 19:41:31 INFO - 'PAGER': '/bin/cat', 19:41:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:41:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:41:31 INFO - 'PWD': '/builds/slave/test', 19:41:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:41:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:41:31 INFO - 'SHELL': '/bin/bash', 19:41:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tKDcAfy8oq/Listeners', 19:41:31 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 19:41:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:41:31 INFO - 'USER': 'cltbld', 19:41:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:41:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:41:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:41:31 INFO - 'XPC_FLAGS': '0x0', 19:41:31 INFO - 'XPC_SERVICE_NAME': '0', 19:41:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:41:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NaUEN1gnQHSjUye_UTWFEQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:41:31 INFO - mozversion application_buildid: 20170111180116 19:41:31 INFO - mozversion application_changeset: d9361bf7a173d95afd1f399ca5ab78ecec0f56fd 19:41:31 INFO - mozversion application_display_name: Nightly 19:41:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:41:31 INFO - mozversion application_name: Firefox 19:41:31 INFO - mozversion application_remotingname: firefox 19:41:31 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 19:41:31 INFO - mozversion application_vendor: Mozilla 19:41:31 INFO - mozversion application_version: 53.0a1 19:41:31 INFO - mozversion platform_buildid: 20170111180116 19:41:31 INFO - mozversion platform_changeset: d9361bf7a173d95afd1f399ca5ab78ecec0f56fd 19:41:31 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 19:41:31 INFO - mozversion platform_version: 53.0a1 19:41:31 INFO - using testdate: 1484192491 19:41:31 INFO - actual date: 1484192491 19:41:31 INFO - starting webserver on 'localhost:49374' 19:41:31 INFO - SUITE-START | Running 2 tests 19:41:31 INFO - TEST-START | dromaeo_css 19:41:31 INFO - operating with platform_type : mac_ 19:41:31 INFO - Initialising browser for dromaeo_css test... 19:41:31 INFO - TEST-INFO | started process 1902 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpdpUa34/profile http://localhost:49374/getInfo.html) 19:41:33 INFO - PROCESS | 1902 | __metrics Screen width/height:1600/1200 19:41:33 INFO - PROCESS | 1902 | colorDepth:24 19:41:33 INFO - PROCESS | 1902 | Browser inner width/height: 1024/689 19:41:33 INFO - PROCESS | 1902 | __metrics 19:41:34 INFO - PROCESS | 1902 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:41:34 INFO - PROCESS | 1902 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:41:34 INFO - TEST-INFO | 1902: exit 0 19:41:34 INFO - Browser initialized. 19:41:34 INFO - Running cycle 1/1 for dromaeo_css test... 19:41:34 INFO - TEST-INFO | started process 1904 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpdpUa34/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:41:46 INFO - PROCESS | 1904 | RSS: Main: 233795584 19:41:46 INFO - PROCESS | 1904 | 19:44:51 INFO - PROCESS | 1904 | Cycle 1(1): loaded http://localhost:49374/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49374/tests/dromaeo/cssquery-ext.html) 19:44:53 INFO - PROCESS | 1904 | RSS: Main: 379162624 19:44:53 INFO - PROCESS | 1904 | 19:46:35 INFO - PROCESS | 1904 | ************************* 19:46:35 INFO - PROCESS | 1904 | A coding exception was thrown and uncaught in a Task. 19:46:35 INFO - PROCESS | 1904 | 19:46:35 INFO - PROCESS | 1904 | Full message: ReferenceError: fetch is not defined 19:46:35 INFO - PROCESS | 1904 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 19:46:35 INFO - PROCESS | 1904 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 19:46:35 INFO - PROCESS | 1904 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 19:46:35 INFO - PROCESS | 1904 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 19:46:35 INFO - PROCESS | 1904 | TaskImpl@resource://gre/modules/Task.jsm:277:3 19:46:35 INFO - PROCESS | 1904 | asyncFunction@resource://gre/modules/Task.jsm:252:14 19:46:35 INFO - PROCESS | 1904 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 19:46:35 INFO - PROCESS | 1904 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 19:46:35 INFO - PROCESS | 1904 | TaskImpl@resource://gre/modules/Task.jsm:277:3 19:46:35 INFO - PROCESS | 1904 | asyncFunction@resource://gre/modules/Task.jsm:252:14 19:46:35 INFO - PROCESS | 1904 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 19:46:35 INFO - PROCESS | 1904 | 19:46:35 INFO - PROCESS | 1904 | ************************* 19:47:56 INFO - PROCESS | 1904 | Cycle 1(1): loaded http://localhost:49374/tests/dromaeo/cssquery-ext.html (next: http://localhost:49374/tests/dromaeo/cssquery-jquery.html) 19:47:56 INFO - PROCESS | 1904 | RSS: Main: 369127424 19:47:56 INFO - PROCESS | 1904 | 19:50:59 INFO - PROCESS | 1904 | Cycle 1(1): loaded http://localhost:49374/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49374/tests/dromaeo/cssquery-mootools.html) 19:50:59 INFO - PROCESS | 1904 | RSS: Main: 336277504 19:50:59 INFO - PROCESS | 1904 | 19:54:02 INFO - PROCESS | 1904 | Cycle 1(1): loaded http://localhost:49374/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49374/tests/dromaeo/cssquery-prototype.html) 19:54:02 INFO - PROCESS | 1904 | RSS: Main: 344408064 19:54:02 INFO - PROCESS | 1904 | 19:57:06 INFO - PROCESS | 1904 | Cycle 1(1): loaded http://localhost:49374/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49374/tests/dromaeo/cssquery-yui.html) 19:57:06 INFO - PROCESS | 1904 | RSS: Main: 334983168 19:57:06 INFO - PROCESS | 1904 | 20:00:10 INFO - PROCESS | 1904 | Cycle 1(1): loaded http://localhost:49374/tests/dromaeo/cssquery-yui.html (next: http://localhost:49374/tests/dromaeo/cssquery-dojo.html) 20:00:10 INFO - PROCESS | 1904 | RSS: Main: 410300416 20:00:10 INFO - PROCESS | 1904 | 20:00:10 INFO - PROCESS | 1904 | __start_tp_report 20:00:10 INFO - PROCESS | 1904 | _x_x_mozilla_page_load 20:00:10 INFO - PROCESS | 1904 | _x_x_mozilla_page_load_details 20:00:10 INFO - PROCESS | 1904 | |i|pagename|runs| 20:00:10 INFO - PROCESS | 1904 | |0;dojo.html;3267.3955318266117;3301.075698804335;3327.1349449143217;3361.2605226850083;3379.273456206915;5538.6399884007515;5554.833354999351;5597.916031259534;5631.6057875948645;5631.831045068644;5648.943510564893;5673.631213971089;5697.173909783079;5733.168690539869;5747.913781293284;5135.666181698178;5144.8713782155555;5217.921731174017;5227.2159176123505;5249.081410753103;5157.355330583677;5264.447233040533;5286.867828304304;5290.1006828839;5314.468553144693;5266.4470230626;5275.182346736262;5290.418054014055;5300.840974770763;5312.17661262503;3914.9804250978846;5098.719570423626;5130.666506677054;5153.6907785532985;5213.713245771481;4275.978620106911;5201.55786758126;5203.427622961472;5238.188080847474;5245.947540524622;5622.044252477089;5674.971625141848;5676.0066988276885;5687.459691329317;5705.657660540381;6123.663198524079;6143.327652471189;6222.875542489125;6246.687665616746;6257.74969001244;5419.783208671648;6176.660283684396;6208.472279856218;6210.937890621081;6255.218097737783;5867.765289388462;5877.324107727666;5882.794102206488;5894.381089985575;5906.379830117861;6223.875522489525;6255.624662520263;6276.717547710364;6311.96844015777;6348.111264422984;6025.517958563304;6075.908861367083;6088.360722124202;6131.877362452726;6139.10982907476;6197.380261973766;6197.845053873689;6199.380061993765;6212.285587157445;6225.782097626561;6111.682900513672;6145.4161854623735;6161.106639537242;6192.535559833031;6223.626582405071;6223.37766223374;6233.844153896189;6235.844103897348;6237.407446292595;6241.500679945593;4960.255961605716;4983.07813054586;4985.5762260208285;4986.4514903360605;5006.549410553068;4283.121959998255;4373.278409062469;4414.757188354672;4417.028253784162;4476.149531588988;5026.824061157842;5812.534997200214;5842.357340692605;5852.94147058524;5869.090291004901;6168.383161683885;6226.501879849692;6227;6253.093301471261;6253.6560489172625;5664.122061080539;5706.115552089433;5797.971010145006;5800.88398232033;5828.0966450200285;5410.242566040757;5423.647462914898;5434.70109143993;5451.863703407367;5518.503334699896;6270.968645156928;6330.461910737639;6344;6353.142325786052;6364.331745166691;6209.410106039919;6229.408206220402;6229.875402491834;6240.563160578898;6255.343188965093;6108.85814249354;6212.97485914819;6214.564980451325;6216.409441103088;6221.844453888689;6067.059605761114;6184.690765461799;6198.659073750807;6210.472109870711;6219.284782249918;5998.25021872266;6128.19758601264;6176.28972668131;6202.162708034538;6214.937850621436;6043.518905264784;6133.785317513865;6156.168917196122;6172.197614310111;6187.443130118311;6009.519238461;6047.546434017554;6062.151298818258;6081.179040829608;6082.118092876596;6044.75820967174;6056.212692349966;6061.242344706911;6071.362506936708;6110.358412366638;6149.7847575334645;6158.04550294705;6168.290646575701;6168.537359697951;6168.537359698131;5832.766689332549;5869.383714709894;5873.471387575139;6039.124326972652;6055.666938318434 20:00:10 INFO - PROCESS | 1904 | |1;ext.html;447.5636254651715;504.45266885429305;504.5509496548073;517;532.1565318969433;29652.85173574132;31679;41512.37731434027;43269.56730432695;43387.3491897621;35742.82128589354;44228.557714422845;44267;44267.55732442674;44450.77774611131;9324;9535.856962145574;9536.570854311572;9545.427274363561;9562.904370956307;7148.642567871611;8777.95611021944;11270.211085224038;11465.885341146564;11531.962123408934;11291.266067705614;11336;11340.716482087973;11346.48940797666;11635.418229088511;8583.313334933191;8782.209601135864;11417.600383986563;11492.31046137226;11521.308721476697;10955.233133680646;11285.943570282096;11295.830562541569;11475.311481311148;11531.365774882379;41617.37573936393;42010;42017;42029.36955945663;42068.3689744651;4007.5190977082643;4019.678425725935;4026.859059932888;4069.308217603015;4153.1486045360625;31377.744890204365;31453.37093258122;31516.842415787774;31525.74402455662;31777.72889084457;3161.4309424303615;3221.5811944447305;3310.4372256716415;3311.3211791582908;3315.022068489777;485128;485848;487925;488534.99999999645;488957.4417023315;62431.68784156141;62731;63286;63482.365176347645;63634.36365636377;66246.33753662498;66270.69834413235;66289;66451.66774166099;66574;15863.12752798584;16091;16105.355785768672;16126.596835079217;16133.193340332937;11227.382493962747;11533.711657208636;12517.248965062125;12580.370981450891;12586.18189817659;12578.371081445892;15613.921930390276;15621.297041633154;15628.2185890705;15640.608984775472;6107.755689772448;7337.669804858794;7392.889106663404;7537;7596.734114306083;869.9956500217459;881.2509367038094;898.9775255618531;914.9313801464783;916.8349697054595;29180.85409572981;30167.547486787716;30456.54315185274;30777;31188.37623247568;1040.4693606260862;1067.7330667333167;1073.1843798713035;1098.5880294889416;1100.691806294223;14181;14269.714605708035;15153.514691620769;15275.770863437057;15728.213589320718;616911;620938;621497;621711;624160;59682;59805;59916.80166396735;59969.700151499834;60099.39900600938;1396.6857457072078;1458.8395276519575;1466.2741942738412;1467.3763650448304;1469.9338529766187;25954.83203255896;27106.051288204817;29322.413551729274;29583.26041848971;29935.401291974475;51071.74464127656;51254.487455124974;51395.74302128465;51447.742761285954;51519.74240128775;529744;531998;532009;533046;533559;39747.40378894261;40205.79897100496;40450.797746011085;40659.98350041272;40856.59143408647;46130.308045378675;46759.53240467688;47238.76380618075;47411.76294118507;47873.28190077082;28932.710672893;38867.80566097151;39091.804540977115;40028.799856000536;40242.798786005886;36555.26889462249;38373;38423.80788096042;39019.046013820414;39757.01822363277;36667.81666091759;37877.431838521894;38025.429618555194;38766.03084922899;38832.22335553329;28834.55827208673;29018.92582097723;29913.700862991092;31541;31971.040868773973;22180;24136.75863241345;24189.274321770376;24523.019079237343;24894.751052489242 20:00:10 INFO - PROCESS | 1904 | |2;jquery.html;373.2795704290718;392.5564112552813;397.62424508839143;402.4084595644402;423.61027854373975;14662.92831799122;16700.83094183406;21202;21252.681209781826;21803.67294490584;21620.459488512795;21885.12459501618;22087.33737987863;22448.66327005096;22475.66286505704;5755.482006619403;5795.855103622401;5921.555883308769;5986.042233242682;5992.400759924017;4169.562195969425;5859.560532960024;5964.314103878066;5975.970120149394;5977.910331345011;4344.152890186399;4353.477582690081;6570.474362051024;6633.568818026837;6636.93363066368;6401.551891367606;6522.77170299042;6626.105475760759;6635.734570617169;6646.26891041985;5704.600677952545;5795.1017592273265;5805.187273781674;5808.3030036395485;5809.157672137559;27065.323366915985;27146;27293.590596141075;27417.725822741715;27423.45153096947;2776.1532732516575;2800.8179468334697;2810.2131403207136;2810.3536186676974;2816.197383745643;15412.845871541253;16064.678706425922;16306.673866522604;16319.428819991363;16360;1790.203359505021;1790.7313902914536;1804.46768203379;1842;1874.5969616532375;132258;136780;137254.31372843072;139524;140533.2973335137;11228.831567526493;11252.693197894412;11361.37512436824;11508.53965841357;11621.360825154698;14688.926555367369;14959.551213463614;15017.174055426838;15043.022203556733;15085.396584136732;8542.316614670935;8808.5595720215;8842.115788421106;8946.642134314685;8973.641054357882;8747.650093996295;8757.693480728143;8773.254273386834;8936.106389361143;8976.05751396107;6197.628142311476;7044.682989265393;7343.77968660941;7351.558906465629;7356.227596102439;1528.4573976238275;1826.5890174710585;1850.7779066512105;1893.384649988759;1898.3355825460978;1035.1511760356586;1039.9792004160026;1057.724991502215;1064.2869277584036;1110.900018998294;22778.544429111324;23020;23031;23161.957711903004;23456;920.5857364186143;1065.573770491794;1106.7067227184803;1110.4780753046055;1110.74452875839;9498.95250523743;9925.894221341827;11373.488193031333;11833.763324733458;12014.279143251433;390118;451370;689348.5810082657;718580;720079;73351;112547;137778;138560;143604;992.5186284651938;1035.223582313265;1066.440118937564;1068.6740544134113;1085.46812062089;20660.760354378785;20945.63944069203;20969.580608388052;21108;21292.612216334728;48852;63139.05291420724;63441.73116537551;64147.3963150925;64806.70386592336;92771;94684;95179.04820951702;95211.52394237985;95229.5238523803;8420.284275836622;8514.574271286534;8546.102659220942;8935.123624039024;9041.50271735061;13202.735945280849;13313.600591982256;13610.523631672844;13663.658408539866;13984.160950343012;9177;11439;11534.538618455168;11768.76462470763;11840.585579504675;10812.67561973142;11489.540418383505;11688.493451964207;11701.76596468083;11855.466504007512;9714.368566043184;11553.826692599785;11626.19793931942;11908.523659053888;11948.223365481215;7336.266373362834;7734.679596121028;8423.663053477792;8916.687915922912;8965.327600430124;5806.44838740319;6650.46796256308;10893.673189804318;11463.337816016798;11880.108991825475 20:00:10 INFO - PROCESS | 1904 | |3;mootools.html;1312.2061153002433;1455.2287287737497;1480.9111453312796;1481.2815784344584;1488.553433969809;8008.599570021497;8423.326133909288;8424.789380265496;8432.957835210831;8442.155784421562;6862.245153033163;6986.615736134523;7367.742129025485;7598.582077985709;8279.006519217703;2272.579572779037;2308.53829234153;2315.6410756332793;2317.2468947592015;2318.9420264493356;2289.3360925331717;2294.3231746634783;2310.295359915225;2331.778481044298;2344.3201471573225;2047.7030830529563;2119.9258025969093;2238.8656680599133;2288.290629904735;2321.1411777642297;2287.313805858244;2289.7252329720372;2290.530441259546;2292;2296.1389478945393;2305.13557415969;2313.4794671199015;2326.406766274606;2328.5924963131383;2331.2773040357542;8276.875846862242;8417.915820841774;8420.115887831751;8422.536760478171;8432.15678432158;4980.477049909779;5133.230015497668;5144.356955380577;5148.665336753099;5154.639175257734;2996.2659148508537;3297.0768184908266;3498.6151523332414;3534.9469757953393;3535.098549869767;1173.3136115372517;1230.366361323919;1235.833162523057;1257.905657075723;1264.386772415378;10307.278490505667;10556.736081597945;10766.946165269124;10792.244542882001;10844.783104337868;4462.843800466968;4582.08358328329;4623.167829790603;4637.1421287062;4650.95349046512;9220.53897305132;9370.062993700712;9374.062593740708;9375.34372593912;9386.436813791195;5191.714455704972;5206.921896171561;5208.322918020633;5213.921791173136;5227.869303267373;4584.129015487047;4769.14155452022;4816.20532612122;4818.855609253918;4820.590249828733;3741.7193710471824;3792.6586607205486;3851.807409629507;3887.4168874669026;3926.469926559935;1231.341232440658;1263.204181365752;1264.7849865522883;1274.3946625352883;1284.7237843863613;902.5712786426526;916.9083091690777;929.7117893453051;934.243262957007;969.345691658128;5535.806246781343;5660.5471562274915;5883.058710606282;5899.616524925866;5901;925.8379783537854;946.0870260198941;989.9010098990043;990.2078337330107;1004.9648262310784;2875.884964601434;3560.5670939679744;3631.2374401375478;3821.102041020358;3930.0960779020415;9580.0898914603;9718.319717619699;9747.951260243653;9839.114479696862;9854.852177217348;9806;9816.214702823758;9830.4101753895;9844.50777461124;9854.113129818208;6505.60966342021;7213.963930180421;7613.9238607614325;7759.534427934342;7785.1436342002335;4860.246661767432;5362.490563396471;5673.574481913955;5714.771409143754;5895.616784908967;8923.41997770143;9023.593938272925;9077.364584479023;9104.04407537199;9130.726078217664;8987.820243595223;8992.370534062553;9171.816563668823;9297.488638124698;9306.488143152192;7088.929110708827;7134.821629459305;7135.464840136907;7254.45591580623;7256.600886951057;7763.68945242184;7852.882206767017;7855.3715702744785;7860.528368297921;7877.606119694107;6790.287019863041;6884.48366372514;7053.047838541731;7116.217216106121;7175.892361614476;6732.562383445061;6838;6938.410235129869;7114.359707626339;7263.34629883313;6250;6323.747050117944;6387.5209359297305;6393.1369265148605;6409.391107844747;4869.342638743724;4889.193283108248;5110.514501122388;5121.718305493234;5188.143956247177;4954.9752251238515;5009.849704508871;5082.669626474268;5196.766145523385;5292.20616907467 20:00:10 INFO - PROCESS | 1904 | |4;prototype.html;299.63594233006893;327.30284494027717;351.5219301749621;351.7309258417311;367.395634181771;4618.884527886805;4889.291052797346;4945.653804233701;4973.900521989563;5169.017886601543;4603.424571928509;4949.851504454863;5121.134921824263;5127.948720512793;5150.793968241275;4028.073543085085;4066.9389959150635;4067.613576710223;4069.267531844267;4088.9591104088877;3178.904632861018;3904.316744569703;3992.680585553149;4005.2990726622725;4212.410262563244;3840.289546433905;3846.7307288489815;3885.4560361549406;4047.231026105045;4079.8164082616354;3263.90659129192;3364.226227967581;4001.7198796084285;4038.374052021912;4074.7962601869935;3140.6388265349547;3497.775778477538;3517.419625761772;3524.8515969806963;3593.3352329819068;4138.675084536666;5029.220470827027;5051.444341122474;5058.215976523645;5104.872378190538;3889.397143442771;4060.330045542482;4670.98721324747;4682.742449165295;4689.320048592969;4922.237053256751;5143.6566231949155;5451;5528.944710552923;5551;3505.8071806050657;3776.583781082094;3785.6403641654274;3791.848326066954;3803.2393521295576;4962.6774259673;5042.999999999964;5324;5795.043817770063;5942.346341902387;3876.7480113792512;3880.941785873214;3890.5720370759195;3890.8910960376156;3898.434726964574;3882.9710126816417;3919.8236079376497;3921.8627348042683;3922.6464121526856;4139.689523285766;3599.4060979938017;4251.702380833312;4557.749323787223;4579.9084018319445;4752.239641657387;4681.882952926204;5516.806911758069;5535.225068490415;5538.113901775697;5544.251526044013;1268.429206856918;1357.4027427931678;1362.3801170467611;1363.8567950365268;1366.5012270521188;884.743903047227;915.1169121797365;967.7241986034087;970.4613939263635;987.9506024698736;4071;4939.851804445872;4946.925796113062;4947.727874966911;4992.8002879885125;4541.863744087683;5126.53861152498;5422.75597598109;5495.6153069285565;5553.750081246354;4119.464469618931;4133.834646614162;4299.527052024275;5256.342957130359;5296.788128474818;2596.143272719998;2662.3077999720213;2849.202223377458;2877.812942158753;2889.9422011560073;4915.124652078574;5554.72226388679;5626.381098079208;5664.716764161775;5690.886182276331;4742.478327383985;5093.643444958817;5348.732563371894;5355.357357117171;5367.954123124251;4486.932696009497;4773.665843390999;5039.840836607601;5563.7774489019985;5590.161475778666;4515.774211289488;4992.101421744121;5200.635955483232;5454.209139674805;5458.5087342139395;4499.392582001388;5270;5299.284596579412;5313.415524292402;5435.456454354533;5103.515166059367;5306;5354.571634269327;5668.61917994435;5669.177969194526;3079.615048118985;3116.797408168462;3344.1305260631925;3423.5549378580627;3629.274145171029;4452.866414007585;5080.882205914693;5218.895622087461;5441.319835020622;5498.80754173602;4676.789544470439;4741;5322.544391998078;5360.954613850262;5468.425815289496;4790.640701947298;5446.346438427256;5477.287952566141;5486.286782718221;5501.5065433449245;4937.851864444073;5137.974310128426;5181.896362072813;5184.988927159318;5388.784448622011;5007.3240112584335;5101.540861322499;5105.923411148761;5500.4224556420995;5567.415421380697;4540.568645978627;4651;5407.188921661782;5491.2312276282155;5508.925759476863 20:00:10 INFO - PROCESS | 1904 | |5;yui.html;717.6447658409088;754.3587950242292;772.5905270206789;817.1338381315805;854.1415877043569;15056.397744090236;15701.607459813496;15784.921075394606;15788;16293.51119466418;14417.495387661435;14831.25843707813;15106.093634381918;15121.773173402407;15138.924305378485;852.0542198160053;878.7495563764328;878.9868151977726;879.5074758135464;880.1990188928077;685.3591891581387;703.5145749432901;842.3934766967774;868.288003836854;871.8430682477151;919.8528235482324;924.2421214604027;924.6671198368582;925.2782829393084;928.5403725156057;908.2869947091567;918.2149262380635;919.4437365393941;920.0661328751323;921.8617207418873;526.5103453787975;541.5505130741475;663.0419044480727;691.6472598974559;692.0415224913531;14907.70184596302;15411.691766164726;15450.459233926871;15465.922670386575;15473.684736797386;14103.083299585494;14280.500182493666;14426.206558639271;14429.278536073154;14440.422383104664;11202.935721106482;12978.675533111653;13026.80459793104;13165.539206127836;13513.662158446019;4273.743575385487;4421.668374871898;4449.844255451076;4632.374629425019;4633.351330813655;125548.37225813903;126703.36648316792;127575.3621231888;129834.3508282462;129886;10588.99404556566;10838.07876330505;11259.099272058216;11402.714932126763;11629.76740465203;18890.52773680669;23518;23598.76401236;23602;23664.645030324216;6379.904301435482;7614.543127412373;7635.740102882962;7851.685932562634;7909.644066017043;4112.794360281974;4124.876253712393;4220.577942205755;4231.809568569422;4303.074838909587;3403.761736678409;3484.564429446319;3523.3481805865995;3528.2414280929725;3528.8588456461966;638.0684201066402;647.4108561209277;653.9967300163564;668.759246671198;671.9395254427125;588.0414923674383;625.6558892609138;653.2422390027546;661.778304268066;663.3731124087691;9804.264680149017;9847.310688251897;9899.455529945779;10177.389356638625;10180.440075795903;497.6019184652264;598.9520838332922;659.370301362198;663.4128796015465;668.4952860590223;4819.95180048202;4968.378952630921;5291.3121294231505;5389.89793980348;5595.720213989284;115406;116074;117964;118341;121284;82164;100771;104808.47595762125;105065.47467262615;107470.3879441809;89620.6556901647;90169.67115590365;91405;92135.07864921265;92667;7971.12317645047;8982.371234013557;10592.046715795615;10785.62250321235;11100.722481938015;51560.74219628878;56979.88321868481;57351.13973290488;57425.712871435375;57829;76745;76819.8477022834;77185;78100.04749881299;78619.60690196512;12871.613851584467;12962.287074211008;13210.141340812816;13377.264250465929;13691.246981416118;14543.92728036353;14920;14936.402543898123;15309.46416875404;15569.532914012598;13902.860971390157;13987.440502379792;14225.502107426191;14714.264286785832;14834.406623734929;13986.930065350016;14060.859391406364;14073.859261407255;14134.575962721136;14546.709065818835;13610.523631672844;13915.956303277093;14194.929025354808;14398.208098554262;14418.639534011734;9062.954685226532;9659.754017416475;11247.156463265124;11546.76906461883;11599.188056835941;10825.296355736851;11083.501242443948;11093.667189984313;11100.611478598534;11238.83141752858 20:00:10 INFO - PROCESS | 1904 | __end_tp_report 20:00:10 INFO - PROCESS | 1904 | __start_cc_report 20:00:10 INFO - PROCESS | 1904 | _x_x_mozilla_cycle_collect,1503 20:00:10 INFO - PROCESS | 1904 | __end_cc_report 20:00:10 INFO - PROCESS | 1904 | __startTimestamp1484193610850__endTimestamp 20:00:10 INFO - PROCESS | 1904 | 20:00:10 INFO - PROCESS | 1904 | ------- Summary: start ------- 20:00:10 INFO - PROCESS | 1904 | Number of tests: 6 20:00:10 INFO - PROCESS | 1904 | 20:00:10 INFO - PROCESS | 1904 | [#0] dojo.html Cycles:165 Average:5728.11 Median:6039.12 stddev:659.58 (10.9%) stddev-sans-first:632.73 20:00:10 INFO - PROCESS | 1904 | Values: 3267.4 3301.1 3327.1 3361.3 3379.3 5538.6 5554.8 5597.9 5631.6 5631.8 5648.9 5673.6 5697.2 5733.2 5747.9 5135.7 5144.9 5217.9 5227.2 5249.1 5157.4 5264.4 5286.9 5290.1 5314.5 5266.4 5275.2 5290.4 5300.8 5312.2 3915.0 5098.7 5130.7 5153.7 5213.7 4276.0 5201.6 5203.4 5238.2 5245.9 5622.0 5675.0 5676.0 5687.5 5705.7 6123.7 6143.3 6222.9 6246.7 6257.7 5419.8 6176.7 6208.5 6210.9 6255.2 5867.8 5877.3 5882.8 5894.4 5906.4 6223.9 6255.6 6276.7 6312.0 6348.1 6025.5 6075.9 6088.4 6131.9 6139.1 6197.4 6197.8 6199.4 6212.3 6225.8 6111.7 6145.4 6161.1 6192.5 6223.6 6223.4 6233.8 6235.8 6237.4 6241.5 4960.3 4983.1 4985.6 4986.5 5006.5 4283.1 4373.3 4414.8 4417.0 4476.1 5026.8 5812.5 5842.4 5852.9 5869.1 6168.4 6226.5 6227.0 6253.1 6253.7 5664.1 5706.1 5798.0 5800.9 5828.1 5410.2 5423.6 5434.7 5451.9 5518.5 6271.0 6330.5 6344.0 6353.1 6364.3 6209.4 6229.4 6229.9 6240.6 6255.3 6108.9 6213.0 6214.6 6216.4 6221.8 6067.1 6184.7 6198.7 6210.5 6219.3 5998.3 6128.2 6176.3 6202.2 6214.9 6043.5 6133.8 6156.2 6172.2 6187.4 6009.5 6047.5 6062.2 6081.2 6082.1 6044.8 6056.2 6061.2 6071.4 6110.4 6149.8 6158.0 6168.3 6168.5 6168.5 5832.8 5869.4 5873.5 6039.1 6055.7 20:00:10 INFO - PROCESS | 1904 | 20:00:10 INFO - PROCESS | 1904 | [#1] ext.html Cycles:180 Average:68848.27 Median:39419.60 stddev:146579.15 (371.8%) stddev-sans-first:146900.38 20:00:10 INFO - PROCESS | 1904 | Values: 447.6 504.5 504.6 517.0 532.2 29652.9 31679.0 41512.4 43269.6 43387.3 35742.8 44228.6 44267.0 44267.6 44450.8 9324.0 9535.9 9536.6 9545.4 9562.9 7148.6 8778.0 11270.2 11465.9 11532.0 11291.3 11336.0 11340.7 11346.5 11635.4 8583.3 8782.2 11417.6 11492.3 11521.3 10955.2 11285.9 11295.8 11475.3 11531.4 41617.4 42010.0 42017.0 42029.4 42068.4 4007.5 4019.7 4026.9 4069.3 4153.1 31377.7 31453.4 31516.8 31525.7 31777.7 3161.4 3221.6 3310.4 3311.3 3315.0 485128.0 485848.0 487925.0 488535.0 488957.4 62431.7 62731.0 63286.0 63482.4 63634.4 66246.3 66270.7 66289.0 66451.7 66574.0 15863.1 16091.0 16105.4 16126.6 16133.2 11227.4 11533.7 12517.2 12580.4 12586.2 12578.4 15613.9 15621.3 15628.2 15640.6 6107.8 7337.7 7392.9 7537.0 7596.7 870.0 881.3 899.0 914.9 916.8 29180.9 30167.5 30456.5 30777.0 31188.4 1040.5 1067.7 1073.2 1098.6 1100.7 14181.0 14269.7 15153.5 15275.8 15728.2 616911.0 620938.0 621497.0 621711.0 624160.0 59682.0 59805.0 59916.8 59969.7 60099.4 1396.7 1458.8 1466.3 1467.4 1469.9 25954.8 27106.1 29322.4 29583.3 29935.4 51071.7 51254.5 51395.7 51447.7 51519.7 529744.0 531998.0 532009.0 533046.0 533559.0 39747.4 40205.8 40450.8 40660.0 40856.6 46130.3 46759.5 47238.8 47411.8 47873.3 28932.7 38867.8 39091.8 40028.8 40242.8 36555.3 38373.0 38423.8 39019.0 39757.0 36667.8 37877.4 38025.4 38766.0 38832.2 28834.6 29018.9 29913.7 31541.0 31971.0 22180.0 24136.8 24189.3 24523.0 24894.8 20:00:10 INFO - PROCESS | 1904 | 20:00:10 INFO - PROCESS | 1904 | [#2] jquery.html Cycles:180 Average:36441.99 Median:25260.66 stddev:102596.49 (406.2%) stddev-sans-first:102848.55 20:00:10 INFO - PROCESS | 1904 | Values: 373.3 392.6 397.6 402.4 423.6 14662.9 16700.8 21202.0 21252.7 21803.7 21620.5 21885.1 22087.3 22448.7 22475.7 5755.5 5795.9 5921.6 5986.0 5992.4 4169.6 5859.6 5964.3 5976.0 5977.9 4344.2 4353.5 6570.5 6633.6 6636.9 6401.6 6522.8 6626.1 6635.7 6646.3 5704.6 5795.1 5805.2 5808.3 5809.2 27065.3 27146.0 27293.6 27417.7 27423.5 2776.2 2800.8 2810.2 2810.4 2816.2 15412.8 16064.7 16306.7 16319.4 16360.0 1790.2 1790.7 1804.5 1842.0 1874.6 132258.0 136780.0 137254.3 139524.0 140533.3 11228.8 11252.7 11361.4 11508.5 11621.4 14688.9 14959.6 15017.2 15043.0 15085.4 8542.3 8808.6 8842.1 8946.6 8973.6 8747.7 8757.7 8773.3 8936.1 8976.1 6197.6 7044.7 7343.8 7351.6 7356.2 1528.5 1826.6 1850.8 1893.4 1898.3 1035.2 1040.0 1057.7 1064.3 1110.9 22778.5 23020.0 23031.0 23162.0 23456.0 920.6 1065.6 1106.7 1110.5 1110.7 9499.0 9925.9 11373.5 11833.8 12014.3 390118.0 451370.0 689348.6 718580.0 720079.0 73351.0 112547.0 137778.0 138560.0 143604.0 992.5 1035.2 1066.4 1068.7 1085.5 20660.8 20945.6 20969.6 21108.0 21292.6 48852.0 63139.1 63441.7 64147.4 64806.7 92771.0 94684.0 95179.0 95211.5 95229.5 8420.3 8514.6 8546.1 8935.1 9041.5 13202.7 13313.6 13610.5 13663.7 13984.2 9177.0 11439.0 11534.5 11768.8 11840.6 10812.7 11489.5 11688.5 11701.8 11855.5 9714.4 11553.8 11626.2 11908.5 11948.2 7336.3 7734.7 8423.7 8916.7 8965.3 5806.4 6650.5 10893.7 11463.3 11880.1 20:00:10 INFO - PROCESS | 1904 | 20:00:10 INFO - PROCESS | 1904 | [#3] mootools.html Cycles:180 Average:5383.73 Median:5260.04 stddev:2897.27 (55.1%) stddev-sans-first:2889.24 20:00:10 INFO - PROCESS | 1904 | Values: 1312.2 1455.2 1480.9 1481.3 1488.6 8008.6 8423.3 8424.8 8433.0 8442.2 6862.2 6986.6 7367.7 7598.6 8279.0 2272.6 2308.5 2315.6 2317.2 2318.9 2289.3 2294.3 2310.3 2331.8 2344.3 2047.7 2119.9 2238.9 2288.3 2321.1 2287.3 2289.7 2290.5 2292.0 2296.1 2305.1 2313.5 2326.4 2328.6 2331.3 8276.9 8417.9 8420.1 8422.5 8432.2 4980.5 5133.2 5144.4 5148.7 5154.6 2996.3 3297.1 3498.6 3534.9 3535.1 1173.3 1230.4 1235.8 1257.9 1264.4 10307.3 10556.7 10766.9 10792.2 10844.8 4462.8 4582.1 4623.2 4637.1 4651.0 9220.5 9370.1 9374.1 9375.3 9386.4 5191.7 5206.9 5208.3 5213.9 5227.9 4584.1 4769.1 4816.2 4818.9 4820.6 3741.7 3792.7 3851.8 3887.4 3926.5 1231.3 1263.2 1264.8 1274.4 1284.7 902.6 916.9 929.7 934.2 969.3 5535.8 5660.5 5883.1 5899.6 5901.0 925.8 946.1 989.9 990.2 1005.0 2875.9 3560.6 3631.2 3821.1 3930.1 9580.1 9718.3 9748.0 9839.1 9854.9 9806.0 9816.2 9830.4 9844.5 9854.1 6505.6 7214.0 7613.9 7759.5 7785.1 4860.2 5362.5 5673.6 5714.8 5895.6 8923.4 9023.6 9077.4 9104.0 9130.7 8987.8 8992.4 9171.8 9297.5 9306.5 7088.9 7134.8 7135.5 7254.5 7256.6 7763.7 7852.9 7855.4 7860.5 7877.6 6790.3 6884.5 7053.0 7116.2 7175.9 6732.6 6838.0 6938.4 7114.4 7263.3 6250.0 6323.7 6387.5 6393.1 6409.4 4869.3 4889.2 5110.5 5121.7 5188.1 4955.0 5009.8 5082.7 5196.8 5292.2 20:00:10 INFO - PROCESS | 1904 | 20:00:10 INFO - PROCESS | 1904 | [#4] prototype.html Cycles:180 Average:4339.74 Median:4902.21 stddev:1294.32 (26.4%) stddev-sans-first:1261.93 20:00:10 INFO - PROCESS | 1904 | Values: 299.6 327.3 351.5 351.7 367.4 4618.9 4889.3 4945.7 4973.9 5169.0 4603.4 4949.9 5121.1 5127.9 5150.8 4028.1 4066.9 4067.6 4069.3 4089.0 3178.9 3904.3 3992.7 4005.3 4212.4 3840.3 3846.7 3885.5 4047.2 4079.8 3263.9 3364.2 4001.7 4038.4 4074.8 3140.6 3497.8 3517.4 3524.9 3593.3 4138.7 5029.2 5051.4 5058.2 5104.9 3889.4 4060.3 4671.0 4682.7 4689.3 4922.2 5143.7 5451.0 5528.9 5551.0 3505.8 3776.6 3785.6 3791.8 3803.2 4962.7 5043.0 5324.0 5795.0 5942.3 3876.7 3880.9 3890.6 3890.9 3898.4 3883.0 3919.8 3921.9 3922.6 4139.7 3599.4 4251.7 4557.7 4579.9 4752.2 4681.9 5516.8 5535.2 5538.1 5544.3 1268.4 1357.4 1362.4 1363.9 1366.5 884.7 915.1 967.7 970.5 988.0 4071.0 4939.9 4946.9 4947.7 4992.8 4541.9 5126.5 5422.8 5495.6 5553.8 4119.5 4133.8 4299.5 5256.3 5296.8 2596.1 2662.3 2849.2 2877.8 2889.9 4915.1 5554.7 5626.4 5664.7 5690.9 4742.5 5093.6 5348.7 5355.4 5368.0 4486.9 4773.7 5039.8 5563.8 5590.2 4515.8 4992.1 5200.6 5454.2 5458.5 4499.4 5270.0 5299.3 5313.4 5435.5 5103.5 5306.0 5354.6 5668.6 5669.2 3079.6 3116.8 3344.1 3423.6 3629.3 4452.9 5080.9 5218.9 5441.3 5498.8 4676.8 4741.0 5322.5 5361.0 5468.4 4790.6 5446.3 5477.3 5486.3 5501.5 4937.9 5138.0 5181.9 5185.0 5388.8 5007.3 5101.5 5105.9 5500.4 5567.4 4540.6 4651.0 5407.2 5491.2 5508.9 20:00:10 INFO - PROCESS | 1904 | 20:00:10 INFO - PROCESS | 1904 | [#5] yui.html Cycles:180 Average:22826.03 Median:3528.55 stddev:34404.76 (975.0%) stddev-sans-first:34461.23 20:00:10 INFO - PROCESS | 1904 | Values: 717.6 754.4 772.6 817.1 854.1 15056.4 15701.6 15784.9 15788.0 16293.5 14417.5 14831.3 15106.1 15121.8 15138.9 852.1 878.7 879.0 879.5 880.2 685.4 703.5 842.4 868.3 871.8 919.9 924.2 924.7 925.3 928.5 908.3 918.2 919.4 920.1 921.9 526.5 541.6 663.0 691.6 692.0 14907.7 15411.7 15450.5 15465.9 15473.7 14103.1 14280.5 14426.2 14429.3 14440.4 11202.9 12978.7 13026.8 13165.5 13513.7 4273.7 4421.7 4449.8 4632.4 4633.4 125548.4 126703.4 127575.4 129834.4 129886.0 10589.0 10838.1 11259.1 11402.7 11629.8 18890.5 23518.0 23598.8 23602.0 23664.6 6379.9 7614.5 7635.7 7851.7 7909.6 4112.8 4124.9 4220.6 4231.8 4303.1 3403.8 3484.6 3523.3 3528.2 3528.9 638.1 647.4 654.0 668.8 671.9 588.0 625.7 653.2 661.8 663.4 9804.3 9847.3 9899.5 10177.4 10180.4 497.6 599.0 659.4 663.4 668.5 4820.0 4968.4 5291.3 5389.9 5595.7 115406.0 116074.0 117964.0 118341.0 121284.0 82164.0 100771.0 104808.5 105065.5 107470.4 89620.7 90169.7 91405.0 92135.1 92667.0 7971.1 8982.4 10592.0 10785.6 11100.7 51560.7 56979.9 57351.1 57425.7 57829.0 76745.0 76819.8 77185.0 78100.0 78619.6 12871.6 12962.3 13210.1 13377.3 13691.2 14543.9 14920.0 14936.4 15309.5 15569.5 13902.9 13987.4 14225.5 14714.3 14834.4 13986.9 14060.9 14073.9 14134.6 14546.7 13610.5 13916.0 14194.9 14398.2 14418.6 9063.0 9659.8 11247.2 11546.8 11599.2 10825.3 11083.5 11093.7 11100.6 11238.8 20:00:10 INFO - PROCESS | 1904 | -------- Summary: end -------- 20:00:10 INFO - PROCESS | 1904 | 20:00:11 INFO - TEST-INFO | 1904: exit 0 20:00:11 INFO - TEST-OK | dromaeo_css | took 1119715ms 20:00:11 INFO - TEST-START | kraken 20:00:11 INFO - operating with platform_type : mac_ 20:00:11 INFO - Initialising browser for kraken test... 20:00:11 INFO - TEST-INFO | started process 1909 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpsbzgys/profile http://localhost:49374/getInfo.html) 20:00:13 INFO - PROCESS | 1909 | __metrics Screen width/height:1600/1200 20:00:13 INFO - PROCESS | 1909 | colorDepth:24 20:00:13 INFO - PROCESS | 1909 | Browser inner width/height: 1024/689 20:00:13 INFO - PROCESS | 1909 | __metrics 20:00:13 INFO - PROCESS | 1909 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:00:13 INFO - PROCESS | 1909 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:00:14 INFO - TEST-INFO | 1909: exit 0 20:00:14 INFO - Browser initialized. 20:00:14 INFO - Running cycle 1/1 for kraken test... 20:00:14 INFO - TEST-INFO | started process 1910 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpsbzgys/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:00:26 INFO - PROCESS | 1910 | RSS: Main: 234266624 20:00:26 INFO - PROCESS | 1910 | 20:00:29 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49374/tests/kraken/driver.html?testName=audio-beat-detection) 20:00:30 INFO - PROCESS | 1910 | RSS: Main: 287211520 20:00:30 INFO - PROCESS | 1910 | 20:00:33 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49374/tests/kraken/driver.html?testName=audio-dft) 20:00:33 INFO - PROCESS | 1910 | RSS: Main: 288559104 20:00:33 INFO - PROCESS | 1910 | 20:00:37 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49374/tests/kraken/driver.html?testName=audio-fft) 20:00:37 INFO - PROCESS | 1910 | RSS: Main: 381239296 20:00:37 INFO - PROCESS | 1910 | 20:00:39 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49374/tests/kraken/driver.html?testName=audio-oscillator) 20:00:40 INFO - PROCESS | 1910 | RSS: Main: 282046464 20:00:40 INFO - PROCESS | 1910 | 20:00:42 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49374/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:00:43 INFO - PROCESS | 1910 | RSS: Main: 286941184 20:00:43 INFO - PROCESS | 1910 | 20:00:45 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49374/tests/kraken/driver.html?testName=imaging-darkroom) 20:00:46 INFO - PROCESS | 1910 | RSS: Main: 328241152 20:00:46 INFO - PROCESS | 1910 | 20:00:49 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49374/tests/kraken/driver.html?testName=imaging-desaturate) 20:00:50 INFO - PROCESS | 1910 | RSS: Main: 332075008 20:00:50 INFO - PROCESS | 1910 | 20:00:53 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49374/tests/kraken/driver.html?testName=json-parse-financial) 20:00:53 INFO - PROCESS | 1910 | RSS: Main: 329715712 20:00:53 INFO - PROCESS | 1910 | 20:00:55 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49374/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:00:55 INFO - PROCESS | 1910 | RSS: Main: 304779264 20:00:55 INFO - PROCESS | 1910 | 20:00:57 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49374/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:00:58 INFO - PROCESS | 1910 | RSS: Main: 305586176 20:00:58 INFO - PROCESS | 1910 | 20:01:00 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49374/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:01:01 INFO - PROCESS | 1910 | RSS: Main: 308146176 20:01:01 INFO - PROCESS | 1910 | 20:01:04 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49374/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:01:05 INFO - PROCESS | 1910 | RSS: Main: 321466368 20:01:05 INFO - PROCESS | 1910 | 20:01:08 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49374/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:01:08 INFO - PROCESS | 1910 | RSS: Main: 320008192 20:01:08 INFO - PROCESS | 1910 | 20:01:10 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49374/tests/kraken/driver.html?testName=ai-astar) 20:01:11 INFO - PROCESS | 1910 | RSS: Main: 363859968 20:01:11 INFO - PROCESS | 1910 | 20:01:11 INFO - PROCESS | 1910 | __start_tp_report 20:01:11 INFO - PROCESS | 1910 | _x_x_mozilla_page_load 20:01:11 INFO - PROCESS | 1910 | _x_x_mozilla_page_load_details 20:01:11 INFO - PROCESS | 1910 | |i|pagename|runs| 20:01:11 INFO - PROCESS | 1910 | |0;ai-astar;114;114;115;154;114;117;164;168;115;114 20:01:11 INFO - PROCESS | 1910 | |1;audio-beat-detection;168;139;138;143;126;122;96;124;161;140 20:01:11 INFO - PROCESS | 1910 | |2;audio-dft;185;184;184;186;183;184;179;183;184;186 20:01:11 INFO - PROCESS | 1910 | |3;audio-fft;81;59;58;89;59;58;59;58;74;57 20:01:11 INFO - PROCESS | 1910 | |4;audio-oscillator;90;69;85;68;69;68;84;70;54;80 20:01:11 INFO - PROCESS | 1910 | |5;imaging-gaussian-blur;88;118;87;84;87;85;128;85;86;124 20:01:11 INFO - PROCESS | 1910 | |6;imaging-darkroom;97;96;98;96;95;100;95;97;96;96 20:01:11 INFO - PROCESS | 1910 | |7;imaging-desaturate;91;87;68;130;136;101;88;87;87;86 20:01:11 INFO - PROCESS | 1910 | |8;json-parse-financial;56;56;55;54;55;55;55;55;55;55 20:01:11 INFO - PROCESS | 1910 | |9;json-stringify-tinderbox;65;73;79;76;73;70;70;70;72;72 20:01:11 INFO - PROCESS | 1910 | |10;stanford-crypto-aes;88;93;109;109;104;90;90;87;88;91 20:01:11 INFO - PROCESS | 1910 | |11;stanford-crypto-ccm;143;140;144;148;155;176;154;151;232;153 20:01:11 INFO - PROCESS | 1910 | |12;stanford-crypto-pbkdf2;172;172;236;212;172;169;171;175;171;172 20:01:11 INFO - PROCESS | 1910 | |13;stanford-crypto-sha256-iterative;68;68;70;68;72;83;90;90;86;73 20:01:11 INFO - PROCESS | 1910 | __end_tp_report 20:01:11 INFO - PROCESS | 1910 | __start_cc_report 20:01:11 INFO - PROCESS | 1910 | _x_x_mozilla_cycle_collect,2002 20:01:11 INFO - PROCESS | 1910 | __end_cc_report 20:01:11 INFO - PROCESS | 1910 | __startTimestamp1484193671017__endTimestamp 20:01:11 INFO - PROCESS | 1910 | 20:01:11 INFO - PROCESS | 1910 | ------- Summary: start ------- 20:01:11 INFO - PROCESS | 1910 | Number of tests: 14 20:01:11 INFO - PROCESS | 1910 | 20:01:11 INFO - PROCESS | 1910 | [#0] ai-astar Cycles:10 Average:128.90 Median:116.00 stddev:23.11 (19.9%) stddev-sans-first:23.88 20:01:11 INFO - PROCESS | 1910 | Values: 114.0 114.0 115.0 154.0 114.0 117.0 164.0 168.0 115.0 114.0 20:01:11 INFO - PROCESS | 1910 | 20:01:11 INFO - PROCESS | 1910 | [#1] audio-beat-detection Cycles:10 Average:135.70 Median:141.50 stddev:20.46 (14.5%) stddev-sans-first:18.05 20:01:11 INFO - PROCESS | 1910 | Values: 168.0 139.0 138.0 143.0 126.0 122.0 96.0 124.0 161.0 140.0 20:01:11 INFO - PROCESS | 1910 | 20:01:11 INFO - PROCESS | 1910 | [#2] audio-dft Cycles:10 Average:183.80 Median:184.00 stddev:1.99 (1.1%) stddev-sans-first:2.06 20:01:11 INFO - PROCESS | 1910 | Values: 185.0 184.0 184.0 186.0 183.0 184.0 179.0 183.0 184.0 186.0 20:01:11 INFO - PROCESS | 1910 | 20:01:11 INFO - PROCESS | 1910 | [#3] audio-fft Cycles:10 Average:65.20 Median:59.00 stddev:11.70 (19.8%) stddev-sans-first:10.92 20:01:11 INFO - PROCESS | 1910 | Values: 81.0 59.0 58.0 89.0 59.0 58.0 59.0 58.0 74.0 57.0 20:01:11 INFO - PROCESS | 1910 | 20:01:11 INFO - PROCESS | 1910 | [#4] audio-oscillator Cycles:10 Average:73.70 Median:75.00 stddev:10.80 (14.4%) stddev-sans-first:9.71 20:01:11 INFO - PROCESS | 1910 | Values: 90.0 69.0 85.0 68.0 69.0 68.0 84.0 70.0 54.0 80.0 20:01:11 INFO - PROCESS | 1910 | 20:01:11 INFO - PROCESS | 1910 | [#5] imaging-gaussian-blur Cycles:10 Average:97.20 Median:85.50 stddev:18.23 (21.3%) stddev-sans-first:19.02 20:01:11 INFO - PROCESS | 1910 | Values: 88.0 118.0 87.0 84.0 87.0 85.0 128.0 85.0 86.0 124.0 20:01:11 INFO - PROCESS | 1910 | 20:01:11 INFO - PROCESS | 1910 | [#6] imaging-darkroom Cycles:10 Average:96.60 Median:96.00 stddev:1.51 (1.6%) stddev-sans-first:1.59 20:01:11 INFO - PROCESS | 1910 | Values: 97.0 96.0 98.0 96.0 95.0 100.0 95.0 97.0 96.0 96.0 20:01:11 INFO - PROCESS | 1910 | 20:01:11 INFO - PROCESS | 1910 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:87.00 stddev:21.07 (24.2%) stddev-sans-first:22.27 20:01:11 INFO - PROCESS | 1910 | Values: 91.0 87.0 68.0 130.0 136.0 101.0 88.0 87.0 87.0 86.0 20:01:11 INFO - PROCESS | 1910 | 20:01:11 INFO - PROCESS | 1910 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.00 stddev:0.57 (1.0%) stddev-sans-first:0.50 20:01:11 INFO - PROCESS | 1910 | Values: 56.0 56.0 55.0 54.0 55.0 55.0 55.0 55.0 55.0 55.0 20:01:11 INFO - PROCESS | 1910 | 20:01:11 INFO - PROCESS | 1910 | [#9] json-stringify-tinderbox Cycles:10 Average:72.00 Median:72.50 stddev:3.77 (5.2%) stddev-sans-first:3.03 20:01:11 INFO - PROCESS | 1910 | Values: 65.0 73.0 79.0 76.0 73.0 70.0 70.0 70.0 72.0 72.0 20:01:11 INFO - PROCESS | 1910 | 20:01:11 INFO - PROCESS | 1910 | [#10] stanford-crypto-aes Cycles:10 Average:94.90 Median:89.00 stddev:8.85 (9.9%) stddev-sans-first:9.03 20:01:11 INFO - PROCESS | 1910 | Values: 88.0 93.0 109.0 109.0 104.0 90.0 90.0 87.0 88.0 91.0 20:01:11 INFO - PROCESS | 1910 | 20:01:11 INFO - PROCESS | 1910 | [#11] stanford-crypto-ccm Cycles:10 Average:159.60 Median:153.50 stddev:27.32 (17.8%) stddev-sans-first:28.31 20:01:11 INFO - PROCESS | 1910 | Values: 143.0 140.0 144.0 148.0 155.0 176.0 154.0 151.0 232.0 153.0 20:01:11 INFO - PROCESS | 1910 | 20:01:11 INFO - PROCESS | 1910 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.20 Median:172.00 stddev:22.79 (13.3%) stddev-sans-first:23.87 20:01:11 INFO - PROCESS | 1910 | Values: 172.0 172.0 236.0 212.0 172.0 169.0 171.0 175.0 171.0 172.0 20:01:11 INFO - PROCESS | 1910 | 20:01:11 INFO - PROCESS | 1910 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.80 Median:78.00 stddev:9.35 (12.0%) stddev-sans-first:9.36 20:01:11 INFO - PROCESS | 1910 | Values: 68.0 68.0 70.0 68.0 72.0 83.0 90.0 90.0 86.0 73.0 20:01:11 INFO - PROCESS | 1910 | -------- Summary: end -------- 20:01:11 INFO - PROCESS | 1910 | 20:01:12 INFO - TEST-INFO | 1910: exit 0 20:01:12 INFO - TEST-OK | kraken | took 60591ms 20:01:12 INFO - SUITE-END | took 1180s 20:01:12 INFO - Completed test suite (00:19:40) 20:01:12 INFO - javascript benchmark 20:01:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3267.3955318266117, 3301.075698804335, 3327.1349449143217, 3361.2605226850083, 3379.273456206915, 5538.6399884007515, 5554.833354999351, 5597.916031259534, 5631.6057875948645, 5631.831045068644, 5648.943510564893, 5673.631213971089, 5697.173909783079, 5733.168690539869, 5747.913781293284, 5135.666181698178, 5144.8713782155555, 5217.921731174017, 5227.2159176123505, 5249.081410753103, 5157.355330583677, 5264.447233040533, 5286.867828304304, 5290.1006828839, 5314.468553144693, 5266.4470230626, 5275.182346736262, 5290.418054014055, 5300.840974770763, 5312.17661262503, 3914.9804250978846, 5098.719570423626, 5130.666506677054, 5153.6907785532985, 5213.713245771481, 4275.978620106911, 5201.55786758126, 5203.427622961472, 5238.188080847474, 5245.947540524622, 5622.044252477089, 5674.971625141848, 5676.0066988276885, 5687.459691329317, 5705.657660540381, 6123.663198524079, 6143.327652471189, 6222.875542489125, 6246.687665616746, 6257.74969001244, 5419.783208671648, 6176.660283684396, 6208.472279856218, 6210.937890621081, 6255.218097737783, 5867.765289388462, 5877.324107727666, 5882.794102206488, 5894.381089985575, 5906.379830117861, 6223.875522489525, 6255.624662520263, 6276.717547710364, 6311.96844015777, 6348.111264422984, 6025.517958563304, 6075.908861367083, 6088.360722124202, 6131.877362452726, 6139.10982907476, 6197.380261973766, 6197.845053873689, 6199.380061993765, 6212.285587157445, 6225.782097626561, 6111.682900513672, 6145.4161854623735, 6161.106639537242, 6192.535559833031, 6223.626582405071, 6223.37766223374, 6233.844153896189, 6235.844103897348, 6237.407446292595, 6241.500679945593, 4960.255961605716, 4983.07813054586, 4985.5762260208285, 4986.4514903360605, 5006.549410553068, 4283.121959998255, 4373.278409062469, 4414.757188354672, 4417.028253784162, 4476.149531588988, 5026.824061157842, 5812.534997200214, 5842.357340692605, 5852.94147058524, 5869.090291004901, 6168.383161683885, 6226.501879849692, 6227.0, 6253.093301471261, 6253.6560489172625, 5664.122061080539, 5706.115552089433, 5797.971010145006, 5800.88398232033, 5828.0966450200285, 5410.242566040757, 5423.647462914898, 5434.70109143993, 5451.863703407367, 5518.503334699896, 6270.968645156928, 6330.461910737639, 6344.0, 6353.142325786052, 6364.331745166691, 6209.410106039919, 6229.408206220402, 6229.875402491834, 6240.563160578898, 6255.343188965093, 6108.85814249354, 6212.97485914819, 6214.564980451325, 6216.409441103088, 6221.844453888689, 6067.059605761114, 6184.690765461799, 6198.659073750807, 6210.472109870711, 6219.284782249918, 5998.25021872266, 6128.19758601264, 6176.28972668131, 6202.162708034538, 6214.937850621436, 6043.518905264784, 6133.785317513865, 6156.168917196122, 6172.197614310111, 6187.443130118311, 6009.519238461, 6047.546434017554, 6062.151298818258, 6081.179040829608, 6082.118092876596, 6044.75820967174, 6056.212692349966, 6061.242344706911, 6071.362506936708, 6110.358412366638, 6149.7847575334645, 6158.04550294705, 6168.290646575701, 6168.537359697951, 6168.537359698131, 5832.766689332549, 5869.383714709894, 5873.471387575139, 6039.124326972652, 6055.666938318434], "value": 5684.988632266795, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [447.5636254651715, 504.45266885429305, 504.5509496548073, 517.0, 532.1565318969433, 29652.85173574132, 31679.0, 41512.37731434027, 43269.56730432695, 43387.3491897621, 35742.82128589354, 44228.557714422845, 44267.0, 44267.55732442674, 44450.77774611131, 9324.0, 9535.856962145574, 9536.570854311572, 9545.427274363561, 9562.904370956307, 7148.642567871611, 8777.95611021944, 11270.211085224038, 11465.885341146564, 11531.962123408934, 11291.266067705614, 11336.0, 11340.716482087973, 11346.48940797666, 11635.418229088511, 8583.313334933191, 8782.209601135864, 11417.600383986563, 11492.31046137226, 11521.308721476697, 10955.233133680646, 11285.943570282096, 11295.830562541569, 11475.311481311148, 11531.365774882379, 41617.37573936393, 42010.0, 42017.0, 42029.36955945663, 42068.3689744651, 4007.5190977082643, 4019.678425725935, 4026.859059932888, 4069.308217603015, 4153.1486045360625, 31377.744890204365, 31453.37093258122, 31516.842415787774, 31525.74402455662, 31777.72889084457, 3161.4309424303615, 3221.5811944447305, 3310.4372256716415, 3311.3211791582908, 3315.022068489777, 485128.0, 485848.0, 487925.0, 488534.99999999645, 488957.4417023315, 62431.68784156141, 62731.0, 63286.0, 63482.365176347645, 63634.36365636377, 66246.33753662498, 66270.69834413235, 66289.0, 66451.66774166099, 66574.0, 15863.12752798584, 16091.0, 16105.355785768672, 16126.596835079217, 16133.193340332937, 11227.382493962747, 11533.711657208636, 12517.248965062125, 12580.370981450891, 12586.18189817659, 12578.371081445892, 15613.921930390276, 15621.297041633154, 15628.2185890705, 15640.608984775472, 6107.755689772448, 7337.669804858794, 7392.889106663404, 7537.0, 7596.734114306083, 869.9956500217459, 881.2509367038094, 898.9775255618531, 914.9313801464783, 916.8349697054595, 29180.85409572981, 30167.547486787716, 30456.54315185274, 30777.0, 31188.37623247568, 1040.4693606260862, 1067.7330667333167, 1073.1843798713035, 1098.5880294889416, 1100.691806294223, 14181.0, 14269.714605708035, 15153.514691620769, 15275.770863437057, 15728.213589320718, 616911.0, 620938.0, 621497.0, 621711.0, 624160.0, 59682.0, 59805.0, 59916.80166396735, 59969.700151499834, 60099.39900600938, 1396.6857457072078, 1458.8395276519575, 1466.2741942738412, 1467.3763650448304, 1469.9338529766187, 25954.83203255896, 27106.051288204817, 29322.413551729274, 29583.26041848971, 29935.401291974475, 51071.74464127656, 51254.487455124974, 51395.74302128465, 51447.742761285954, 51519.74240128775, 529744.0, 531998.0, 532009.0, 533046.0, 533559.0, 39747.40378894261, 40205.79897100496, 40450.797746011085, 40659.98350041272, 40856.59143408647, 46130.308045378675, 46759.53240467688, 47238.76380618075, 47411.76294118507, 47873.28190077082, 28932.710672893, 38867.80566097151, 39091.804540977115, 40028.799856000536, 40242.798786005886, 36555.26889462249, 38373.0, 38423.80788096042, 39019.046013820414, 39757.01822363277, 36667.81666091759, 37877.431838521894, 38025.429618555194, 38766.03084922899, 38832.22335553329, 28834.55827208673, 29018.92582097723, 29913.700862991092, 31541.0, 31971.040868773973, 22180.0, 24136.75863241345, 24189.274321770376, 24523.019079237343, 24894.751052489242], "value": 20247.953955031677, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.2795704290718, 392.5564112552813, 397.62424508839143, 402.4084595644402, 423.61027854373975, 14662.92831799122, 16700.83094183406, 21202.0, 21252.681209781826, 21803.67294490584, 21620.459488512795, 21885.12459501618, 22087.33737987863, 22448.66327005096, 22475.66286505704, 5755.482006619403, 5795.855103622401, 5921.555883308769, 5986.042233242682, 5992.400759924017, 4169.562195969425, 5859.560532960024, 5964.314103878066, 5975.970120149394, 5977.910331345011, 4344.152890186399, 4353.477582690081, 6570.474362051024, 6633.568818026837, 6636.93363066368, 6401.551891367606, 6522.77170299042, 6626.105475760759, 6635.734570617169, 6646.26891041985, 5704.600677952545, 5795.1017592273265, 5805.187273781674, 5808.3030036395485, 5809.157672137559, 27065.323366915985, 27146.0, 27293.590596141075, 27417.725822741715, 27423.45153096947, 2776.1532732516575, 2800.8179468334697, 2810.2131403207136, 2810.3536186676974, 2816.197383745643, 15412.845871541253, 16064.678706425922, 16306.673866522604, 16319.428819991363, 16360.0, 1790.203359505021, 1790.7313902914536, 1804.46768203379, 1842.0, 1874.5969616532375, 132258.0, 136780.0, 137254.31372843072, 139524.0, 140533.2973335137, 11228.831567526493, 11252.693197894412, 11361.37512436824, 11508.53965841357, 11621.360825154698, 14688.926555367369, 14959.551213463614, 15017.174055426838, 15043.022203556733, 15085.396584136732, 8542.316614670935, 8808.5595720215, 8842.115788421106, 8946.642134314685, 8973.641054357882, 8747.650093996295, 8757.693480728143, 8773.254273386834, 8936.106389361143, 8976.05751396107, 6197.628142311476, 7044.682989265393, 7343.77968660941, 7351.558906465629, 7356.227596102439, 1528.4573976238275, 1826.5890174710585, 1850.7779066512105, 1893.384649988759, 1898.3355825460978, 1035.1511760356586, 1039.9792004160026, 1057.724991502215, 1064.2869277584036, 1110.900018998294, 22778.544429111324, 23020.0, 23031.0, 23161.957711903004, 23456.0, 920.5857364186143, 1065.573770491794, 1106.7067227184803, 1110.4780753046055, 1110.74452875839, 9498.95250523743, 9925.894221341827, 11373.488193031333, 11833.763324733458, 12014.279143251433, 390118.0, 451370.0, 689348.5810082657, 718580.0, 720079.0, 73351.0, 112547.0, 137778.0, 138560.0, 143604.0, 992.5186284651938, 1035.223582313265, 1066.440118937564, 1068.6740544134113, 1085.46812062089, 20660.760354378785, 20945.63944069203, 20969.580608388052, 21108.0, 21292.612216334728, 48852.0, 63139.05291420724, 63441.73116537551, 64147.3963150925, 64806.70386592336, 92771.0, 94684.0, 95179.04820951702, 95211.52394237985, 95229.5238523803, 8420.284275836622, 8514.574271286534, 8546.102659220942, 8935.123624039024, 9041.50271735061, 13202.735945280849, 13313.600591982256, 13610.523631672844, 13663.658408539866, 13984.160950343012, 9177.0, 11439.0, 11534.538618455168, 11768.76462470763, 11840.585579504675, 10812.67561973142, 11489.540418383505, 11688.493451964207, 11701.76596468083, 11855.466504007512, 9714.368566043184, 11553.826692599785, 11626.19793931942, 11908.523659053888, 11948.223365481215, 7336.266373362834, 7734.679596121028, 8423.663053477792, 8916.687915922912, 8965.327600430124, 5806.44838740319, 6650.46796256308, 10893.673189804318, 11463.337816016798, 11880.108991825475], "value": 10216.42025300772, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1312.2061153002433, 1455.2287287737497, 1480.9111453312796, 1481.2815784344584, 1488.553433969809, 8008.599570021497, 8423.326133909288, 8424.789380265496, 8432.957835210831, 8442.155784421562, 6862.245153033163, 6986.615736134523, 7367.742129025485, 7598.582077985709, 8279.006519217703, 2272.579572779037, 2308.53829234153, 2315.6410756332793, 2317.2468947592015, 2318.9420264493356, 2289.3360925331717, 2294.3231746634783, 2310.295359915225, 2331.778481044298, 2344.3201471573225, 2047.7030830529563, 2119.9258025969093, 2238.8656680599133, 2288.290629904735, 2321.1411777642297, 2287.313805858244, 2289.7252329720372, 2290.530441259546, 2292.0, 2296.1389478945393, 2305.13557415969, 2313.4794671199015, 2326.406766274606, 2328.5924963131383, 2331.2773040357542, 8276.875846862242, 8417.915820841774, 8420.115887831751, 8422.536760478171, 8432.15678432158, 4980.477049909779, 5133.230015497668, 5144.356955380577, 5148.665336753099, 5154.639175257734, 2996.2659148508537, 3297.0768184908266, 3498.6151523332414, 3534.9469757953393, 3535.098549869767, 1173.3136115372517, 1230.366361323919, 1235.833162523057, 1257.905657075723, 1264.386772415378, 10307.278490505667, 10556.736081597945, 10766.946165269124, 10792.244542882001, 10844.783104337868, 4462.843800466968, 4582.08358328329, 4623.167829790603, 4637.1421287062, 4650.95349046512, 9220.53897305132, 9370.062993700712, 9374.062593740708, 9375.34372593912, 9386.436813791195, 5191.714455704972, 5206.921896171561, 5208.322918020633, 5213.921791173136, 5227.869303267373, 4584.129015487047, 4769.14155452022, 4816.20532612122, 4818.855609253918, 4820.590249828733, 3741.7193710471824, 3792.6586607205486, 3851.807409629507, 3887.4168874669026, 3926.469926559935, 1231.341232440658, 1263.204181365752, 1264.7849865522883, 1274.3946625352883, 1284.7237843863613, 902.5712786426526, 916.9083091690777, 929.7117893453051, 934.243262957007, 969.345691658128, 5535.806246781343, 5660.5471562274915, 5883.058710606282, 5899.616524925866, 5901.0, 925.8379783537854, 946.0870260198941, 989.9010098990043, 990.2078337330107, 1004.9648262310784, 2875.884964601434, 3560.5670939679744, 3631.2374401375478, 3821.102041020358, 3930.0960779020415, 9580.0898914603, 9718.319717619699, 9747.951260243653, 9839.114479696862, 9854.852177217348, 9806.0, 9816.214702823758, 9830.4101753895, 9844.50777461124, 9854.113129818208, 6505.60966342021, 7213.963930180421, 7613.9238607614325, 7759.534427934342, 7785.1436342002335, 4860.246661767432, 5362.490563396471, 5673.574481913955, 5714.771409143754, 5895.616784908967, 8923.41997770143, 9023.593938272925, 9077.364584479023, 9104.04407537199, 9130.726078217664, 8987.820243595223, 8992.370534062553, 9171.816563668823, 9297.488638124698, 9306.488143152192, 7088.929110708827, 7134.821629459305, 7135.464840136907, 7254.45591580623, 7256.600886951057, 7763.68945242184, 7852.882206767017, 7855.3715702744785, 7860.528368297921, 7877.606119694107, 6790.287019863041, 6884.48366372514, 7053.047838541731, 7116.217216106121, 7175.892361614476, 6732.562383445061, 6838.0, 6938.410235129869, 7114.359707626339, 7263.34629883313, 6250.0, 6323.747050117944, 6387.5209359297305, 6393.1369265148605, 6409.391107844747, 4869.342638743724, 4889.193283108248, 5110.514501122388, 5121.718305493234, 5188.143956247177, 4954.9752251238515, 5009.849704508871, 5082.669626474268, 5196.766145523385, 5292.20616907467], "value": 4401.740324529609, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.63594233006893, 327.30284494027717, 351.5219301749621, 351.7309258417311, 367.395634181771, 4618.884527886805, 4889.291052797346, 4945.653804233701, 4973.900521989563, 5169.017886601543, 4603.424571928509, 4949.851504454863, 5121.134921824263, 5127.948720512793, 5150.793968241275, 4028.073543085085, 4066.9389959150635, 4067.613576710223, 4069.267531844267, 4088.9591104088877, 3178.904632861018, 3904.316744569703, 3992.680585553149, 4005.2990726622725, 4212.410262563244, 3840.289546433905, 3846.7307288489815, 3885.4560361549406, 4047.231026105045, 4079.8164082616354, 3263.90659129192, 3364.226227967581, 4001.7198796084285, 4038.374052021912, 4074.7962601869935, 3140.6388265349547, 3497.775778477538, 3517.419625761772, 3524.8515969806963, 3593.3352329819068, 4138.675084536666, 5029.220470827027, 5051.444341122474, 5058.215976523645, 5104.872378190538, 3889.397143442771, 4060.330045542482, 4670.98721324747, 4682.742449165295, 4689.320048592969, 4922.237053256751, 5143.6566231949155, 5451.0, 5528.944710552923, 5551.0, 3505.8071806050657, 3776.583781082094, 3785.6403641654274, 3791.848326066954, 3803.2393521295576, 4962.6774259673, 5042.999999999964, 5324.0, 5795.043817770063, 5942.346341902387, 3876.7480113792512, 3880.941785873214, 3890.5720370759195, 3890.8910960376156, 3898.434726964574, 3882.9710126816417, 3919.8236079376497, 3921.8627348042683, 3922.6464121526856, 4139.689523285766, 3599.4060979938017, 4251.702380833312, 4557.749323787223, 4579.9084018319445, 4752.239641657387, 4681.882952926204, 5516.806911758069, 5535.225068490415, 5538.113901775697, 5544.251526044013, 1268.429206856918, 1357.4027427931678, 1362.3801170467611, 1363.8567950365268, 1366.5012270521188, 884.743903047227, 915.1169121797365, 967.7241986034087, 970.4613939263635, 987.9506024698736, 4071.0, 4939.851804445872, 4946.925796113062, 4947.727874966911, 4992.8002879885125, 4541.863744087683, 5126.53861152498, 5422.75597598109, 5495.6153069285565, 5553.750081246354, 4119.464469618931, 4133.834646614162, 4299.527052024275, 5256.342957130359, 5296.788128474818, 2596.143272719998, 2662.3077999720213, 2849.202223377458, 2877.812942158753, 2889.9422011560073, 4915.124652078574, 5554.72226388679, 5626.381098079208, 5664.716764161775, 5690.886182276331, 4742.478327383985, 5093.643444958817, 5348.732563371894, 5355.357357117171, 5367.954123124251, 4486.932696009497, 4773.665843390999, 5039.840836607601, 5563.7774489019985, 5590.161475778666, 4515.774211289488, 4992.101421744121, 5200.635955483232, 5454.209139674805, 5458.5087342139395, 4499.392582001388, 5270.0, 5299.284596579412, 5313.415524292402, 5435.456454354533, 5103.515166059367, 5306.0, 5354.571634269327, 5668.61917994435, 5669.177969194526, 3079.615048118985, 3116.797408168462, 3344.1305260631925, 3423.5549378580627, 3629.274145171029, 4452.866414007585, 5080.882205914693, 5218.895622087461, 5441.319835020622, 5498.80754173602, 4676.789544470439, 4741.0, 5322.544391998078, 5360.954613850262, 5468.425815289496, 4790.640701947298, 5446.346438427256, 5477.287952566141, 5486.286782718221, 5501.5065433449245, 4937.851864444073, 5137.974310128426, 5181.896362072813, 5184.988927159318, 5388.784448622011, 5007.3240112584335, 5101.540861322499, 5105.923411148761, 5500.4224556420995, 5567.415421380697, 4540.568645978627, 4651.0, 5407.188921661782, 5491.2312276282155, 5508.925759476863], "value": 3950.9630713577167, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.6447658409088, 754.3587950242292, 772.5905270206789, 817.1338381315805, 854.1415877043569, 15056.397744090236, 15701.607459813496, 15784.921075394606, 15788.0, 16293.51119466418, 14417.495387661435, 14831.25843707813, 15106.093634381918, 15121.773173402407, 15138.924305378485, 852.0542198160053, 878.7495563764328, 878.9868151977726, 879.5074758135464, 880.1990188928077, 685.3591891581387, 703.5145749432901, 842.3934766967774, 868.288003836854, 871.8430682477151, 919.8528235482324, 924.2421214604027, 924.6671198368582, 925.2782829393084, 928.5403725156057, 908.2869947091567, 918.2149262380635, 919.4437365393941, 920.0661328751323, 921.8617207418873, 526.5103453787975, 541.5505130741475, 663.0419044480727, 691.6472598974559, 692.0415224913531, 14907.70184596302, 15411.691766164726, 15450.459233926871, 15465.922670386575, 15473.684736797386, 14103.083299585494, 14280.500182493666, 14426.206558639271, 14429.278536073154, 14440.422383104664, 11202.935721106482, 12978.675533111653, 13026.80459793104, 13165.539206127836, 13513.662158446019, 4273.743575385487, 4421.668374871898, 4449.844255451076, 4632.374629425019, 4633.351330813655, 125548.37225813903, 126703.36648316792, 127575.3621231888, 129834.3508282462, 129886.0, 10588.99404556566, 10838.07876330505, 11259.099272058216, 11402.714932126763, 11629.76740465203, 18890.52773680669, 23518.0, 23598.76401236, 23602.0, 23664.645030324216, 6379.904301435482, 7614.543127412373, 7635.740102882962, 7851.685932562634, 7909.644066017043, 4112.794360281974, 4124.876253712393, 4220.577942205755, 4231.809568569422, 4303.074838909587, 3403.761736678409, 3484.564429446319, 3523.3481805865995, 3528.2414280929725, 3528.8588456461966, 638.0684201066402, 647.4108561209277, 653.9967300163564, 668.759246671198, 671.9395254427125, 588.0414923674383, 625.6558892609138, 653.2422390027546, 661.778304268066, 663.3731124087691, 9804.264680149017, 9847.310688251897, 9899.455529945779, 10177.389356638625, 10180.440075795903, 497.6019184652264, 598.9520838332922, 659.370301362198, 663.4128796015465, 668.4952860590223, 4819.95180048202, 4968.378952630921, 5291.3121294231505, 5389.89793980348, 5595.720213989284, 115406.0, 116074.0, 117964.0, 118341.0, 121284.0, 82164.0, 100771.0, 104808.47595762125, 105065.47467262615, 107470.3879441809, 89620.6556901647, 90169.67115590365, 91405.0, 92135.07864921265, 92667.0, 7971.12317645047, 8982.371234013557, 10592.046715795615, 10785.62250321235, 11100.722481938015, 51560.74219628878, 56979.88321868481, 57351.13973290488, 57425.712871435375, 57829.0, 76745.0, 76819.8477022834, 77185.0, 78100.04749881299, 78619.60690196512, 12871.613851584467, 12962.287074211008, 13210.141340812816, 13377.264250465929, 13691.246981416118, 14543.92728036353, 14920.0, 14936.402543898123, 15309.46416875404, 15569.532914012598, 13902.860971390157, 13987.440502379792, 14225.502107426191, 14714.264286785832, 14834.406623734929, 13986.930065350016, 14060.859391406364, 14073.859261407255, 14134.575962721136, 14546.709065818835, 13610.523631672844, 13915.956303277093, 14194.929025354808, 14398.208098554262, 14418.639534011734, 9062.954685226532, 9659.754017416475, 11247.156463265124, 11546.76906461883, 11599.188056835941, 10825.296355736851, 11083.501242443948, 11093.667189984313, 11100.611478598534, 11238.83141752858], "value": 7794.0787965110985, "unit": "score"}], "name": "dromaeo_css", "value": 7363.631975663924, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 154.0, 114.0, 117.0, 164.0, 168.0, 115.0, 114.0], "value": 128.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 139.0, 138.0, 143.0, 126.0, 122.0, 96.0, 124.0, 161.0, 140.0], "value": 135.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 184.0, 186.0, 183.0, 184.0, 179.0, 183.0, 184.0, 186.0], "value": 183.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 58.0, 89.0, 59.0, 58.0, 59.0, 58.0, 74.0, 57.0], "value": 65.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 69.0, 85.0, 68.0, 69.0, 68.0, 84.0, 70.0, 54.0, 80.0], "value": 73.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 118.0, 87.0, 84.0, 87.0, 85.0, 128.0, 85.0, 86.0, 124.0], "value": 97.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 98.0, 96.0, 95.0, 100.0, 95.0, 97.0, 96.0, 96.0], "value": 96.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 87.0, 68.0, 130.0, 136.0, 101.0, 88.0, 87.0, 87.0, 86.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 54.0, 55.0, 55.0, 55.0, 55.0, 55.0, 55.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 73.0, 79.0, 76.0, 73.0, 70.0, 70.0, 70.0, 72.0, 72.0], "value": 72.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 93.0, 109.0, 109.0, 104.0, 90.0, 90.0, 87.0, 88.0, 91.0], "value": 94.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 140.0, 144.0, 148.0, 155.0, 176.0, 154.0, 151.0, 232.0, 153.0], "value": 159.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 172.0, 236.0, 212.0, 172.0, 169.0, 171.0, 175.0, 171.0, 172.0], "value": 182.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 70.0, 68.0, 72.0, 83.0, 90.0, 90.0, 86.0, 73.0], "value": 76.8, "unit": "score"}], "name": "kraken", "value": 1517.8000000000002, "alertThreshold": 2.0}]} 20:01:12 INFO - Return code: 0 20:01:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:01:12 INFO - # TBPL SUCCESS # 20:01:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:01:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:01:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:01:12 INFO - 2017-01-11 20:01:12.317 screenresolution[1914:11082] starting screenresolution argv=screenresolution get 20:01:12 INFO - 2017-01-11 20:01:12.320 screenresolution[1914:11082] Display 0: 1600x1200x32@60 20:01:12 INFO - 2017-01-11 20:01:12.326 screenresolution[1915:11085] starting screenresolution argv=screenresolution list 20:01:12 INFO - Available Modes on Display 0 20:01:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:01:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:01:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:01:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:01:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:01:12 INFO - Intel Iris: 20:01:12 INFO - Chipset Model: Intel Iris 20:01:12 INFO - Type: GPU 20:01:12 INFO - Bus: Built-In 20:01:12 INFO - VRAM (Dynamic, Max): 1536 MB 20:01:12 INFO - Vendor: Intel (0x8086) 20:01:12 INFO - Device ID: 0x0a2e 20:01:12 INFO - Revision ID: 0x0009 20:01:12 INFO - Displays: 20:01:12 INFO - Display: 20:01:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:01:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:01:12 INFO - Display Serial Number: 1600x1200 60 20:01:12 INFO - Main Display: Yes 20:01:12 INFO - Mirror: Off 20:01:12 INFO - Online: Yes 20:01:12 INFO - Rotation: Supported 20:01:12 INFO - Return code: 0 20:01:12 INFO - Running post-action listener: _resource_record_post_action 20:01:12 INFO - [mozharness: 2017-01-12 04:01:12.575380Z] Finished run-tests step (success) 20:01:12 INFO - Running post-run listener: _resource_record_post_run 20:01:12 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 4292608; Write bytes: 548660224; Read time: 25; Write time: 1597 20:01:12 INFO - TinderboxPrint: CPU usage
53.6% 20:01:12 INFO - TinderboxPrint: I/O read bytes / time
4,292,608 / 25 20:01:12 INFO - TinderboxPrint: I/O write bytes / time
548,660,224 / 1,597 20:01:12 INFO - TinderboxPrint: CPU idle
2,231.5 (46.4%) 20:01:12 INFO - TinderboxPrint: CPU system
959.7 (20.0%) 20:01:12 INFO - TinderboxPrint: CPU user
1,618.5 (33.7%) 20:01:12 INFO - TinderboxPrint: Swap in / out
254,844,928 / 0 20:01:12 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 251390464; Write bytes: 252692480; Read time: 18223; Write time: 525 20:01:12 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 1282048; Write bytes: 294456320; Read time: 14; Write time: 1066 20:01:13 INFO - Running post-run listener: _upload_blobber_files 20:01:13 INFO - Blob upload gear active. 20:01:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:01:13 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:01:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:01:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:01:13 INFO - (blobuploader) - INFO - Open directory for files ... 20:01:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:01:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:01:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:01:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:01:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:01:14 INFO - (blobuploader) - INFO - Done attempting. 20:01:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:01:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:01:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:01:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:01:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:01:15 INFO - (blobuploader) - INFO - Done attempting. 20:01:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:01:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:01:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:01:16 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:01:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:01:16 INFO - (blobuploader) - INFO - Done attempting. 20:01:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:01:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:01:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:01:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:01:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:01:18 INFO - (blobuploader) - INFO - Done attempting. 20:01:18 INFO - (blobuploader) - INFO - Iteration through files over. 20:01:18 INFO - Return code: 0 20:01:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:01:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:01:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9b46fc6442208264d7c1e54eed6a5d0f81d2c0248722820f7f79b5180aa6df7d8e0d23337d6eb01d816d45625b9696229eaecb312ddf4aafde21e9d498df096e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/70ba1c0bce030249c753c7a70cb49ece8ee1cbc64782a05cf91a7de51184d204a60e428d980a739343d648dac691ccd21a0764522872b095195eb22ada6a2e45", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/a7719dda606917d19e52723c24a985eedb39c0bc68774ee96cf19cc2dac29604e7ab4247a5a599795cf57c6d66699c090315de214cb95336d1ac352a7cfcfc19", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/0c82eabde62e217b6864eb21824e01eb79e890ad5e0d7cf0e53409f886e6b7ca7a993290842af4229f853826f6be2b98889e037176f8ea107bec3d7792b9dcd2"} 20:01:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:01:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:01:18 INFO - Contents: 20:01:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9b46fc6442208264d7c1e54eed6a5d0f81d2c0248722820f7f79b5180aa6df7d8e0d23337d6eb01d816d45625b9696229eaecb312ddf4aafde21e9d498df096e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/70ba1c0bce030249c753c7a70cb49ece8ee1cbc64782a05cf91a7de51184d204a60e428d980a739343d648dac691ccd21a0764522872b095195eb22ada6a2e45", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/a7719dda606917d19e52723c24a985eedb39c0bc68774ee96cf19cc2dac29604e7ab4247a5a599795cf57c6d66699c090315de214cb95336d1ac352a7cfcfc19", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/0c82eabde62e217b6864eb21824e01eb79e890ad5e0d7cf0e53409f886e6b7ca7a993290842af4229f853826f6be2b98889e037176f8ea107bec3d7792b9dcd2"} 20:01:18 INFO - Running post-run listener: copy_logs_to_upload_dir 20:01:18 INFO - Copying logs to upload dir... 20:01:18 INFO - mkdir: /builds/slave/test/build/upload/logs 20:01:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.270456 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-01-11 20:01:18.961324) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-11 20:01:18.964457) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7MvL0giBCw/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.tKDcAfy8oq/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9b46fc6442208264d7c1e54eed6a5d0f81d2c0248722820f7f79b5180aa6df7d8e0d23337d6eb01d816d45625b9696229eaecb312ddf4aafde21e9d498df096e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/70ba1c0bce030249c753c7a70cb49ece8ee1cbc64782a05cf91a7de51184d204a60e428d980a739343d648dac691ccd21a0764522872b095195eb22ada6a2e45", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/a7719dda606917d19e52723c24a985eedb39c0bc68774ee96cf19cc2dac29604e7ab4247a5a599795cf57c6d66699c090315de214cb95336d1ac352a7cfcfc19", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/0c82eabde62e217b6864eb21824e01eb79e890ad5e0d7cf0e53409f886e6b7ca7a993290842af4229f853826f6be2b98889e037176f8ea107bec3d7792b9dcd2"} build_url:https://queue.taskcluster.net/v1/task/NaUEN1gnQHSjUye_UTWFEQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011491 build_url: 'https://queue.taskcluster.net/v1/task/NaUEN1gnQHSjUye_UTWFEQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9b46fc6442208264d7c1e54eed6a5d0f81d2c0248722820f7f79b5180aa6df7d8e0d23337d6eb01d816d45625b9696229eaecb312ddf4aafde21e9d498df096e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/70ba1c0bce030249c753c7a70cb49ece8ee1cbc64782a05cf91a7de51184d204a60e428d980a739343d648dac691ccd21a0764522872b095195eb22ada6a2e45", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/a7719dda606917d19e52723c24a985eedb39c0bc68774ee96cf19cc2dac29604e7ab4247a5a599795cf57c6d66699c090315de214cb95336d1ac352a7cfcfc19", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/0c82eabde62e217b6864eb21824e01eb79e890ad5e0d7cf0e53409f886e6b7ca7a993290842af4229f853826f6be2b98889e037176f8ea107bec3d7792b9dcd2"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-11 20:01:19.003631) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 20:01:19.004327) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7MvL0giBCw/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.tKDcAfy8oq/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005270 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 20:01:19.053065) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-11 20:01:19.053400) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-11 20:01:19.053735) ========= ========= Total master_lag: 0.20 =========