builder: graphics_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0261 starttime: 1482184502.64 results: success (0) buildid: 20161219123723 builduid: df1268842007495d8dbe69c1a8d8c224 revision: 39d87131faa0ceabba4e740dc80bc58dae52e24d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-19 13:55:02.642501) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-19 13:55:02.642909) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-19 13:55:02.643185) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-19 13:55:02.669275) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 13:55:02.669665) ========= 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.TiolayNXGd/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.lddQaDqBIH/Listeners TMPDIR=/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 --2016-12-19 13:55:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.58M=0.001s 2016-12-19 13:55:02 (8.58 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.109142 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 13:55:02.801725) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 13:55:02.802036) ========= 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.TiolayNXGd/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.lddQaDqBIH/Listeners TMPDIR=/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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.020931 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 13:55:02.851071) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-19 13:55:02.854481) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 39d87131faa0ceabba4e740dc80bc58dae52e24d --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 39d87131faa0ceabba4e740dc80bc58dae52e24d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TiolayNXGd/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.lddQaDqBIH/Listeners TMPDIR=/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 2016-12-19 13:55:02,931 truncating revision to first 12 chars 2016-12-19 13:55:02,932 Setting DEBUG logging. 2016-12-19 13:55:02,932 attempt 1/10 2016-12-19 13:55:02,932 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/39d87131faa0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-19 13:55:03,695 unpacking tar archive at: graphics-39d87131faa0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.023560 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-19 13:55:03.901885) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-19 13:55:03.902203) ========= script_repo_revision: 39d87131faa0ceabba4e740dc80bc58dae52e24d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-19 13:55:03.902656) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-19 13:55:03.902920) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-19 13:55:03.922700) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-12-19 13:55:03.923084) ========= /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.TiolayNXGd/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.lddQaDqBIH/Listeners TMPDIR=/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 13:55:04 INFO - MultiFileLogger online at 20161219 13:55:04 in /builds/slave/test 13:55:04 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 13:55:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:55:04 INFO - {'append_to_log': False, 13:55:04 INFO - 'base_work_dir': '/builds/slave/test', 13:55:04 INFO - 'blob_upload_branch': 'Graphics', 13:55:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:55:04 INFO - 'branch': 'Graphics', 13:55:04 INFO - 'buildbot_json_path': 'buildprops.json', 13:55:04 INFO - 'config_files': ('talos/mac_config.py',), 13:55:04 INFO - 'default_actions': ('clobber', 13:55:04 INFO - 'read-buildbot-config', 13:55:04 INFO - 'download-and-extract', 13:55:04 INFO - 'populate-webroot', 13:55:04 INFO - 'create-virtualenv', 13:55:04 INFO - 'install', 13:55:04 INFO - 'run-tests'), 13:55:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:55:04 INFO - 'download_minidump_stackwalk': True, 13:55:04 INFO - 'download_symbols': 'ondemand', 13:55:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:55:04 INFO - 'tooltool.py': '/tools/tooltool.py', 13:55:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:55:04 INFO - '/tools/misc-python/virtualenv.py')}, 13:55:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:55:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:55:04 INFO - 'installer_path': 'installer.exe', 13:55:04 INFO - 'log_level': 'info', 13:55:04 INFO - 'log_name': 'talos', 13:55:04 INFO - 'log_to_console': True, 13:55:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:55:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:55:04 INFO - 'opt_config_files': (), 13:55:04 INFO - 'pip_index': False, 13:55:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:55:04 INFO - 'cmd': ('bash', 13:55:04 INFO - '-c', 13:55:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:55:04 INFO - 'enabled': True, 13:55:04 INFO - 'halt_on_failure': False, 13:55:04 INFO - 'name': 'check_screen_resolution'},), 13:55:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:55:04 INFO - 'cmd': ('bash', 13:55:04 INFO - '-c', 13:55:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:55:04 INFO - 'enabled': True, 13:55:04 INFO - 'halt_on_failure': False, 13:55:04 INFO - 'name': 'check_screen_resolution'},), 13:55:04 INFO - 'run_cmd_checks_enabled': True, 13:55:04 INFO - 'sps_profile': False, 13:55:04 INFO - 'sps_profile_interval': 0, 13:55:04 INFO - 'suite': 'dromaeojs', 13:55:04 INFO - 'system_bits': '32', 13:55:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:55:04 INFO - 'title': 't-yosemite-r7-0261', 13:55:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:55:04 INFO - 'use_talos_json': True, 13:55:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:55:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:55:04 INFO - 'work_dir': 'build'} 13:55:04 INFO - [mozharness: 2016-12-19 21:55:04.120553Z] Running clobber step. 13:55:04 INFO - Running pre-action listener: _resource_record_pre_action 13:55:04 INFO - Running main action method: clobber 13:55:04 INFO - rmtree: /builds/slave/test/build 13:55:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:55:06 INFO - Running post-action listener: _resource_record_post_action 13:55:06 INFO - [mozharness: 2016-12-19 21:55:06.407339Z] Finished clobber step (success) 13:55:06 INFO - [mozharness: 2016-12-19 21:55:06.407606Z] Running read-buildbot-config step. 13:55:06 INFO - Running pre-action listener: _resource_record_pre_action 13:55:06 INFO - Running main action method: read_buildbot_config 13:55:06 INFO - Using buildbot properties: 13:55:06 INFO - { 13:55:06 INFO - "project": "", 13:55:06 INFO - "product": "firefox", 13:55:06 INFO - "script_repo_revision": "default", 13:55:06 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs", 13:55:06 INFO - "repository": "", 13:55:06 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs", 13:55:06 INFO - "buildid": "20161219123723", 13:55:06 INFO - "pgo_build": "False", 13:55:06 INFO - "basedir": "/builds/slave/test", 13:55:06 INFO - "buildnumber": 6, 13:55:06 INFO - "slavename": "t-yosemite-r7-0261", 13:55:06 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 13:55:06 INFO - "platform": "yosemite_r7", 13:55:06 INFO - "scheduler": "tests-graphics-macosx64-talos", 13:55:06 INFO - "branch": "graphics", 13:55:06 INFO - "repo_path": "projects/graphics", 13:55:06 INFO - "revision": "39d87131faa0ceabba4e740dc80bc58dae52e24d", 13:55:06 INFO - "stage_platform": "macosx64", 13:55:06 INFO - "builduid": "df1268842007495d8dbe69c1a8d8c224", 13:55:06 INFO - "slavebuilddir": "test" 13:55:06 INFO - } 13:55:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/aXEeZ5t6TMG3KYq44UfISQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 13:55:06 INFO - Running post-action listener: _resource_record_post_action 13:55:06 INFO - [mozharness: 2016-12-19 21:55:06.413234Z] Finished read-buildbot-config step (success) 13:55:06 INFO - [mozharness: 2016-12-19 21:55:06.413398Z] Running download-and-extract step. 13:55:06 INFO - Running pre-action listener: _resource_record_pre_action 13:55:06 INFO - Running main action method: download_and_extract 13:55:06 INFO - mkdir: /builds/slave/test/build/tests 13:55:06 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')]} 13:55:06 INFO - trying https://queue.taskcluster.net/v1/task/aXEeZ5t6TMG3KYq44UfISQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 13:55:06 INFO - Downloading https://queue.taskcluster.net/v1/task/aXEeZ5t6TMG3KYq44UfISQ/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 13:55:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aXEeZ5t6TMG3KYq44UfISQ/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 13:55:07 INFO - Downloaded 1199 bytes. 13:55:07 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 13:55:07 INFO - Using the following test package requirements: 13:55:07 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 13:55:07 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 13:55:07 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 13:55:07 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 13:55:07 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 13:55:07 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 13:55:07 INFO - u'jsshell-mac.zip'], 13:55:07 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 13:55:07 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 13:55:07 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 13:55:07 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 13:55:07 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 13:55:07 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 13:55:07 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 13:55:07 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 13:55:07 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 13:55:07 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 13:55:07 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 13:55:07 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:55:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aXEeZ5t6TMG3KYq44UfISQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 13:55:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aXEeZ5t6TMG3KYq44UfISQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:55:07 INFO - Fetch https://queue.taskcluster.net/v1/task/aXEeZ5t6TMG3KYq44UfISQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 13:55:08 INFO - Expected file size: 16276046 13:55:08 INFO - Obtained file size: 16276046 13:55:15 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 13:55:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aXEeZ5t6TMG3KYq44UfISQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 13:55:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aXEeZ5t6TMG3KYq44UfISQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:55:15 INFO - Fetch https://queue.taskcluster.net/v1/task/aXEeZ5t6TMG3KYq44UfISQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 13:55:15 INFO - Expected file size: 16276046 13:55:15 INFO - Obtained file size: 16276046 13:55:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aXEeZ5t6TMG3KYq44UfISQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 13:55:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aXEeZ5t6TMG3KYq44UfISQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 13:55:22 INFO - Fetch https://queue.taskcluster.net/v1/task/aXEeZ5t6TMG3KYq44UfISQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 13:55:23 INFO - Expected file size: 14409734 13:55:23 INFO - Obtained file size: 14409734 13:55:23 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')]} 13:55:23 INFO - trying https://queue.taskcluster.net/v1/task/aXEeZ5t6TMG3KYq44UfISQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 13:55:23 INFO - Downloading https://queue.taskcluster.net/v1/task/aXEeZ5t6TMG3KYq44UfISQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 13:55:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aXEeZ5t6TMG3KYq44UfISQ/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 13:55:25 INFO - Downloaded 69661362 bytes. 13:55:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aXEeZ5t6TMG3KYq44UfISQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 13:55:25 INFO - mkdir: /builds/slave/test/properties 13:55:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:55:25 INFO - Writing to file /builds/slave/test/properties/build_url 13:55:25 INFO - Contents: 13:55:25 INFO - build_url:https://queue.taskcluster.net/v1/task/aXEeZ5t6TMG3KYq44UfISQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 13:55:26 INFO - Running post-action listener: _resource_record_post_action 13:55:26 INFO - Running post-action listener: set_extra_try_arguments 13:55:26 INFO - [mozharness: 2016-12-19 21:55:26.486290Z] Finished download-and-extract step (success) 13:55:26 INFO - [mozharness: 2016-12-19 21:55:26.486398Z] Running populate-webroot step. 13:55:26 INFO - Running pre-action listener: _resource_record_pre_action 13:55:26 INFO - Running main action method: populate_webroot 13:55:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:55:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:55:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:55:26 INFO - '--tppagecycles', 13:55:26 INFO - '7'], 13:55:26 INFO - 'tests': ['tsvgm']}}, 13:55:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:55:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:55:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:55:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:55:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:55:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:55:26 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 13:55:26 INFO - 'talos_options': ['--disable-e10s'], 13:55:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:55:26 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:55:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:55:26 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 13:55:26 INFO - 'talos_options': ['--disable-e10s'], 13:55:26 INFO - 'tests': ['damp', 'tps']}, 13:55:26 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:55:26 INFO - 'tests': ['damp', 'tps']}, 13:55:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:55:26 INFO - 'tests': ['dromaeo_dom']}, 13:55:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:55:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:55:26 INFO - 'tests': ['basic_compositor_video']}, 13:55:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:55:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:55:26 INFO - 'tests': ['a11yr', 13:55:26 INFO - 'ts_paint', 13:55:26 INFO - 'tpaint', 13:55:26 INFO - 'sessionrestore', 13:55:26 INFO - 'sessionrestore_no_auto_restore', 13:55:26 INFO - 'tabpaint']}, 13:55:26 INFO - 'other-e10s': {'tests': ['a11yr', 13:55:26 INFO - 'ts_paint', 13:55:26 INFO - 'tpaint', 13:55:26 INFO - 'sessionrestore', 13:55:26 INFO - 'sessionrestore_no_auto_restore', 13:55:26 INFO - 'tabpaint']}, 13:55:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:55:26 INFO - 'ts_paint', 13:55:26 INFO - 'tpaint', 13:55:26 INFO - 'sessionrestore', 13:55:26 INFO - 'sessionrestore_no_auto_restore', 13:55:26 INFO - 'tabpaint']}, 13:55:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:55:26 INFO - 'ts_paint', 13:55:26 INFO - 'tpaint', 13:55:26 INFO - 'sessionrestore', 13:55:26 INFO - 'sessionrestore_no_auto_restore', 13:55:26 INFO - 'tabpaint']}, 13:55:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:55:26 INFO - 'tests': ['a11yr', 13:55:26 INFO - 'ts_paint', 13:55:26 INFO - 'tpaint', 13:55:26 INFO - 'sessionrestore', 13:55:26 INFO - 'sessionrestore_no_auto_restore', 13:55:26 INFO - 'tabpaint']}, 13:55:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:55:26 INFO - 'tests': ['a11yr', 13:55:26 INFO - 'ts_paint', 13:55:26 INFO - 'tpaint', 13:55:26 INFO - 'sessionrestore', 13:55:26 INFO - 'sessionrestore_no_auto_restore', 13:55:26 INFO - 'tabpaint']}, 13:55:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:55:26 INFO - 'tests': ['tsvgx', 13:55:26 INFO - 'tsvgr_opacity', 13:55:26 INFO - 'tart', 13:55:26 INFO - 'tscrollx', 13:55:26 INFO - 'cart', 13:55:26 INFO - 'tsvg_static']}, 13:55:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:55:26 INFO - 'tsvgr_opacity', 13:55:26 INFO - 'tart', 13:55:26 INFO - 'tscrollx', 13:55:26 INFO - 'cart', 13:55:26 INFO - 'tsvg_static']}, 13:55:26 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 13:55:26 INFO - 'talos_options': ['--disable-e10s'], 13:55:26 INFO - 'tests': ['tp5o']}, 13:55:26 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:55:26 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 13:55:26 INFO - 'talos_options': ['--disable-e10s', 13:55:26 INFO - '--xperf_path', 13:55:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:55:26 INFO - 'tests': ['tp5n']}, 13:55:26 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:55:26 INFO - 'talos_options': ['--xperf_path', 13:55:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:55:26 INFO - 'tests': ['tp5n']}}, 13:55:26 INFO - 'talos.zip': {'path': '', 13:55:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:55:26 INFO - Running post-action listener: _resource_record_post_action 13:55:26 INFO - [mozharness: 2016-12-19 21:55:26.504460Z] Finished populate-webroot step (success) 13:55:26 INFO - [mozharness: 2016-12-19 21:55:26.504591Z] Running create-virtualenv step. 13:55:26 INFO - Running pre-action listener: _resource_record_pre_action 13:55:26 INFO - Running main action method: create_virtualenv 13:55:26 INFO - Creating virtualenv /builds/slave/test/build/venv 13:55:26 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 13:55:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:55:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:55:26 INFO - Using real prefix '/tools/python27' 13:55:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:55:27 INFO - Installing distribute.............................................................................................................................................................................................done. 13:55:30 INFO - Installing pip.................done. 13:55:30 INFO - Return code: 0 13:55:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:55:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:55:30 INFO - Reading from file tmpfile_stdout 13:55:30 INFO - Output received: 13:55:30 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) 13:55:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:55:30 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')]} 13:55:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:30 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')]} 13:55:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:30 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 0x10ce16b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce19768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb153d71880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbf4d30>, '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 0x10cb1bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbe9be8>, '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.TiolayNXGd/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.lddQaDqBIH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 13:55:30 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 13:55:30 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 13:55:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TiolayNXGd/Render', 13:55:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:55:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:55:30 INFO - 'HOME': '/Users/cltbld', 13:55:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:55:30 INFO - 'LOGNAME': 'cltbld', 13:55:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:30 INFO - 'MOZ_NO_REMOTE': '1', 13:55:30 INFO - 'NO_EM_RESTART': '1', 13:55:30 INFO - 'PAGER': '/bin/cat', 13:55:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:55:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:30 INFO - 'PWD': '/builds/slave/test', 13:55:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:55:30 INFO - 'SHELL': '/bin/bash', 13:55:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lddQaDqBIH/Listeners', 13:55:30 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 13:55:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:55:30 INFO - 'USER': 'cltbld', 13:55:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:55:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:55:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:30 INFO - 'XPC_FLAGS': '0x0', 13:55:30 INFO - 'XPC_SERVICE_NAME': '0', 13:55:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:55:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:30 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 13:55:30 INFO - Cleaning up... 13:55:30 INFO - Return code: 0 13:55:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:55:30 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')]} 13:55:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:30 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')]} 13:55:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:30 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 0x10ce16b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce19768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb153d71880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbf4d30>, '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 0x10cb1bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbe9be8>, '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.TiolayNXGd/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.lddQaDqBIH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 13:55:30 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 13:55:30 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 13:55:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TiolayNXGd/Render', 13:55:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:55:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:55:30 INFO - 'HOME': '/Users/cltbld', 13:55:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:55:30 INFO - 'LOGNAME': 'cltbld', 13:55:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:30 INFO - 'MOZ_NO_REMOTE': '1', 13:55:30 INFO - 'NO_EM_RESTART': '1', 13:55:30 INFO - 'PAGER': '/bin/cat', 13:55:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:55:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:30 INFO - 'PWD': '/builds/slave/test', 13:55:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:55:30 INFO - 'SHELL': '/bin/bash', 13:55:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lddQaDqBIH/Listeners', 13:55:30 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 13:55:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:55:30 INFO - 'USER': 'cltbld', 13:55:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:55:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:55:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:30 INFO - 'XPC_FLAGS': '0x0', 13:55:30 INFO - 'XPC_SERVICE_NAME': '0', 13:55:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:55:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:30 INFO - Downloading/unpacking psutil>=3.1.1 13:55:30 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 13:55:30 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 13:55:30 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 13:55:30 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 13:55:30 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 13:55:30 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 13:55:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:55:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:55:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:55:34 INFO - Installing collected packages: psutil 13:55:34 INFO - Running setup.py install for psutil 13:55:34 INFO - building 'psutil._psutil_osx' extension 13:55:34 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 13:55:34 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 13:55:34 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 13:55:35 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 13:55:35 INFO - building 'psutil._psutil_posix' extension 13:55:35 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 13:55:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:55:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:55:35 INFO - ^ 13:55:35 INFO - 1 warning generated. 13:55:35 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 13:55:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:55:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:55:35 INFO - Successfully installed psutil 13:55:35 INFO - Cleaning up... 13:55:35 INFO - Return code: 0 13:55:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:55:35 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')]} 13:55:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:35 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')]} 13:55:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:35 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 0x10ce16b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce19768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb153d71880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbf4d30>, '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 0x10cb1bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbe9be8>, '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.TiolayNXGd/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.lddQaDqBIH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 13:55:35 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 13:55:35 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 13:55:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TiolayNXGd/Render', 13:55:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:55:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:55:35 INFO - 'HOME': '/Users/cltbld', 13:55:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:55:35 INFO - 'LOGNAME': 'cltbld', 13:55:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:35 INFO - 'MOZ_NO_REMOTE': '1', 13:55:35 INFO - 'NO_EM_RESTART': '1', 13:55:35 INFO - 'PAGER': '/bin/cat', 13:55:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:55:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:35 INFO - 'PWD': '/builds/slave/test', 13:55:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:55:35 INFO - 'SHELL': '/bin/bash', 13:55:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lddQaDqBIH/Listeners', 13:55:35 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 13:55:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:55:35 INFO - 'USER': 'cltbld', 13:55:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:55:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:55:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:35 INFO - 'XPC_FLAGS': '0x0', 13:55:35 INFO - 'XPC_SERVICE_NAME': '0', 13:55:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:55:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:55:35 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 13:55:35 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 13:55:35 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 13:55:35 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 13:55:35 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 13:55:35 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 13:55:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:55:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:55:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:55:38 INFO - Installing collected packages: mozsystemmonitor 13:55:38 INFO - Running setup.py install for mozsystemmonitor 13:55:38 INFO - Successfully installed mozsystemmonitor 13:55:38 INFO - Cleaning up... 13:55:38 INFO - Return code: 0 13:55:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:55:38 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')]} 13:55:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:38 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')]} 13:55:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:38 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 0x10ce16b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce19768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb153d71880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbf4d30>, '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 0x10cb1bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbe9be8>, '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.TiolayNXGd/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.lddQaDqBIH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 13:55:38 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 13:55:38 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 13:55:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TiolayNXGd/Render', 13:55:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:55:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:55:38 INFO - 'HOME': '/Users/cltbld', 13:55:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:55:38 INFO - 'LOGNAME': 'cltbld', 13:55:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:38 INFO - 'MOZ_NO_REMOTE': '1', 13:55:38 INFO - 'NO_EM_RESTART': '1', 13:55:38 INFO - 'PAGER': '/bin/cat', 13:55:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:55:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:38 INFO - 'PWD': '/builds/slave/test', 13:55:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:55:38 INFO - 'SHELL': '/bin/bash', 13:55:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lddQaDqBIH/Listeners', 13:55:38 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 13:55:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:55:38 INFO - 'USER': 'cltbld', 13:55:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:55:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:55:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:38 INFO - 'XPC_FLAGS': '0x0', 13:55:38 INFO - 'XPC_SERVICE_NAME': '0', 13:55:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:55:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:38 INFO - Downloading/unpacking jsonschema==2.5.1 13:55:38 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 13:55:38 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 13:55:38 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 13:55:38 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 13:55:38 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 13:55:38 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 13:55:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:55:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:55: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 13:55: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 13:55: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 13:55: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 13:55: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 13:55: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 13:55:41 INFO - Downloading functools32-3.2.3-2.tar.gz 13:55:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:55:42 INFO - warning: no files found matching '*.txt' 13:55:42 INFO - no previously-included directories found matching 'build' 13:55:42 INFO - no previously-included directories found matching 'dist' 13:55:42 INFO - no previously-included directories found matching '.git*' 13:55:42 INFO - Installing collected packages: jsonschema, functools32 13:55:42 INFO - Running setup.py install for functools32 13:55:42 INFO - warning: no files found matching '*.txt' 13:55:42 INFO - no previously-included directories found matching 'build' 13:55:42 INFO - no previously-included directories found matching 'dist' 13:55:42 INFO - no previously-included directories found matching '.git*' 13:55:42 INFO - Successfully installed jsonschema functools32 13:55:42 INFO - Cleaning up... 13:55:42 INFO - Return code: 0 13:55:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:55:42 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')]} 13:55:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:42 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')]} 13:55:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:42 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 0x10ce16b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce19768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb153d71880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbf4d30>, '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 0x10cb1bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbe9be8>, '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.TiolayNXGd/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.lddQaDqBIH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 13:55:42 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 13:55:42 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 13:55:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TiolayNXGd/Render', 13:55:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:55:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:55:42 INFO - 'HOME': '/Users/cltbld', 13:55:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:55:42 INFO - 'LOGNAME': 'cltbld', 13:55:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:42 INFO - 'MOZ_NO_REMOTE': '1', 13:55:42 INFO - 'NO_EM_RESTART': '1', 13:55:42 INFO - 'PAGER': '/bin/cat', 13:55:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:55:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:42 INFO - 'PWD': '/builds/slave/test', 13:55:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:55:42 INFO - 'SHELL': '/bin/bash', 13:55:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lddQaDqBIH/Listeners', 13:55:42 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 13:55:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:55:42 INFO - 'USER': 'cltbld', 13:55:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:55:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:55:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:42 INFO - 'XPC_FLAGS': '0x0', 13:55:42 INFO - 'XPC_SERVICE_NAME': '0', 13:55:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:55:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:55:42 INFO - Cleaning up... 13:55:42 INFO - Return code: 0 13:55:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:55:42 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')]} 13:55:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:42 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')]} 13:55:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:42 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 0x10ce16b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce19768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb153d71880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbf4d30>, '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 0x10cb1bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbe9be8>, '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.TiolayNXGd/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.lddQaDqBIH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 13:55:42 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 13:55:42 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 13:55:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TiolayNXGd/Render', 13:55:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:55:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:55:42 INFO - 'HOME': '/Users/cltbld', 13:55:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:55:42 INFO - 'LOGNAME': 'cltbld', 13:55:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:42 INFO - 'MOZ_NO_REMOTE': '1', 13:55:42 INFO - 'NO_EM_RESTART': '1', 13:55:42 INFO - 'PAGER': '/bin/cat', 13:55:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:55:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:42 INFO - 'PWD': '/builds/slave/test', 13:55:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:55:42 INFO - 'SHELL': '/bin/bash', 13:55:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lddQaDqBIH/Listeners', 13:55:42 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 13:55:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:55:42 INFO - 'USER': 'cltbld', 13:55:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:55:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:55:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:42 INFO - 'XPC_FLAGS': '0x0', 13:55:42 INFO - 'XPC_SERVICE_NAME': '0', 13:55:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:55:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:42 INFO - Downloading/unpacking blobuploader==1.2.4 13:55:42 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 13:55:42 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 13:55:42 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 13:55:42 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 13:55:42 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 13:55:42 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 13:55:45 INFO - Downloading blobuploader-1.2.4.tar.gz 13:55:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:55:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:55:45 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 13:55:45 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 13:55:45 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 13:55:45 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 13:55:45 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 13:55:45 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 13:55:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:55:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:55: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 13:55: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 13:55: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 13:55: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 13:55: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 13:55: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 13:55:46 INFO - Downloading docopt-0.6.1.tar.gz 13:55:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:55:46 INFO - Installing collected packages: blobuploader, requests, docopt 13:55:46 INFO - Running setup.py install for blobuploader 13:55:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:55:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:55:46 INFO - Running setup.py install for requests 13:55:47 INFO - Running setup.py install for docopt 13:55:47 INFO - Successfully installed blobuploader requests docopt 13:55:47 INFO - Cleaning up... 13:55:47 INFO - Return code: 0 13:55:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:55:47 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')]} 13:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:47 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')]} 13:55:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:47 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 0x10ce16b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce19768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb153d71880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbf4d30>, '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 0x10cb1bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbe9be8>, '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.TiolayNXGd/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.lddQaDqBIH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 13:55:47 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 13:55:47 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 13:55:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TiolayNXGd/Render', 13:55:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:55:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:55:47 INFO - 'HOME': '/Users/cltbld', 13:55:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:55:47 INFO - 'LOGNAME': 'cltbld', 13:55:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:47 INFO - 'MOZ_NO_REMOTE': '1', 13:55:47 INFO - 'NO_EM_RESTART': '1', 13:55:47 INFO - 'PAGER': '/bin/cat', 13:55:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:55:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:47 INFO - 'PWD': '/builds/slave/test', 13:55:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:55:47 INFO - 'SHELL': '/bin/bash', 13:55:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lddQaDqBIH/Listeners', 13:55:47 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 13:55:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:55:47 INFO - 'USER': 'cltbld', 13:55:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:55:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:55:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:47 INFO - 'XPC_FLAGS': '0x0', 13:55:47 INFO - 'XPC_SERVICE_NAME': '0', 13:55:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:55:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:55:47 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-UGtXGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:55:47 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-F0DsVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:55:48 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-qOPNKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:55:48 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-0YLeuV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:55:48 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-hFLbLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:55:48 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-6U6QGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:55:48 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-Hsuv5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:55:48 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-49xhs4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:55:48 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-yhSOXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:55:48 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-yGGi4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:55:48 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-dVkypV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:55:48 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-V97WgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:55:49 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-N979SO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:55:49 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-2uNljt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:55:49 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-1xTqAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:55:49 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-Q8HTGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:55:49 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-BW8Crt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:55:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:55:49 INFO - Running setup.py install for manifestparser 13:55:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:55:49 INFO - Running setup.py install for mozcrash 13:55:49 INFO - Running setup.py install for mozdebug 13:55:50 INFO - Running setup.py install for mozdevice 13:55:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:55:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:55:50 INFO - Running setup.py install for mozfile 13:55:50 INFO - Running setup.py install for mozhttpd 13:55:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:55:50 INFO - Running setup.py install for mozinfo 13:55:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:55:50 INFO - Running setup.py install for mozInstall 13:55:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:55:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:55:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:55:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:55:50 INFO - Running setup.py install for mozleak 13:55:50 INFO - Running setup.py install for mozlog 13:55:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:55:51 INFO - Running setup.py install for moznetwork 13:55:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:55:51 INFO - Running setup.py install for mozprocess 13:55:51 INFO - Running setup.py install for mozprofile 13:55:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:55:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:55:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:55:51 INFO - Running setup.py install for mozrunner 13:55:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:55:51 INFO - Running setup.py install for mozscreenshot 13:55:51 INFO - Running setup.py install for moztest 13:55:52 INFO - Running setup.py install for mozversion 13:55:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:55:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:55:52 INFO - Cleaning up... 13:55:52 INFO - Return code: 0 13:55:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:55:52 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')]} 13:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:52 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')]} 13:55:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:52 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 0x10ce16b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce19768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb153d71880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbf4d30>, '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 0x10cb1bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbe9be8>, '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.TiolayNXGd/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.lddQaDqBIH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 13:55:52 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 13:55:52 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 13:55:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TiolayNXGd/Render', 13:55:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:55:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:55:52 INFO - 'HOME': '/Users/cltbld', 13:55:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:55:52 INFO - 'LOGNAME': 'cltbld', 13:55:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:52 INFO - 'MOZ_NO_REMOTE': '1', 13:55:52 INFO - 'NO_EM_RESTART': '1', 13:55:52 INFO - 'PAGER': '/bin/cat', 13:55:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:55:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:52 INFO - 'PWD': '/builds/slave/test', 13:55:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:55:52 INFO - 'SHELL': '/bin/bash', 13:55:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lddQaDqBIH/Listeners', 13:55:52 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 13:55:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:55:52 INFO - 'USER': 'cltbld', 13:55:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:55:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:55:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:52 INFO - 'XPC_FLAGS': '0x0', 13:55:52 INFO - 'XPC_SERVICE_NAME': '0', 13:55:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:55:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:55:52 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-Hz97Hj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:55:52 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)) 13:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:55:52 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-izsPTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:55:52 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)) 13:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:55:52 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-26NBGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:55:52 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)) 13:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:55:52 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-i0TIFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:55:52 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)) 13:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:55:52 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-xasUzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:55:52 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)) 13:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:55:52 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-AZpE5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:55:53 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)) 13:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:55:53 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-KE2nin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:55:53 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)) 13:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:55:53 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-kRwM1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:55:53 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)) 13:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:55:53 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-PyHHIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:55:53 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)) 13:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:55:53 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-9Y3WCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:55:53 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)) 13:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:55:53 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-F817Ab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:55:53 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)) 13:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:55:53 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-TMO1C0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:55:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 13:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:55:53 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-fPHYI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:55:53 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)) 13:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:55:53 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-DzIMgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:55:53 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)) 13:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:55:53 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-KnsOvv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:55:54 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)) 13:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:55:54 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-mxDF2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:55:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 13:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:55:54 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-yuouZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:55:54 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)) 13:55:54 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)) 13:55:54 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)) 13:55:54 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)) 13:55:54 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)) 13:55:54 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)) 13:55:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:55:54 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 13:55:54 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 13:55:54 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 13:55:54 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 13:55:54 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 13:55:54 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 13:55:56 INFO - Downloading blessings-1.6.tar.gz 13:55:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:55:56 INFO - Installing collected packages: blessings 13:55:56 INFO - Running setup.py install for blessings 13:55:57 INFO - Successfully installed blessings 13:55:57 INFO - Cleaning up... 13:55:57 INFO - Return code: 0 13:55:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:55:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:55:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:55:57 INFO - Reading from file tmpfile_stdout 13:55:57 INFO - Current package versions: 13:55:57 INFO - blessings == 1.6 13:55:57 INFO - blobuploader == 1.2.4 13:55:57 INFO - docopt == 0.6.1 13:55:57 INFO - functools32 == 3.2.3-2 13:55:57 INFO - jsonschema == 2.5.1 13:55:57 INFO - manifestparser == 1.1 13:55:57 INFO - mozInstall == 1.12 13:55:57 INFO - mozcrash == 1.0 13:55:57 INFO - mozdebug == 0.1 13:55:57 INFO - mozdevice == 0.49 13:55:57 INFO - mozfile == 1.2 13:55:57 INFO - mozhttpd == 0.7 13:55:57 INFO - mozinfo == 0.9 13:55:57 INFO - mozleak == 0.1 13:55:57 INFO - mozlog == 3.4 13:55:57 INFO - moznetwork == 0.27 13:55:57 INFO - mozprocess == 0.23 13:55:57 INFO - mozprofile == 0.28 13:55:57 INFO - mozrunner == 6.13 13:55:57 INFO - mozscreenshot == 0.1 13:55:57 INFO - mozsystemmonitor == 0.3 13:55:57 INFO - moztest == 0.7 13:55:57 INFO - mozversion == 1.4 13:55:57 INFO - psutil == 3.1.1 13:55:57 INFO - requests == 1.2.3 13:55:57 INFO - wsgiref == 0.1.2 13:55:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:55:57 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')]} 13:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:57 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')]} 13:55:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:58 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 0x10ce16b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce19768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb153d71880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbf4d30>, '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 0x10cb1bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbe9be8>, '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.TiolayNXGd/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.lddQaDqBIH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 13:55:58 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 13:55:58 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 13:55:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TiolayNXGd/Render', 13:55:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:55:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:55:58 INFO - 'HOME': '/Users/cltbld', 13:55:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:55:58 INFO - 'LOGNAME': 'cltbld', 13:55:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:58 INFO - 'MOZ_NO_REMOTE': '1', 13:55:58 INFO - 'NO_EM_RESTART': '1', 13:55:58 INFO - 'PAGER': '/bin/cat', 13:55:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:55:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:58 INFO - 'PWD': '/builds/slave/test', 13:55:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:55:58 INFO - 'SHELL': '/bin/bash', 13:55:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lddQaDqBIH/Listeners', 13:55:58 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 13:55:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:55:58 INFO - 'USER': 'cltbld', 13:55:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:55:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:55:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:58 INFO - 'XPC_FLAGS': '0x0', 13:55:58 INFO - 'XPC_SERVICE_NAME': '0', 13:55:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:55:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:58 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)) 13:55:58 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)) 13:55:58 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)) 13:55:58 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)) 13:55:58 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)) 13:55:58 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)) 13:55:58 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)) 13:55:58 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)) 13:55:58 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)) 13:55:58 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)) 13:55:58 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)) 13:55:58 INFO - Cleaning up... 13:55:58 INFO - Return code: 0 13:55:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:55: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')]} 13:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55: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')]} 13:55:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:59 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 0x10ce16b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce19768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb153d71880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbf4d30>, '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 0x10cb1bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbe9be8>, '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.TiolayNXGd/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.lddQaDqBIH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 13:55:59 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 13:55:59 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 13:55:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TiolayNXGd/Render', 13:55:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:55:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:55:59 INFO - 'HOME': '/Users/cltbld', 13:55:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:55:59 INFO - 'LOGNAME': 'cltbld', 13:55:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:59 INFO - 'MOZ_NO_REMOTE': '1', 13:55:59 INFO - 'NO_EM_RESTART': '1', 13:55:59 INFO - 'PAGER': '/bin/cat', 13:55:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:55:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:59 INFO - 'PWD': '/builds/slave/test', 13:55:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:55:59 INFO - 'SHELL': '/bin/bash', 13:55:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lddQaDqBIH/Listeners', 13:55:59 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 13:55:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:55:59 INFO - 'USER': 'cltbld', 13:55:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:55:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:55:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:59 INFO - 'XPC_FLAGS': '0x0', 13:55:59 INFO - 'XPC_SERVICE_NAME': '0', 13:55:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:55:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:55:59 INFO - Cleaning up... 13:55:59 INFO - Return code: 0 13:55:59 INFO - Running post-action listener: _resource_record_post_action 13:55:59 INFO - Running post-action listener: _start_resource_monitoring 13:55:59 INFO - Starting resource monitoring. 13:55:59 INFO - [mozharness: 2016-12-19 21:55:59.574531Z] Finished create-virtualenv step (success) 13:55:59 INFO - [mozharness: 2016-12-19 21:55:59.575562Z] Running install step. 13:55:59 INFO - Running pre-action listener: _resource_record_pre_action 13:55:59 INFO - Running main action method: install 13:55:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:55:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:55:59 INFO - Reading from file tmpfile_stdout 13:55:59 INFO - Detecting whether we're running mozinstall >=1.0... 13:55:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:55:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:55:59 INFO - Reading from file tmpfile_stdout 13:55:59 INFO - Output received: 13:55:59 INFO - Usage: mozinstall [options] installer 13:55:59 INFO - Options: 13:55:59 INFO - -h, --help show this help message and exit 13:55:59 INFO - -d DEST, --destination=DEST 13:55:59 INFO - Directory to install application into. [default: 13:55:59 INFO - "/builds/slave/test"] 13:55:59 INFO - --app=APP Application being installed. [default: firefox] 13:55:59 INFO - mkdir: /builds/slave/test/build/application 13:55:59 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'] 13:55:59 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 13:56:22 INFO - Reading from file tmpfile_stdout 13:56:22 INFO - Output received: 13:56:22 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:56:22 INFO - Running post-action listener: _resource_record_post_action 13:56:22 INFO - [mozharness: 2016-12-19 21:56:22.295246Z] Finished install step (success) 13:56:22 INFO - [mozharness: 2016-12-19 21:56:22.295412Z] Running run-tests step. 13:56:22 INFO - Running pre-action listener: _resource_record_pre_action 13:56:22 INFO - Running main action method: run_tests 13:56:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:56:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:56:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:56:22 INFO - 2016-12-19 13:56:22.310 screenresolution[1952:10713] starting screenresolution argv=screenresolution get 13:56:22 INFO - 2016-12-19 13:56:22.313 screenresolution[1952:10713] Display 0: 1600x1200x32@60 13:56:22 INFO - 2016-12-19 13:56:22.319 screenresolution[1953:10715] starting screenresolution argv=screenresolution list 13:56:22 INFO - Available Modes on Display 0 13:56:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:56:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:56:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:56:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:56:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:56:22 INFO - Intel Iris: 13:56:22 INFO - Chipset Model: Intel Iris 13:56:22 INFO - Type: GPU 13:56:22 INFO - Bus: Built-In 13:56:22 INFO - VRAM (Dynamic, Max): 1536 MB 13:56:22 INFO - Vendor: Intel (0x8086) 13:56:22 INFO - Device ID: 0x0a2e 13:56:22 INFO - Revision ID: 0x0009 13:56:22 INFO - Displays: 13:56:22 INFO - Display: 13:56:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:56:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:56:22 INFO - Display Serial Number: 1600x1200 60 13:56:22 INFO - Main Display: Yes 13:56:22 INFO - Mirror: Off 13:56:22 INFO - Online: Yes 13:56:22 INFO - Rotation: Supported 13:56:22 INFO - Return code: 0 13:56:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:56:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:56:22 INFO - Python 2.7.3 13:56:22 INFO - Return code: 0 13:56:22 INFO - grabbing minidump binary from tooltool 13:56:22 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')]} 13:56:22 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 0x10cbf4d30>, '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 0x10cb1bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbe9be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:56:22 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 13:56:22 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 13:56:22 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 13:56:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:56:22 INFO - Return code: 0 13:56:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:56:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:56:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:56:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:56:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:56:22 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/aXEeZ5t6TMG3KYq44UfISQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0261', '--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 13:56:22 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/aXEeZ5t6TMG3KYq44UfISQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0261 --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 13:56:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TiolayNXGd/Render', 13:56:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:56:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:56:22 INFO - 'HOME': '/Users/cltbld', 13:56:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:56:22 INFO - 'LOGNAME': 'cltbld', 13:56:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:56:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:56:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:22 INFO - 'MOZ_NO_REMOTE': '1', 13:56:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:56:22 INFO - 'NO_EM_RESTART': '1', 13:56:22 INFO - 'PAGER': '/bin/cat', 13:56:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:56:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:22 INFO - 'PWD': '/builds/slave/test', 13:56:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:56:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:56:22 INFO - 'SHELL': '/bin/bash', 13:56:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lddQaDqBIH/Listeners', 13:56:22 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 13:56:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:56:22 INFO - 'USER': 'cltbld', 13:56:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:56:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:56:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:22 INFO - 'XPC_FLAGS': '0x0', 13:56:22 INFO - 'XPC_SERVICE_NAME': '0', 13:56:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:56:22 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/aXEeZ5t6TMG3KYq44UfISQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0261', '--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 13:56:22 INFO - mozversion application_buildid: 20161219123723 13:56:22 INFO - mozversion application_changeset: 39d87131faa0ceabba4e740dc80bc58dae52e24d 13:56:22 INFO - mozversion application_display_name: Nightly 13:56:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:56:22 INFO - mozversion application_name: Firefox 13:56:22 INFO - mozversion application_remotingname: firefox 13:56:22 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 13:56:22 INFO - mozversion application_vendor: Mozilla 13:56:22 INFO - mozversion application_version: 53.0a1 13:56:22 INFO - mozversion platform_buildid: 20161219123723 13:56:22 INFO - mozversion platform_changeset: 39d87131faa0ceabba4e740dc80bc58dae52e24d 13:56:22 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 13:56:22 INFO - mozversion platform_version: 53.0a1 13:56:22 INFO - using testdate: 1482184582 13:56:22 INFO - actual date: 1482184582 13:56:22 INFO - starting webserver on 'localhost:49347' 13:56:22 INFO - SUITE-START | Running 2 tests 13:56:22 INFO - TEST-START | dromaeo_css 13:56:22 INFO - operating with platform_type : mac_ 13:56:22 INFO - Initialising browser for dromaeo_css test... 13:56:22 INFO - TEST-INFO | started process 1963 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/tmpI1U8T8/profile http://localhost:49347/getInfo.html) 13:56:25 INFO - PROCESS | 1963 | __metrics Screen width/height:1600/1200 13:56:25 INFO - PROCESS | 1963 | colorDepth:24 13:56:25 INFO - PROCESS | 1963 | Browser inner width/height: 1024/689 13:56:25 INFO - PROCESS | 1963 | __metrics 13:56:25 INFO - PROCESS | 1963 | 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" 13:56:25 INFO - PROCESS | 1963 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:56:26 INFO - TEST-INFO | 1963: exit 0 13:56:26 INFO - Browser initialized. 13:56:26 INFO - Running cycle 1/1 for dromaeo_css test... 13:56:26 INFO - TEST-INFO | started process 1965 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/tmpI1U8T8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:56:38 INFO - PROCESS | 1965 | RSS: Main: 237330432 13:56:38 INFO - PROCESS | 1965 | 13:57:30 INFO - PROCESS | 1965 | 1482184650355 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 13:59:42 INFO - PROCESS | 1965 | Cycle 1(1): loaded http://localhost:49347/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49347/tests/dromaeo/cssquery-ext.html) 13:59:44 INFO - PROCESS | 1965 | RSS: Main: 398827520 13:59:44 INFO - PROCESS | 1965 | 14:02:47 INFO - PROCESS | 1965 | Cycle 1(1): loaded http://localhost:49347/tests/dromaeo/cssquery-ext.html (next: http://localhost:49347/tests/dromaeo/cssquery-jquery.html) 14:02:47 INFO - PROCESS | 1965 | RSS: Main: 375205888 14:02:47 INFO - PROCESS | 1965 | 14:05:50 INFO - PROCESS | 1965 | Cycle 1(1): loaded http://localhost:49347/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49347/tests/dromaeo/cssquery-mootools.html) 14:05:50 INFO - PROCESS | 1965 | RSS: Main: 359497728 14:05:50 INFO - PROCESS | 1965 | 14:08:53 INFO - PROCESS | 1965 | Cycle 1(1): loaded http://localhost:49347/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49347/tests/dromaeo/cssquery-prototype.html) 14:08:54 INFO - PROCESS | 1965 | RSS: Main: 356057088 14:08:54 INFO - PROCESS | 1965 | 14:11:57 INFO - PROCESS | 1965 | Cycle 1(1): loaded http://localhost:49347/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49347/tests/dromaeo/cssquery-yui.html) 14:11:58 INFO - PROCESS | 1965 | RSS: Main: 338268160 14:11:58 INFO - PROCESS | 1965 | 14:15:01 INFO - PROCESS | 1965 | Cycle 1(1): loaded http://localhost:49347/tests/dromaeo/cssquery-yui.html (next: http://localhost:49347/tests/dromaeo/cssquery-dojo.html) 14:15:01 INFO - PROCESS | 1965 | RSS: Main: 437813248 14:15:01 INFO - PROCESS | 1965 | 14:15:01 INFO - PROCESS | 1965 | __start_tp_report 14:15:01 INFO - PROCESS | 1965 | _x_x_mozilla_page_load 14:15:01 INFO - PROCESS | 1965 | _x_x_mozilla_page_load_details 14:15:01 INFO - PROCESS | 1965 | |i|pagename|runs| 14:15:01 INFO - PROCESS | 1965 | |0;dojo.html;3253.4469140246156;3263.787853789505;3274.3778682050415;3283.195617073816;3351.547541081953;5503.834884953448;5567.916481252784;5594.916076258854;5690.9715451422735;5705.0871860502275;5611.961787069395;5632.464915832989;5696.601237913348;5707.343655479621;5749.770009199627;4795.616350691954;5066.670666406671;5127;5163.432022477525;5164.380274367081;5184.688918664873;5234.084035293828;5234.8691282717855;5256.92114618281;5279.788808447657;5080.644354895159;5190.143626301656;5222.582193424555;5248.317718696564;5291.100512912814;5081.923771143436;5082.440931497569;5124.795008199705;5132;5139.408967968694;5046.974765126188;5087.516685914869;5102.285680004802;5115.590752739772;5151.948480515184;5566.35986861508;5620.185073164368;5629;5631.521320687746;5652.830415087513;5950.702464876739;6015.939840601582;6016.639001659914;6089.939100608982;6118.847028824315;6111;6130.826205142237;6142.621558143048;6147.801178770142;6148.7087711580625;4725.314829349725;5567.276254086943;5636.661800291996;5702.885942281214;5736.6558006519745;6226.688665566794;6262;6274.749010039639;6284.371562843679;6286.591371560834;6080.14877917092;6088.847778805565;6097.359777223416;6100.450959413674;6109.725062372115;6018.8194354169445;6091.817245482643;6098.573099882966;6108.198106408921;6193.752249910043;6098.847528811815;6101.095933926299;6127.864175486541;6136.648568731431;6136.888284849073;6131.50947924165;6145.262568491809;6165.9826128689165;6174.228221472316;6176.444120029129;4778.307145463888;4828.493008234155;4874.390701162355;4887.584555312767;4916.557509824133;4333.046729719456;4340.717853339523;4362.541933097043;4362.76004819738;4398.868033958986;4726.62187025044;5690.487856092889;5704.172894930211;5711.086226203787;5725.971370143123;6200.100985357098;6229.283632382243;6234.532410069263;6234.937650623436;6238.625682459067;5469.07025805614;5480.588955828329;5517.227588137664;5565.693886836182;5585.581081418829;5296.788128474818;5301.840944771663;5312.468753124656;5367.865803354947;5381.354237491448;6263.123162757218;6268.153799237136;6270.278917924497;6378.138951241523;6419.069234960811;6018.883161683278;6181.35095814933;6217.285012223652;6226.128342032029;6231.781887633911;6134.099846298167;6136.509079273558;6195.2875419325555;6246.625202487865;6274.152989346379;5816;5818.534517238695;5833.708314584339;5834.766609335579;5867.794627188028;5788.102844059177;5840.532757379485;5848.912266316093;5948.405159484017;5964.194833697396;5751.913721294268;5756;5786.3056433228285;5847.912281315698;5867.20792692981;5941.31674857397;5986;5992.910106348496;6033.909491357545;6093.756249750138;5870.324912635102;5876.294844618673;5884.32330282023;5886.882262354643;5888.793892213752;5766.567507437043;6017.729202185825;6044.7279872406725;6054.0918862169265;6055.969720151371;5723.313202415737;5744.396838332083;5785.652860828363;5790.7973220937065;5793.102069179284 14:15:01 INFO - PROCESS | 1965 | |1;ext.html;425.2473122573046;482.17547992932083;493.7407860873041;496.69949680443307;499.04183966783773;29648;31122;31160.53259201114;31162.532562011587;31171.376572468536;31641.683583164162;32317.51523727146;39655.405168922414;40896.77309680707;41061.794691026575;9253.583588738524;9438.056194380575;9449.905500944971;9454.81090378192;9467.384619999679;9353.438793672402;9480.004599517055;9487.193588544947;9488.240940724725;9496.477693726842;8419.621117049717;8610.741677749678;9490.05099490049;10989.340639561611;11255.887441125566;11075.335479871233;11145;11235.775284494264;11242;11265.042471389941;10768.3538987661;10835.566577336896;10840.403777792219;10861.40262285574;10863.348199107999;30083.548746768814;30645;37929.81035094807;38216;38342.84971450861;3154.652739016008;3187.442197615408;3267.607887053545;3269.9509507357407;3722.664960153599;29288.267793305124;29492.967746128998;29704.851475742482;29884.35636040017;30050;3101.131683128705;3102.348506813572;3145.402373549018;3176;3230.16015835882;374090;374418;375414;376557;377188.99999999726;55485;55974.16038759422;55990;56020.15969760457;56072.71963640237;51369.486305136474;58594.41405585975;58699;58834.41165588289;58835;14551.199684017269;15164.772528412082;15393.153376564396;15399.23003849803;15449.768253476206;11944.64166075019;12017.87982120185;12024.879751202376;12034.277943323428;12039.157258991961;14099.647508812363;14981.951263411456;15077.396904123712;15098.698026039638;15277.694446111016;4816.77240946486;6806.7957961261245;6820.556663816836;7049.964750176319;7065.576065435987;900.7072701372081;961.624966263158;992.731962370156;992.9553170107363;1055.0241027050101;29130.854345728134;29137.56293655597;29692.406151876843;29760.702392976225;29861.55207671887;1042.3172821801732;1048.9824869876209;1050.6795427394718;1082.8538147350007;1162.4187906046977;12967.546135885388;15172.165530895907;15224.162671053198;15699;15881.52355429339;577134;585745;585781;585864;586030.1396986061;48708;49634.554816777774;56150;56256.718716406154;56257;1362.5776009436909;1368.2337890780996;1406.6975600245996;1418.1136789506559;1421.8933579981542;27369.86315068412;28799.56800648034;29584.852075739484;29604.407911842074;30663;39758.2048359037;48688.26967595418;48734.781630459525;48764.2685359727;48773;567389;567529;607444;621936;622887;22978.770212298332;23262.0695172198;23267.53464930658;23335.766642333358;23335.949882255678;39034.414483782195;39438;39653.80173099116;39814.402783958845;40501;33527.49708754322;33642;33915.830420847735;34087.65912340944;34505.654943450245;33427.83286083651;34088;34173.31653366869;34368.312633747686;34661.6135354583;33038.83480582582;33575.49636755402;33671.494927575615;33828.3234335307;33853.3229335407;25661.871690641427;28668.283292917844;30152.84923575368;30403.39193216079;30472.542911856784;18340.449786506426;22819.429514262276;22843.771562284164;23087.845607719883;23314.533709326057 14:15:01 INFO - PROCESS | 1965 | |2;jquery.html;324.5326729509507;351.2097779995011;366.50704802041247;372.72604635592836;399.5145897734254;11679.649610511688;14635.19506427146;15494.84505154948;16971;19805.108770105344;16265.918670406661;18838.905805470953;19877.006149692494;20136;20147;5548;5890.998530249846;5895.646261224319;5895.823125306226;5901.586888917777;4210.894727631803;5723.742431590567;5831.737571809257;6352.364763523634;6412;6381.329960354165;6415.807525774211;6416.45460135889;6418.261899881527;6425.22897252328;6135.631862088267;6344.794489047089;6414.069959855795;6424.935750642528;6444.033394990789;5312.362516498045;5477.67133971963;5576.219329293902;5578.497935185812;5594.160875868612;24214.757852421426;24520.754792452204;24735.752642473526;24787.504249914902;24954.87703053367;2084.937451876446;2269.7730226977337;2479.85120892747;2652.655154829879;2783.9025634102914;14442.277886105652;14625.12249265037;14808.629784255372;15233;15364.00133991287;1719.6302794899032;1721.8707356407394;1810.4025671528495;1815.2664205683673;1911.350140952083;59038;97941.51029244879;98339.50830245802;99194;99242.50378748133;10030.699079027641;10124.493775311204;10207.693769186937;10517.21120915919;10655.89344106549;10682.78634427307;13010.54463093806;13032.348382580833;13032.609021729364;13053.543125990735;7285.797843355787;7347.595882226529;7734.2265773422205;7754.798006309031;7936.206379362133;8263.793405164919;8286.047104582929;8290.792730181673;8433.030201526903;8462.534560599226;6195.566310358322;6303.684815759286;6371.33101024395;6380.936190638127;6528.575642583217;1756.8682348823888;1796.4520821149674;1796.6015369481627;1800.5948661551047;1802.342145117049;786.3355464632376;919.8620206969008;921.2077613252598;924.2975338742469;959.5681943125621;20447.59104817925;20791.792082078984;21112;21131.788682112983;21276.57446851085;939.9483028433365;974.668612671695;986.3588667366126;1022.0478885328986;1046.3355769086534;7898.763037108896;9028.729138125867;10880;11168.218224724355;11174.44127793607;481328;490911;495028;495769;507412;74496;83619.5819020901;92115;106975.46512267545;111582;928.215657769184;949.2690628216372;1019.6482213636284;1019.938803671782;1021.7139201023725;18861.339853105077;18961;19005.714914276574;19051.856888586728;19103.331383401513;35391.646083538835;46834.531654683014;47767.522324777696;47782.283265751736;49108.263376050105;66734;67502.64994700177;68162.63674726577;68376;68829;7483.513571617827;7585.6965721372735;7596.235247248511;7653.732119375795;7810.531368117931;12400.81398779037;12473.5010599575;12665.240085594894;12671.87328126707;12781.488740450277;9710.417374957526;10729.195310351599;10973.670789876316;11184.049355804522;11273.661790146309;8570.442921210102;9379.906200937903;10071.093601575893;10556.208284378548;10860.402677852793;10988.230823842574;11038.613648522263;11245.662630121109;11303.717407064889;11313.830292545454;7542.547447153188;7780.766577002699;7787.06555213378;7932.56370899583;7936.682532698627;10643.840342394715;10806.837897431702;11169.72075698114;11181.993620574187;11199.552017919192 14:15:01 INFO - PROCESS | 1965 | |3;mootools.html;1521.9923900380497;1559.766035094736;1806.259433632211;1938.050355325889;1975.3678822776699;8187.467814592047;8602.784930376743;8637.611307491163;8648.524331161783;8648.610812513436;7079.433645308376;7539.132999705022;7864.68541258349;8176.22325879042;8470.280026197765;2313.699219101519;2357.787799098081;2360.3862995621175;2360.5278944211227;2362.492064206195;2346.249200255919;2361.079179120136;2386.832921695482;2392.210570511727;2405.3505553500545;2077.9480512987143;2155.6550951847707;2245;2318.6522021696796;2321.2688003278913;2318.5710643530915;2325.2094287942014;2349.565330413879;2350.1891847312822;2355.2580937004873;2349.612313968193;2377.8811059446957;2384.701912260967;2384.8449850759644;2388.10446082719;8266.586670666442;8492.278156356717;8494.490330580185;8511;8515.74452766418;5066.898662026776;5226.634135610509;5233.188855727369;5236.162214045735;5250.422453530108;3170.239142605781;3278.541004259406;3397.3884700753856;3433.1760377509218;3437.9828100859586;971.3491960386488;986.2110311750571;996.8654231678703;1014.06705830636;1019.7807471393686;10440.373577585293;10729;10731.570737170503;10971.01260886524;11146.832797508045;4303.698741088157;4329.415528903621;4509.932351014738;4517.435320584927;4517.841875534341;7426;8798.29613630908;8806.471611703319;8808.735737927873;8813.47119172839;5064.18972964324;5156.04613146569;5157.226416037624;5159;5168.095583272912;4621.95378046222;4803.543663351976;4811.27830825372;4822.469528351879;4824.204006338985;3522.348365552381;3540.291941611688;3572.3212589607892;3610.3140403323287;3620.818959052037;1052.1109662335314;1108.5177947592822;1114.331401159298;1124.8368986496912;1126.7295848996182;777.3314949143731;778.0044186661196;903.2006674093343;921.6083164654995;983.7737320416201;5643.604947653707;5716.256886604715;5836.1245813127525;5847.152162936351;6025.186599809057;806.5281810141016;901.9052999435096;908.4912449028565;916.093067862811;941.6704153546204;3784.243151369737;3803.391457366808;3853.152306492623;3904.4533765272886;3925.4700615417123;10038.447885366375;10301.793964120676;10392.42841643717;10414.271001029856;10429.9478502607;9883.590161394308;10367.0151335623;10380.636677716244;10384.961503849705;10388.013138751807;7732.381409487228;8018.799530011796;8036.4776289541;8042.758717238609;8049.074356448966;4863.756812159307;5530.336359636869;5537.390887002507;5547.472990065938;5667.1782591524825;7858.882116768367;9379.202767764817;9408.294377921546;9513.714588562354;9644.276679249224;7437.962810185914;9436.150746432853;9478.620855165991;9562.617495300388;9683.951580242054;6677.432418244503;6742.6628668567355;6749.49378796602;6752.426043786333;6760.898586521304;6702.262751097278;7603.695852165852;7865.803354915944;7891.487053341514;8085;7056.364927156375;7211.8557628848175;7227.963860180876;7288.453365997678;7394.889076663747;7117.217106118426;7144.749933752294;7146.678399471933;7184.245654206233;7233.276672332725;6741;6753.3921947025;6774.085498457645;6832.555883867532;6848.486363522656;3550.55618047744;4848.490908454562;4863.7324947128245;4883.560479556715;5016.473270306711;3572.499850020947;4722.858314250578;4871.805127794849;4897.314375987436;5044.54599086084 14:15:01 INFO - PROCESS | 1965 | |4;prototype.html;349.52464648078615;353.2669710351021;359.54158447978824;372.71673528118623;372.7651579504913;4851.345068415762;4939.654224204307;5165.741712914353;5192.481646401497;5205.947940520594;4682.969746655739;4693.741844198567;5092.516210959953;5106.208537676657;5224.843254702365;3504.456809194579;3998.9200215995807;4081.1837632473475;4084.9183016339657;4119.979400102995;3551.236484155906;3965.6430921217084;4091.7954102294766;4128.195001974616;4128.761371588526;3701.4077747560395;3800.429935509668;3879.1078052047906;3979.343408337621;4079.1637714268504;3761.592580748323;4018.5579586245344;4066.7763273019973;4066.877993660195;4089.5297040840387;3204.875246634536;3601.333753255656;3607;3628.6008539060945;3633.8728144514816;4943.258511223309;5108.463611320833;5127.359080114986;5131.255967884673;5186.766595503173;4467.664925130628;4654.464736555272;4686.336350595524;4713.929291060636;4723.551262630044;5422.15956526739;5448.128299472105;5450.5367043801325;5455.918161227585;5467.753951072212;3659.7621154624862;3734.402495600718;3784.9432258516144;3944.5660977292473;3986.2824691555506;5053.444121146671;5263.421023687391;5760.0783874579865;5772.682502462405;5775.451332123442;3556.76881002734;4068.145689405258;4085.080856807195;4091.3249313863475;4106.527749308808;3326.850291736878;3464.7401444891734;3680.2455496623666;3878.650921417086;4150.584941505826;4000.979995100006;4597.494275629678;4618.376519169936;4618.95381046192;4636.44362676481;5442.401335853053;5459.426760190123;5476.67139971603;5486.3690675572025;5503.504684578327;1130.5421304371744;1238.7646347194004;1266.8479782426168;1271.554955765493;1282.569934523;801.8957535520461;822.0998007182126;917.4862077236769;958.3291695812959;959.6545243712258;4219.852305169305;4468.720952314343;4796.688215265996;4842.297866809293;4858.927116093261;4549.45406551216;4899.510048995072;4939.678920870132;5140.4554745401265;5335.706536140472;4536.797748596625;5014.749262536859;5159.509846564571;5164.269969560164;5168.457311982263;2371.312319427381;2387.617981123047;2497.8501289922665;2755.61421401004;2760.4755096531994;5157.561607263349;5183.974080129575;5336;5519.448055194448;5556.249906262684;5752.108423194411;5779.739911703983;5835.212246346774;5851.236532015961;5892.292924849045;5041.168207245837;5856.472917437451;5874.94125058744;5910.231669882888;5942.197803296586;4597.93103103447;5507.394186639386;5507.5593952484505;5636.196417146473;5653.547716182613;5559.832435188656;5561.41394251675;5597.888042239051;5598.752723420488;5660.264225611077;5545.528630066328;5576.609637325349;5813.79651712188;5847.678377689268;5853.653659658217;3068.6624471308583;3200.4079245339685;3359.3785149747373;3784.4701741756726;3784.508013958168;5350.170723537858;5568.470995255444;5617.5505959522325;5619.775208991595;5659.518940890071;4339.435873336446;4867.80528778859;5112.897742045064;5505.449455054462;5575.9163612545035;4387.210302145644;4868.391451068616;5444.243472004305;5523.944760552343;5545.639533430314;5189.8202754842305;5255.081895108335;5342.599305052059;5365.09539113609;5414.35027796667;4753.5008824072975;5258.8159414420315;5438.048341540136;5448.782048718165;5452.509274165185;4730.905381892412;5165.819196328111;5312.203169524602;5326.191772882407;5335.386430560535 14:15:01 INFO - PROCESS | 1965 | |5;yui.html;700.6391708270245;710.3855165282033;711.7508871894837;729.3071581997104;755.4900442201513;14398.49605263816;14412.207328596924;14983.175925324103;15005.92497037516;15191;13446.462141514328;13498.392572334244;13839.377228024738;13873.959453041038;13876.444942202324;846.1834329871673;874.0516539554591;875.9080296568864;876.7545087375545;876.8860048193726;690.9930900691004;713.4185638704465;718.1561665043553;793.3217099380033;875.1860769484377;890.8975467821186;936.3773090894547;939.1125386509751;939.1500691873865;939.3518472254157;930.3627015494408;930.8091841172543;931.1014870649822;932.324065052838;933.1788026536605;526.765589312756;543.6194663735401;546.6556069676078;547.0317537957792;691.0015028284131;12202.755944881053;13646.590602281947;14215.50245741394;14266.857331426656;14548.563543093724;11472.94263528677;14074.648133796634;14103.576892693236;14161.645958851008;14184;11365.943170284096;11434.885651143466;11563.248388854781;11607.825882611767;11636;3628.256207477461;3680.7423480356388;3708.8331025103935;3720.255948810249;3812.8856134316015;89761.65357519643;95846.12461626163;101925.45186370252;104220;106976.46511767391;10819.513121909533;10892;10970.122390208764;10983.890161098287;11243.044341230923;21913;22161.556768864855;22186.44533886666;22309.996050177782;22430.439239019153;7722.961385193038;7735.9613201933635;7736.922630773733;7759.961200193963;8011.919880801117;4214.367844823301;4304.4834619845815;4304.80628371724;4308.138372325548;4460.598546130864;3323.8171900545703;3383.7123844473003;3390;3425;3428.074419906661;602.1088788592907;604.9818505444844;605.9091136329586;612.6354818882758;623.03118650498;547.2475346398702;566.6430149006183;582.5630776917312;606.6814922165898;606.9059295809157;8656.13438656142;9325.067493250757;9351.158395744416;9431.905680943102;9498.382605130644;582.7057336045355;646.2632598837329;654.554902666182;658.706875440434;669.8325418645338;3579.266250418658;3732.2908647356917;3783.9243215135543;3788.3938569828697;3802.1825307558456;95146;98345.50827245961;100179.99820001707;101386;104000.95999040065;73794.6310268456;80182.19817801865;89920.10079899117;90612.5469372662;91189.08810911806;61114;72952.90570641444;76476.47047059139;77330.62709966379;78497.21502785127;7777.766666999999;7806.804829879298;7866.254827786116;8050.114487406264;8106.79733006656;43079;50467;51431.74284128555;52428.21357679561;52774.208386875;69744;70554.29445705477;71042.57914841778;71634.64182679054;73153;11116.221864469733;11130.16523760705;11247.887521124683;11249.417757648123;11270.436478175894;11465.713357165803;11752.059835213333;12069;12220.450079746255;12824.743505130033;10073.899261007296;11485.138614603771;11647.767044658889;11654.533818647498;11903.46434410471;10996.725081873017;11023.503942322453;11625.418729063344;11675.241109328206;11807.291562506278;11328.773424531628;11778.705532361759;11952.521899123938;12291.50833966667;12333.075019373404;9238.935227680899;9247.815043698954;9267.907320926704;9353.345265831598;9815.705528834147;9865.704028879145;9900.059494348025;10007.431013759913;10166.237532185263;10193.133583645473 14:15:01 INFO - PROCESS | 1965 | __end_tp_report 14:15:01 INFO - PROCESS | 1965 | __start_cc_report 14:15:01 INFO - PROCESS | 1965 | _x_x_mozilla_cycle_collect,1699 14:15:01 INFO - PROCESS | 1965 | __end_cc_report 14:15:01 INFO - PROCESS | 1965 | __startTimestamp1482185701883__endTimestamp 14:15:01 INFO - PROCESS | 1965 | 14:15:01 INFO - PROCESS | 1965 | ------- Summary: start ------- 14:15:01 INFO - PROCESS | 1965 | Number of tests: 6 14:15:01 INFO - PROCESS | 1965 | 14:15:01 INFO - PROCESS | 1965 | [#0] dojo.html Cycles:165 Average:5635.58 Median:5788.10 stddev:633.53 (10.9%) stddev-sans-first:607.29 14:15:01 INFO - PROCESS | 1965 | Values: 3253.4 3263.8 3274.4 3283.2 3351.5 5503.8 5567.9 5594.9 5691.0 5705.1 5612.0 5632.5 5696.6 5707.3 5749.8 4795.6 5066.7 5127.0 5163.4 5164.4 5184.7 5234.1 5234.9 5256.9 5279.8 5080.6 5190.1 5222.6 5248.3 5291.1 5081.9 5082.4 5124.8 5132.0 5139.4 5047.0 5087.5 5102.3 5115.6 5151.9 5566.4 5620.2 5629.0 5631.5 5652.8 5950.7 6015.9 6016.6 6089.9 6118.8 6111.0 6130.8 6142.6 6147.8 6148.7 4725.3 5567.3 5636.7 5702.9 5736.7 6226.7 6262.0 6274.7 6284.4 6286.6 6080.1 6088.8 6097.4 6100.5 6109.7 6018.8 6091.8 6098.6 6108.2 6193.8 6098.8 6101.1 6127.9 6136.6 6136.9 6131.5 6145.3 6166.0 6174.2 6176.4 4778.3 4828.5 4874.4 4887.6 4916.6 4333.0 4340.7 4362.5 4362.8 4398.9 4726.6 5690.5 5704.2 5711.1 5726.0 6200.1 6229.3 6234.5 6234.9 6238.6 5469.1 5480.6 5517.2 5565.7 5585.6 5296.8 5301.8 5312.5 5367.9 5381.4 6263.1 6268.2 6270.3 6378.1 6419.1 6018.9 6181.4 6217.3 6226.1 6231.8 6134.1 6136.5 6195.3 6246.6 6274.2 5816.0 5818.5 5833.7 5834.8 5867.8 5788.1 5840.5 5848.9 5948.4 5964.2 5751.9 5756.0 5786.3 5847.9 5867.2 5941.3 5986.0 5992.9 6033.9 6093.8 5870.3 5876.3 5884.3 5886.9 5888.8 5766.6 6017.7 6044.7 6054.1 6056.0 5723.3 5744.4 5785.7 5790.8 5793.1 14:15:01 INFO - PROCESS | 1965 | 14:15:01 INFO - PROCESS | 1965 | [#1] ext.html Cycles:180 Average:63956.59 Median:18154.39 stddev:141671.01 (780.4%) stddev-sans-first:141988.13 14:15:01 INFO - PROCESS | 1965 | Values: 425.2 482.2 493.7 496.7 499.0 29648.0 31122.0 31160.5 31162.5 31171.4 31641.7 32317.5 39655.4 40896.8 41061.8 9253.6 9438.1 9449.9 9454.8 9467.4 9353.4 9480.0 9487.2 9488.2 9496.5 8419.6 8610.7 9490.1 10989.3 11255.9 11075.3 11145.0 11235.8 11242.0 11265.0 10768.4 10835.6 10840.4 10861.4 10863.3 30083.5 30645.0 37929.8 38216.0 38342.8 3154.7 3187.4 3267.6 3270.0 3722.7 29288.3 29493.0 29704.9 29884.4 30050.0 3101.1 3102.3 3145.4 3176.0 3230.2 374090.0 374418.0 375414.0 376557.0 377189.0 55485.0 55974.2 55990.0 56020.2 56072.7 51369.5 58594.4 58699.0 58834.4 58835.0 14551.2 15164.8 15393.2 15399.2 15449.8 11944.6 12017.9 12024.9 12034.3 12039.2 14099.6 14982.0 15077.4 15098.7 15277.7 4816.8 6806.8 6820.6 7050.0 7065.6 900.7 961.6 992.7 993.0 1055.0 29130.9 29137.6 29692.4 29760.7 29861.6 1042.3 1049.0 1050.7 1082.9 1162.4 12967.5 15172.2 15224.2 15699.0 15881.5 577134.0 585745.0 585781.0 585864.0 586030.1 48708.0 49634.6 56150.0 56256.7 56257.0 1362.6 1368.2 1406.7 1418.1 1421.9 27369.9 28799.6 29584.9 29604.4 30663.0 39758.2 48688.3 48734.8 48764.3 48773.0 567389.0 567529.0 607444.0 621936.0 622887.0 22978.8 23262.1 23267.5 23335.8 23335.9 39034.4 39438.0 39653.8 39814.4 40501.0 33527.5 33642.0 33915.8 34087.7 34505.7 33427.8 34088.0 34173.3 34368.3 34661.6 33038.8 33575.5 33671.5 33828.3 33853.3 25661.9 28668.3 30152.8 30403.4 30472.5 18340.4 22819.4 22843.8 23087.8 23314.5 14:15:01 INFO - PROCESS | 1965 | 14:15:01 INFO - PROCESS | 1965 | [#2] jquery.html Cycles:180 Average:29758.86 Median:369.62 stddev:81911.73 (22161.3%) stddev-sans-first:82111.70 14:15:01 INFO - PROCESS | 1965 | Values: 324.5 351.2 366.5 372.7 399.5 11679.6 14635.2 15494.8 16971.0 19805.1 16265.9 18838.9 19877.0 20136.0 20147.0 5548.0 5891.0 5895.6 5895.8 5901.6 4210.9 5723.7 5831.7 6352.4 6412.0 6381.3 6415.8 6416.5 6418.3 6425.2 6135.6 6344.8 6414.1 6424.9 6444.0 5312.4 5477.7 5576.2 5578.5 5594.2 24214.8 24520.8 24735.8 24787.5 24954.9 2084.9 2269.8 2479.9 2652.7 2783.9 14442.3 14625.1 14808.6 15233.0 15364.0 1719.6 1721.9 1810.4 1815.3 1911.4 59038.0 97941.5 98339.5 99194.0 99242.5 10030.7 10124.5 10207.7 10517.2 10655.9 10682.8 13010.5 13032.3 13032.6 13053.5 7285.8 7347.6 7734.2 7754.8 7936.2 8263.8 8286.0 8290.8 8433.0 8462.5 6195.6 6303.7 6371.3 6380.9 6528.6 1756.9 1796.5 1796.6 1800.6 1802.3 786.3 919.9 921.2 924.3 959.6 20447.6 20791.8 21112.0 21131.8 21276.6 939.9 974.7 986.4 1022.0 1046.3 7898.8 9028.7 10880.0 11168.2 11174.4 481328.0 490911.0 495028.0 495769.0 507412.0 74496.0 83619.6 92115.0 106975.5 111582.0 928.2 949.3 1019.6 1019.9 1021.7 18861.3 18961.0 19005.7 19051.9 19103.3 35391.6 46834.5 47767.5 47782.3 49108.3 66734.0 67502.6 68162.6 68376.0 68829.0 7483.5 7585.7 7596.2 7653.7 7810.5 12400.8 12473.5 12665.2 12671.9 12781.5 9710.4 10729.2 10973.7 11184.0 11273.7 8570.4 9379.9 10071.1 10556.2 10860.4 10988.2 11038.6 11245.7 11303.7 11313.8 7542.5 7780.8 7787.1 7932.6 7936.7 10643.8 10806.8 11169.7 11182.0 11199.6 14:15:01 INFO - PROCESS | 1965 | 14:15:01 INFO - PROCESS | 1965 | [#3] mootools.html Cycles:180 Average:5408.23 Median:5158.11 stddev:2972.93 (57.6%) stddev-sans-first:2966.93 14:15:01 INFO - PROCESS | 1965 | Values: 1522.0 1559.8 1806.3 1938.1 1975.4 8187.5 8602.8 8637.6 8648.5 8648.6 7079.4 7539.1 7864.7 8176.2 8470.3 2313.7 2357.8 2360.4 2360.5 2362.5 2346.2 2361.1 2386.8 2392.2 2405.4 2077.9 2155.7 2245.0 2318.7 2321.3 2318.6 2325.2 2349.6 2350.2 2355.3 2349.6 2377.9 2384.7 2384.8 2388.1 8266.6 8492.3 8494.5 8511.0 8515.7 5066.9 5226.6 5233.2 5236.2 5250.4 3170.2 3278.5 3397.4 3433.2 3438.0 971.3 986.2 996.9 1014.1 1019.8 10440.4 10729.0 10731.6 10971.0 11146.8 4303.7 4329.4 4509.9 4517.4 4517.8 7426.0 8798.3 8806.5 8808.7 8813.5 5064.2 5156.0 5157.2 5159.0 5168.1 4622.0 4803.5 4811.3 4822.5 4824.2 3522.3 3540.3 3572.3 3610.3 3620.8 1052.1 1108.5 1114.3 1124.8 1126.7 777.3 778.0 903.2 921.6 983.8 5643.6 5716.3 5836.1 5847.2 6025.2 806.5 901.9 908.5 916.1 941.7 3784.2 3803.4 3853.2 3904.5 3925.5 10038.4 10301.8 10392.4 10414.3 10429.9 9883.6 10367.0 10380.6 10385.0 10388.0 7732.4 8018.8 8036.5 8042.8 8049.1 4863.8 5530.3 5537.4 5547.5 5667.2 7858.9 9379.2 9408.3 9513.7 9644.3 7438.0 9436.2 9478.6 9562.6 9684.0 6677.4 6742.7 6749.5 6752.4 6760.9 6702.3 7603.7 7865.8 7891.5 8085.0 7056.4 7211.9 7228.0 7288.5 7394.9 7117.2 7144.7 7146.7 7184.2 7233.3 6741.0 6753.4 6774.1 6832.6 6848.5 3550.6 4848.5 4863.7 4883.6 5016.5 3572.5 4722.9 4871.8 4897.3 5044.5 14:15:01 INFO - PROCESS | 1965 | 14:15:01 INFO - PROCESS | 1965 | [#4] prototype.html Cycles:180 Average:4440.04 Median:4979.00 stddev:1359.72 (27.3%) stddev-sans-first:1328.42 14:15:01 INFO - PROCESS | 1965 | Values: 349.5 353.3 359.5 372.7 372.8 4851.3 4939.7 5165.7 5192.5 5205.9 4683.0 4693.7 5092.5 5106.2 5224.8 3504.5 3998.9 4081.2 4084.9 4120.0 3551.2 3965.6 4091.8 4128.2 4128.8 3701.4 3800.4 3879.1 3979.3 4079.2 3761.6 4018.6 4066.8 4066.9 4089.5 3204.9 3601.3 3607.0 3628.6 3633.9 4943.3 5108.5 5127.4 5131.3 5186.8 4467.7 4654.5 4686.3 4713.9 4723.6 5422.2 5448.1 5450.5 5455.9 5467.8 3659.8 3734.4 3784.9 3944.6 3986.3 5053.4 5263.4 5760.1 5772.7 5775.5 3556.8 4068.1 4085.1 4091.3 4106.5 3326.9 3464.7 3680.2 3878.7 4150.6 4001.0 4597.5 4618.4 4619.0 4636.4 5442.4 5459.4 5476.7 5486.4 5503.5 1130.5 1238.8 1266.8 1271.6 1282.6 801.9 822.1 917.5 958.3 959.7 4219.9 4468.7 4796.7 4842.3 4858.9 4549.5 4899.5 4939.7 5140.5 5335.7 4536.8 5014.7 5159.5 5164.3 5168.5 2371.3 2387.6 2497.9 2755.6 2760.5 5157.6 5184.0 5336.0 5519.4 5556.2 5752.1 5779.7 5835.2 5851.2 5892.3 5041.2 5856.5 5874.9 5910.2 5942.2 4597.9 5507.4 5507.6 5636.2 5653.5 5559.8 5561.4 5597.9 5598.8 5660.3 5545.5 5576.6 5813.8 5847.7 5853.7 3068.7 3200.4 3359.4 3784.5 3784.5 5350.2 5568.5 5617.6 5619.8 5659.5 4339.4 4867.8 5112.9 5505.4 5575.9 4387.2 4868.4 5444.2 5523.9 5545.6 5189.8 5255.1 5342.6 5365.1 5414.4 4753.5 5258.8 5438.0 5448.8 5452.5 4730.9 5165.8 5312.2 5326.2 5335.4 14:15:01 INFO - PROCESS | 1965 | 14:15:01 INFO - PROCESS | 1965 | [#5] yui.html Cycles:180 Average:19554.23 Median:50949.37 stddev:28537.80 (56.0%) stddev-sans-first:28582.75 14:15:01 INFO - PROCESS | 1965 | Values: 700.6 710.4 711.8 729.3 755.5 14398.5 14412.2 14983.2 15005.9 15191.0 13446.5 13498.4 13839.4 13874.0 13876.4 846.2 874.1 875.9 876.8 876.9 691.0 713.4 718.2 793.3 875.2 890.9 936.4 939.1 939.2 939.4 930.4 930.8 931.1 932.3 933.2 526.8 543.6 546.7 547.0 691.0 12202.8 13646.6 14215.5 14266.9 14548.6 11472.9 14074.6 14103.6 14161.6 14184.0 11365.9 11434.9 11563.2 11607.8 11636.0 3628.3 3680.7 3708.8 3720.3 3812.9 89761.7 95846.1 101925.5 104220.0 106976.5 10819.5 10892.0 10970.1 10983.9 11243.0 21913.0 22161.6 22186.4 22310.0 22430.4 7723.0 7736.0 7736.9 7760.0 8011.9 4214.4 4304.5 4304.8 4308.1 4460.6 3323.8 3383.7 3390.0 3425.0 3428.1 602.1 605.0 605.9 612.6 623.0 547.2 566.6 582.6 606.7 606.9 8656.1 9325.1 9351.2 9431.9 9498.4 582.7 646.3 654.6 658.7 669.8 3579.3 3732.3 3783.9 3788.4 3802.2 95146.0 98345.5 100180.0 101386.0 104001.0 73794.6 80182.2 89920.1 90612.5 91189.1 61114.0 72952.9 76476.5 77330.6 78497.2 7777.8 7806.8 7866.3 8050.1 8106.8 43079.0 50467.0 51431.7 52428.2 52774.2 69744.0 70554.3 71042.6 71634.6 73153.0 11116.2 11130.2 11247.9 11249.4 11270.4 11465.7 11752.1 12069.0 12220.5 12824.7 10073.9 11485.1 11647.8 11654.5 11903.5 10996.7 11023.5 11625.4 11675.2 11807.3 11328.8 11778.7 11952.5 12291.5 12333.1 9238.9 9247.8 9267.9 9353.3 9815.7 9865.7 9900.1 10007.4 10166.2 10193.1 14:15:01 INFO - PROCESS | 1965 | -------- Summary: end -------- 14:15:01 INFO - PROCESS | 1965 | 14:15:02 INFO - TEST-INFO | 1965: exit 0 14:15:02 INFO - TEST-OK | dromaeo_css | took 1119623ms 14:15:02 INFO - TEST-START | kraken 14:15:02 INFO - operating with platform_type : mac_ 14:15:02 INFO - Initialising browser for kraken test... 14:15:02 INFO - TEST-INFO | started process 1968 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/tmppY1UhN/profile http://localhost:49347/getInfo.html) 14:15:04 INFO - PROCESS | 1968 | __metrics Screen width/height:1600/1200 14:15:04 INFO - PROCESS | 1968 | colorDepth:24 14:15:04 INFO - PROCESS | 1968 | Browser inner width/height: 1024/689 14:15:04 INFO - PROCESS | 1968 | __metrics 14:15:04 INFO - PROCESS | 1968 | 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" 14:15:04 INFO - PROCESS | 1968 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:15:05 INFO - TEST-INFO | 1968: exit 0 14:15:05 INFO - Browser initialized. 14:15:05 INFO - Running cycle 1/1 for kraken test... 14:15:05 INFO - TEST-INFO | started process 1969 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/tmppY1UhN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:15:17 INFO - PROCESS | 1969 | RSS: Main: 229838848 14:15:17 INFO - PROCESS | 1969 | 14:15:20 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49347/tests/kraken/driver.html?testName=audio-beat-detection) 14:15:21 INFO - PROCESS | 1969 | RSS: Main: 289828864 14:15:21 INFO - PROCESS | 1969 | 14:15:24 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49347/tests/kraken/driver.html?testName=audio-dft) 14:15:24 INFO - PROCESS | 1969 | RSS: Main: 292388864 14:15:24 INFO - PROCESS | 1969 | 14:15:28 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49347/tests/kraken/driver.html?testName=audio-fft) 14:15:28 INFO - PROCESS | 1969 | RSS: Main: 385056768 14:15:28 INFO - PROCESS | 1969 | 14:15:30 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49347/tests/kraken/driver.html?testName=audio-oscillator) 14:15:31 INFO - PROCESS | 1969 | RSS: Main: 287162368 14:15:31 INFO - PROCESS | 1969 | 14:15:33 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49347/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:15:33 INFO - PROCESS | 1969 | RSS: Main: 290406400 14:15:33 INFO - PROCESS | 1969 | 14:15:36 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49347/tests/kraken/driver.html?testName=imaging-darkroom) 14:15:37 INFO - PROCESS | 1969 | RSS: Main: 332550144 14:15:37 INFO - PROCESS | 1969 | 14:15:40 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49347/tests/kraken/driver.html?testName=imaging-desaturate) 14:15:41 INFO - PROCESS | 1969 | RSS: Main: 333721600 14:15:41 INFO - PROCESS | 1969 | 14:15:44 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49347/tests/kraken/driver.html?testName=json-parse-financial) 14:15:44 INFO - PROCESS | 1969 | RSS: Main: 330911744 14:15:44 INFO - PROCESS | 1969 | 14:15:46 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49347/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:15:47 INFO - PROCESS | 1969 | RSS: Main: 305778688 14:15:47 INFO - PROCESS | 1969 | 14:15:48 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49347/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:15:49 INFO - PROCESS | 1969 | RSS: Main: 313507840 14:15:49 INFO - PROCESS | 1969 | 14:15:51 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49347/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:15:52 INFO - PROCESS | 1969 | RSS: Main: 314261504 14:15:52 INFO - PROCESS | 1969 | 14:15:55 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49347/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:15:56 INFO - PROCESS | 1969 | RSS: Main: 331526144 14:15:56 INFO - PROCESS | 1969 | 14:15:59 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49347/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:15:59 INFO - PROCESS | 1969 | RSS: Main: 324968448 14:15:59 INFO - PROCESS | 1969 | 14:16:01 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:49347/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49347/tests/kraken/driver.html?testName=ai-astar) 14:16:01 INFO - PROCESS | 1969 | RSS: Main: 368988160 14:16:01 INFO - PROCESS | 1969 | 14:16:01 INFO - PROCESS | 1969 | __start_tp_report 14:16:01 INFO - PROCESS | 1969 | _x_x_mozilla_page_load 14:16:01 INFO - PROCESS | 1969 | _x_x_mozilla_page_load_details 14:16:01 INFO - PROCESS | 1969 | |i|pagename|runs| 14:16:01 INFO - PROCESS | 1969 | |0;ai-astar;103;111;114;113;113;114;111;113;113;114 14:16:01 INFO - PROCESS | 1969 | |1;audio-beat-detection;147;99;128;180;110;112;109;116;161;141 14:16:01 INFO - PROCESS | 1969 | |2;audio-dft;184;179;183;182;184;196;258;184;184;184 14:16:01 INFO - PROCESS | 1969 | |3;audio-fft;81;60;60;87;58;60;58;59;74;59 14:16:01 INFO - PROCESS | 1969 | |4;audio-oscillator;89;69;85;69;68;69;83;70;69;83 14:16:01 INFO - PROCESS | 1969 | |5;imaging-gaussian-blur;107;108;107;110;106;108;106;109;106;107 14:16:01 INFO - PROCESS | 1969 | |6;imaging-darkroom;93;107;151;94;134;152;94;111;151;95 14:16:01 INFO - PROCESS | 1969 | |7;imaging-desaturate;87;84;84;88;85;85;85;85;85;93 14:16:01 INFO - PROCESS | 1969 | |8;json-parse-financial;56;54;54;54;55;56;55;55;54;55 14:16:01 INFO - PROCESS | 1969 | |9;json-stringify-tinderbox;64;71;77;78;75;72;72;73;73;73 14:16:01 INFO - PROCESS | 1969 | |10;stanford-crypto-aes;88;88;88;87;90;100;106;108;89;88 14:16:01 INFO - PROCESS | 1969 | |11;stanford-crypto-ccm;143;144;133;144;147;147;150;141;186;145 14:16:01 INFO - PROCESS | 1969 | |12;stanford-crypto-pbkdf2;173;170;173;171;172;170;171;173;169;170 14:16:01 INFO - PROCESS | 1969 | |13;stanford-crypto-sha256-iterative;70;67;68;68;68;67;66;67;66;65 14:16:01 INFO - PROCESS | 1969 | __end_tp_report 14:16:01 INFO - PROCESS | 1969 | __start_cc_report 14:16:01 INFO - PROCESS | 1969 | _x_x_mozilla_cycle_collect,2093 14:16:01 INFO - PROCESS | 1969 | __end_cc_report 14:16:01 INFO - PROCESS | 1969 | __startTimestamp1482185761751__endTimestamp 14:16:01 INFO - PROCESS | 1969 | 14:16:01 INFO - PROCESS | 1969 | ------- Summary: start ------- 14:16:01 INFO - PROCESS | 1969 | Number of tests: 14 14:16:01 INFO - PROCESS | 1969 | 14:16:01 INFO - PROCESS | 1969 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:3.31 (2.9%) stddev-sans-first:1.17 14:16:01 INFO - PROCESS | 1969 | Values: 103.0 111.0 114.0 113.0 113.0 114.0 111.0 113.0 113.0 114.0 14:16:01 INFO - PROCESS | 1969 | 14:16:01 INFO - PROCESS | 1969 | [#1] audio-beat-detection Cycles:10 Average:130.30 Median:144.00 stddev:26.24 (18.2%) stddev-sans-first:27.13 14:16:01 INFO - PROCESS | 1969 | Values: 147.0 99.0 128.0 180.0 110.0 112.0 109.0 116.0 161.0 141.0 14:16:01 INFO - PROCESS | 1969 | 14:16:01 INFO - PROCESS | 1969 | [#2] audio-dft Cycles:10 Average:191.80 Median:184.00 stddev:23.67 (12.9%) stddev-sans-first:24.93 14:16:01 INFO - PROCESS | 1969 | Values: 184.0 179.0 183.0 182.0 184.0 196.0 258.0 184.0 184.0 184.0 14:16:01 INFO - PROCESS | 1969 | 14:16:01 INFO - PROCESS | 1969 | [#3] audio-fft Cycles:10 Average:65.60 Median:60.00 stddev:10.86 (18.1%) stddev-sans-first:9.99 14:16:01 INFO - PROCESS | 1969 | Values: 81.0 60.0 60.0 87.0 58.0 60.0 58.0 59.0 74.0 59.0 14:16:01 INFO - PROCESS | 1969 | 14:16:01 INFO - PROCESS | 1969 | [#4] audio-oscillator Cycles:10 Average:75.40 Median:76.50 stddev:8.44 (11.0%) stddev-sans-first:7.37 14:16:01 INFO - PROCESS | 1969 | Values: 89.0 69.0 85.0 69.0 68.0 69.0 83.0 70.0 69.0 83.0 14:16:01 INFO - PROCESS | 1969 | 14:16:01 INFO - PROCESS | 1969 | [#5] imaging-gaussian-blur Cycles:10 Average:107.40 Median:107.50 stddev:1.35 (1.3%) stddev-sans-first:1.42 14:16:01 INFO - PROCESS | 1969 | Values: 107.0 108.0 107.0 110.0 106.0 108.0 106.0 109.0 106.0 107.0 14:16:01 INFO - PROCESS | 1969 | 14:16:01 INFO - PROCESS | 1969 | [#6] imaging-darkroom Cycles:10 Average:118.20 Median:122.50 stddev:25.96 (21.2%) stddev-sans-first:25.88 14:16:01 INFO - PROCESS | 1969 | Values: 93.0 107.0 151.0 94.0 134.0 152.0 94.0 111.0 151.0 95.0 14:16:01 INFO - PROCESS | 1969 | 14:16:01 INFO - PROCESS | 1969 | [#7] imaging-desaturate Cycles:10 Average:86.10 Median:85.00 stddev:2.73 (3.2%) stddev-sans-first:2.87 14:16:01 INFO - PROCESS | 1969 | Values: 87.0 84.0 84.0 88.0 85.0 85.0 85.0 85.0 85.0 93.0 14:16:01 INFO - PROCESS | 1969 | 14:16:01 INFO - PROCESS | 1969 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:55.00 stddev:0.79 (1.4%) stddev-sans-first:0.71 14:16:01 INFO - PROCESS | 1969 | Values: 56.0 54.0 54.0 54.0 55.0 56.0 55.0 55.0 54.0 55.0 14:16:01 INFO - PROCESS | 1969 | 14:16:01 INFO - PROCESS | 1969 | [#9] json-stringify-tinderbox Cycles:10 Average:72.80 Median:73.00 stddev:3.82 (5.2%) stddev-sans-first:2.39 14:16:01 INFO - PROCESS | 1969 | Values: 64.0 71.0 77.0 78.0 75.0 72.0 72.0 73.0 73.0 73.0 14:16:01 INFO - PROCESS | 1969 | 14:16:01 INFO - PROCESS | 1969 | [#10] stanford-crypto-aes Cycles:10 Average:93.20 Median:88.00 stddev:8.19 (9.3%) stddev-sans-first:8.47 14:16:01 INFO - PROCESS | 1969 | Values: 88.0 88.0 88.0 87.0 90.0 100.0 106.0 108.0 89.0 88.0 14:16:01 INFO - PROCESS | 1969 | 14:16:01 INFO - PROCESS | 1969 | [#11] stanford-crypto-ccm Cycles:10 Average:148.00 Median:146.00 stddev:14.10 (9.7%) stddev-sans-first:14.84 14:16:01 INFO - PROCESS | 1969 | Values: 143.0 144.0 133.0 144.0 147.0 147.0 150.0 141.0 186.0 145.0 14:16:01 INFO - PROCESS | 1969 | 14:16:01 INFO - PROCESS | 1969 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.20 Median:171.50 stddev:1.48 (0.9%) stddev-sans-first:1.41 14:16:01 INFO - PROCESS | 1969 | Values: 173.0 170.0 173.0 171.0 172.0 170.0 171.0 173.0 169.0 170.0 14:16:01 INFO - PROCESS | 1969 | 14:16:01 INFO - PROCESS | 1969 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.50 stddev:1.40 (2.1%) stddev-sans-first:1.05 14:16:01 INFO - PROCESS | 1969 | Values: 70.0 67.0 68.0 68.0 68.0 67.0 66.0 67.0 66.0 65.0 14:16:01 INFO - PROCESS | 1969 | -------- Summary: end -------- 14:16:01 INFO - PROCESS | 1969 | 14:16:02 INFO - TEST-INFO | 1969: exit 0 14:16:02 INFO - TEST-OK | kraken | took 60109ms 14:16:02 INFO - SUITE-END | took 1179s 14:16:02 INFO - Completed test suite (00:19:40) 14:16:02 INFO - javascript benchmark 14:16:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3253.4469140246156, 3263.787853789505, 3274.3778682050415, 3283.195617073816, 3351.547541081953, 5503.834884953448, 5567.916481252784, 5594.916076258854, 5690.9715451422735, 5705.0871860502275, 5611.961787069395, 5632.464915832989, 5696.601237913348, 5707.343655479621, 5749.770009199627, 4795.616350691954, 5066.670666406671, 5127.0, 5163.432022477525, 5164.380274367081, 5184.688918664873, 5234.084035293828, 5234.8691282717855, 5256.92114618281, 5279.788808447657, 5080.644354895159, 5190.143626301656, 5222.582193424555, 5248.317718696564, 5291.100512912814, 5081.923771143436, 5082.440931497569, 5124.795008199705, 5132.0, 5139.408967968694, 5046.974765126188, 5087.516685914869, 5102.285680004802, 5115.590752739772, 5151.948480515184, 5566.35986861508, 5620.185073164368, 5629.0, 5631.521320687746, 5652.830415087513, 5950.702464876739, 6015.939840601582, 6016.639001659914, 6089.939100608982, 6118.847028824315, 6111.0, 6130.826205142237, 6142.621558143048, 6147.801178770142, 6148.7087711580625, 4725.314829349725, 5567.276254086943, 5636.661800291996, 5702.885942281214, 5736.6558006519745, 6226.688665566794, 6262.0, 6274.749010039639, 6284.371562843679, 6286.591371560834, 6080.14877917092, 6088.847778805565, 6097.359777223416, 6100.450959413674, 6109.725062372115, 6018.8194354169445, 6091.817245482643, 6098.573099882966, 6108.198106408921, 6193.752249910043, 6098.847528811815, 6101.095933926299, 6127.864175486541, 6136.648568731431, 6136.888284849073, 6131.50947924165, 6145.262568491809, 6165.9826128689165, 6174.228221472316, 6176.444120029129, 4778.307145463888, 4828.493008234155, 4874.390701162355, 4887.584555312767, 4916.557509824133, 4333.046729719456, 4340.717853339523, 4362.541933097043, 4362.76004819738, 4398.868033958986, 4726.62187025044, 5690.487856092889, 5704.172894930211, 5711.086226203787, 5725.971370143123, 6200.100985357098, 6229.283632382243, 6234.532410069263, 6234.937650623436, 6238.625682459067, 5469.07025805614, 5480.588955828329, 5517.227588137664, 5565.693886836182, 5585.581081418829, 5296.788128474818, 5301.840944771663, 5312.468753124656, 5367.865803354947, 5381.354237491448, 6263.123162757218, 6268.153799237136, 6270.278917924497, 6378.138951241523, 6419.069234960811, 6018.883161683278, 6181.35095814933, 6217.285012223652, 6226.128342032029, 6231.781887633911, 6134.099846298167, 6136.509079273558, 6195.2875419325555, 6246.625202487865, 6274.152989346379, 5816.0, 5818.534517238695, 5833.708314584339, 5834.766609335579, 5867.794627188028, 5788.102844059177, 5840.532757379485, 5848.912266316093, 5948.405159484017, 5964.194833697396, 5751.913721294268, 5756.0, 5786.3056433228285, 5847.912281315698, 5867.20792692981, 5941.31674857397, 5986.0, 5992.910106348496, 6033.909491357545, 6093.756249750138, 5870.324912635102, 5876.294844618673, 5884.32330282023, 5886.882262354643, 5888.793892213752, 5766.567507437043, 6017.729202185825, 6044.7279872406725, 6054.0918862169265, 6055.969720151371, 5723.313202415737, 5744.396838332083, 5785.652860828363, 5790.7973220937065, 5793.102069179284], "value": 5594.668617209746, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [425.2473122573046, 482.17547992932083, 493.7407860873041, 496.69949680443307, 499.04183966783773, 29648.0, 31122.0, 31160.53259201114, 31162.532562011587, 31171.376572468536, 31641.683583164162, 32317.51523727146, 39655.405168922414, 40896.77309680707, 41061.794691026575, 9253.583588738524, 9438.056194380575, 9449.905500944971, 9454.81090378192, 9467.384619999679, 9353.438793672402, 9480.004599517055, 9487.193588544947, 9488.240940724725, 9496.477693726842, 8419.621117049717, 8610.741677749678, 9490.05099490049, 10989.340639561611, 11255.887441125566, 11075.335479871233, 11145.0, 11235.775284494264, 11242.0, 11265.042471389941, 10768.3538987661, 10835.566577336896, 10840.403777792219, 10861.40262285574, 10863.348199107999, 30083.548746768814, 30645.0, 37929.81035094807, 38216.0, 38342.84971450861, 3154.652739016008, 3187.442197615408, 3267.607887053545, 3269.9509507357407, 3722.664960153599, 29288.267793305124, 29492.967746128998, 29704.851475742482, 29884.35636040017, 30050.0, 3101.131683128705, 3102.348506813572, 3145.402373549018, 3176.0, 3230.16015835882, 374090.0, 374418.0, 375414.0, 376557.0, 377188.99999999726, 55485.0, 55974.16038759422, 55990.0, 56020.15969760457, 56072.71963640237, 51369.486305136474, 58594.41405585975, 58699.0, 58834.41165588289, 58835.0, 14551.199684017269, 15164.772528412082, 15393.153376564396, 15399.23003849803, 15449.768253476206, 11944.64166075019, 12017.87982120185, 12024.879751202376, 12034.277943323428, 12039.157258991961, 14099.647508812363, 14981.951263411456, 15077.396904123712, 15098.698026039638, 15277.694446111016, 4816.77240946486, 6806.7957961261245, 6820.556663816836, 7049.964750176319, 7065.576065435987, 900.7072701372081, 961.624966263158, 992.731962370156, 992.9553170107363, 1055.0241027050101, 29130.854345728134, 29137.56293655597, 29692.406151876843, 29760.702392976225, 29861.55207671887, 1042.3172821801732, 1048.9824869876209, 1050.6795427394718, 1082.8538147350007, 1162.4187906046977, 12967.546135885388, 15172.165530895907, 15224.162671053198, 15699.0, 15881.52355429339, 577134.0, 585745.0, 585781.0, 585864.0, 586030.1396986061, 48708.0, 49634.554816777774, 56150.0, 56256.718716406154, 56257.0, 1362.5776009436909, 1368.2337890780996, 1406.6975600245996, 1418.1136789506559, 1421.8933579981542, 27369.86315068412, 28799.56800648034, 29584.852075739484, 29604.407911842074, 30663.0, 39758.2048359037, 48688.26967595418, 48734.781630459525, 48764.2685359727, 48773.0, 567389.0, 567529.0, 607444.0, 621936.0, 622887.0, 22978.770212298332, 23262.0695172198, 23267.53464930658, 23335.766642333358, 23335.949882255678, 39034.414483782195, 39438.0, 39653.80173099116, 39814.402783958845, 40501.0, 33527.49708754322, 33642.0, 33915.830420847735, 34087.65912340944, 34505.654943450245, 33427.83286083651, 34088.0, 34173.31653366869, 34368.312633747686, 34661.6135354583, 33038.83480582582, 33575.49636755402, 33671.494927575615, 33828.3234335307, 33853.3229335407, 25661.871690641427, 28668.283292917844, 30152.84923575368, 30403.39193216079, 30472.542911856784, 18340.449786506426, 22819.429514262276, 22843.771562284164, 23087.845607719883, 23314.533709326057], "value": 18613.31177576904, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.5326729509507, 351.2097779995011, 366.50704802041247, 372.72604635592836, 399.5145897734254, 11679.649610511688, 14635.19506427146, 15494.84505154948, 16971.0, 19805.108770105344, 16265.918670406661, 18838.905805470953, 19877.006149692494, 20136.0, 20147.0, 5548.0, 5890.998530249846, 5895.646261224319, 5895.823125306226, 5901.586888917777, 4210.894727631803, 5723.742431590567, 5831.737571809257, 6352.364763523634, 6412.0, 6381.329960354165, 6415.807525774211, 6416.45460135889, 6418.261899881527, 6425.22897252328, 6135.631862088267, 6344.794489047089, 6414.069959855795, 6424.935750642528, 6444.033394990789, 5312.362516498045, 5477.67133971963, 5576.219329293902, 5578.497935185812, 5594.160875868612, 24214.757852421426, 24520.754792452204, 24735.752642473526, 24787.504249914902, 24954.87703053367, 2084.937451876446, 2269.7730226977337, 2479.85120892747, 2652.655154829879, 2783.9025634102914, 14442.277886105652, 14625.12249265037, 14808.629784255372, 15233.0, 15364.00133991287, 1719.6302794899032, 1721.8707356407394, 1810.4025671528495, 1815.2664205683673, 1911.350140952083, 59038.0, 97941.51029244879, 98339.50830245802, 99194.0, 99242.50378748133, 10030.699079027641, 10124.493775311204, 10207.693769186937, 10517.21120915919, 10655.89344106549, 10682.78634427307, 13010.54463093806, 13032.348382580833, 13032.609021729364, 13053.543125990735, 7285.797843355787, 7347.595882226529, 7734.2265773422205, 7754.798006309031, 7936.206379362133, 8263.793405164919, 8286.047104582929, 8290.792730181673, 8433.030201526903, 8462.534560599226, 6195.566310358322, 6303.684815759286, 6371.33101024395, 6380.936190638127, 6528.575642583217, 1756.8682348823888, 1796.4520821149674, 1796.6015369481627, 1800.5948661551047, 1802.342145117049, 786.3355464632376, 919.8620206969008, 921.2077613252598, 924.2975338742469, 959.5681943125621, 20447.59104817925, 20791.792082078984, 21112.0, 21131.788682112983, 21276.57446851085, 939.9483028433365, 974.668612671695, 986.3588667366126, 1022.0478885328986, 1046.3355769086534, 7898.763037108896, 9028.729138125867, 10880.0, 11168.218224724355, 11174.44127793607, 481328.0, 490911.0, 495028.0, 495769.0, 507412.0, 74496.0, 83619.5819020901, 92115.0, 106975.46512267545, 111582.0, 928.215657769184, 949.2690628216372, 1019.6482213636284, 1019.938803671782, 1021.7139201023725, 18861.339853105077, 18961.0, 19005.714914276574, 19051.856888586728, 19103.331383401513, 35391.646083538835, 46834.531654683014, 47767.522324777696, 47782.283265751736, 49108.263376050105, 66734.0, 67502.64994700177, 68162.63674726577, 68376.0, 68829.0, 7483.513571617827, 7585.6965721372735, 7596.235247248511, 7653.732119375795, 7810.531368117931, 12400.81398779037, 12473.5010599575, 12665.240085594894, 12671.87328126707, 12781.488740450277, 9710.417374957526, 10729.195310351599, 10973.670789876316, 11184.049355804522, 11273.661790146309, 8570.442921210102, 9379.906200937903, 10071.093601575893, 10556.208284378548, 10860.402677852793, 10988.230823842574, 11038.613648522263, 11245.662630121109, 11303.717407064889, 11313.830292545454, 7542.547447153188, 7780.766577002699, 7787.06555213378, 7932.56370899583, 7936.682532698627, 10643.840342394715, 10806.837897431702, 11169.72075698114, 11181.993620574187, 11199.552017919192], "value": 9228.335514736811, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1521.9923900380497, 1559.766035094736, 1806.259433632211, 1938.050355325889, 1975.3678822776699, 8187.467814592047, 8602.784930376743, 8637.611307491163, 8648.524331161783, 8648.610812513436, 7079.433645308376, 7539.132999705022, 7864.68541258349, 8176.22325879042, 8470.280026197765, 2313.699219101519, 2357.787799098081, 2360.3862995621175, 2360.5278944211227, 2362.492064206195, 2346.249200255919, 2361.079179120136, 2386.832921695482, 2392.210570511727, 2405.3505553500545, 2077.9480512987143, 2155.6550951847707, 2245.0, 2318.6522021696796, 2321.2688003278913, 2318.5710643530915, 2325.2094287942014, 2349.565330413879, 2350.1891847312822, 2355.2580937004873, 2349.612313968193, 2377.8811059446957, 2384.701912260967, 2384.8449850759644, 2388.10446082719, 8266.586670666442, 8492.278156356717, 8494.490330580185, 8511.0, 8515.74452766418, 5066.898662026776, 5226.634135610509, 5233.188855727369, 5236.162214045735, 5250.422453530108, 3170.239142605781, 3278.541004259406, 3397.3884700753856, 3433.1760377509218, 3437.9828100859586, 971.3491960386488, 986.2110311750571, 996.8654231678703, 1014.06705830636, 1019.7807471393686, 10440.373577585293, 10729.0, 10731.570737170503, 10971.01260886524, 11146.832797508045, 4303.698741088157, 4329.415528903621, 4509.932351014738, 4517.435320584927, 4517.841875534341, 7426.0, 8798.29613630908, 8806.471611703319, 8808.735737927873, 8813.47119172839, 5064.18972964324, 5156.04613146569, 5157.226416037624, 5159.0, 5168.095583272912, 4621.95378046222, 4803.543663351976, 4811.27830825372, 4822.469528351879, 4824.204006338985, 3522.348365552381, 3540.291941611688, 3572.3212589607892, 3610.3140403323287, 3620.818959052037, 1052.1109662335314, 1108.5177947592822, 1114.331401159298, 1124.8368986496912, 1126.7295848996182, 777.3314949143731, 778.0044186661196, 903.2006674093343, 921.6083164654995, 983.7737320416201, 5643.604947653707, 5716.256886604715, 5836.1245813127525, 5847.152162936351, 6025.186599809057, 806.5281810141016, 901.9052999435096, 908.4912449028565, 916.093067862811, 941.6704153546204, 3784.243151369737, 3803.391457366808, 3853.152306492623, 3904.4533765272886, 3925.4700615417123, 10038.447885366375, 10301.793964120676, 10392.42841643717, 10414.271001029856, 10429.9478502607, 9883.590161394308, 10367.0151335623, 10380.636677716244, 10384.961503849705, 10388.013138751807, 7732.381409487228, 8018.799530011796, 8036.4776289541, 8042.758717238609, 8049.074356448966, 4863.756812159307, 5530.336359636869, 5537.390887002507, 5547.472990065938, 5667.1782591524825, 7858.882116768367, 9379.202767764817, 9408.294377921546, 9513.714588562354, 9644.276679249224, 7437.962810185914, 9436.150746432853, 9478.620855165991, 9562.617495300388, 9683.951580242054, 6677.432418244503, 6742.6628668567355, 6749.49378796602, 6752.426043786333, 6760.898586521304, 6702.262751097278, 7603.695852165852, 7865.803354915944, 7891.487053341514, 8085.0, 7056.364927156375, 7211.8557628848175, 7227.963860180876, 7288.453365997678, 7394.889076663747, 7117.217106118426, 7144.749933752294, 7146.678399471933, 7184.245654206233, 7233.276672332725, 6741.0, 6753.3921947025, 6774.085498457645, 6832.555883867532, 6848.486363522656, 3550.55618047744, 4848.490908454562, 4863.7324947128245, 4883.560479556715, 5016.473270306711, 3572.499850020947, 4722.858314250578, 4871.805127794849, 4897.314375987436, 5044.54599086084], "value": 4379.671988501363, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.52464648078615, 353.2669710351021, 359.54158447978824, 372.71673528118623, 372.7651579504913, 4851.345068415762, 4939.654224204307, 5165.741712914353, 5192.481646401497, 5205.947940520594, 4682.969746655739, 4693.741844198567, 5092.516210959953, 5106.208537676657, 5224.843254702365, 3504.456809194579, 3998.9200215995807, 4081.1837632473475, 4084.9183016339657, 4119.979400102995, 3551.236484155906, 3965.6430921217084, 4091.7954102294766, 4128.195001974616, 4128.761371588526, 3701.4077747560395, 3800.429935509668, 3879.1078052047906, 3979.343408337621, 4079.1637714268504, 3761.592580748323, 4018.5579586245344, 4066.7763273019973, 4066.877993660195, 4089.5297040840387, 3204.875246634536, 3601.333753255656, 3607.0, 3628.6008539060945, 3633.8728144514816, 4943.258511223309, 5108.463611320833, 5127.359080114986, 5131.255967884673, 5186.766595503173, 4467.664925130628, 4654.464736555272, 4686.336350595524, 4713.929291060636, 4723.551262630044, 5422.15956526739, 5448.128299472105, 5450.5367043801325, 5455.918161227585, 5467.753951072212, 3659.7621154624862, 3734.402495600718, 3784.9432258516144, 3944.5660977292473, 3986.2824691555506, 5053.444121146671, 5263.421023687391, 5760.0783874579865, 5772.682502462405, 5775.451332123442, 3556.76881002734, 4068.145689405258, 4085.080856807195, 4091.3249313863475, 4106.527749308808, 3326.850291736878, 3464.7401444891734, 3680.2455496623666, 3878.650921417086, 4150.584941505826, 4000.979995100006, 4597.494275629678, 4618.376519169936, 4618.95381046192, 4636.44362676481, 5442.401335853053, 5459.426760190123, 5476.67139971603, 5486.3690675572025, 5503.504684578327, 1130.5421304371744, 1238.7646347194004, 1266.8479782426168, 1271.554955765493, 1282.569934523, 801.8957535520461, 822.0998007182126, 917.4862077236769, 958.3291695812959, 959.6545243712258, 4219.852305169305, 4468.720952314343, 4796.688215265996, 4842.297866809293, 4858.927116093261, 4549.45406551216, 4899.510048995072, 4939.678920870132, 5140.4554745401265, 5335.706536140472, 4536.797748596625, 5014.749262536859, 5159.509846564571, 5164.269969560164, 5168.457311982263, 2371.312319427381, 2387.617981123047, 2497.8501289922665, 2755.61421401004, 2760.4755096531994, 5157.561607263349, 5183.974080129575, 5336.0, 5519.448055194448, 5556.249906262684, 5752.108423194411, 5779.739911703983, 5835.212246346774, 5851.236532015961, 5892.292924849045, 5041.168207245837, 5856.472917437451, 5874.94125058744, 5910.231669882888, 5942.197803296586, 4597.93103103447, 5507.394186639386, 5507.5593952484505, 5636.196417146473, 5653.547716182613, 5559.832435188656, 5561.41394251675, 5597.888042239051, 5598.752723420488, 5660.264225611077, 5545.528630066328, 5576.609637325349, 5813.79651712188, 5847.678377689268, 5853.653659658217, 3068.6624471308583, 3200.4079245339685, 3359.3785149747373, 3784.4701741756726, 3784.508013958168, 5350.170723537858, 5568.470995255444, 5617.5505959522325, 5619.775208991595, 5659.518940890071, 4339.435873336446, 4867.80528778859, 5112.897742045064, 5505.449455054462, 5575.9163612545035, 4387.210302145644, 4868.391451068616, 5444.243472004305, 5523.944760552343, 5545.639533430314, 5189.8202754842305, 5255.081895108335, 5342.599305052059, 5365.09539113609, 5414.35027796667, 4753.5008824072975, 5258.8159414420315, 5438.048341540136, 5448.782048718165, 5452.509274165185, 4730.905381892412, 5165.819196328111, 5312.203169524602, 5326.191772882407, 5335.386430560535], "value": 4020.4025344360284, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.6391708270245, 710.3855165282033, 711.7508871894837, 729.3071581997104, 755.4900442201513, 14398.49605263816, 14412.207328596924, 14983.175925324103, 15005.92497037516, 15191.0, 13446.462141514328, 13498.392572334244, 13839.377228024738, 13873.959453041038, 13876.444942202324, 846.1834329871673, 874.0516539554591, 875.9080296568864, 876.7545087375545, 876.8860048193726, 690.9930900691004, 713.4185638704465, 718.1561665043553, 793.3217099380033, 875.1860769484377, 890.8975467821186, 936.3773090894547, 939.1125386509751, 939.1500691873865, 939.3518472254157, 930.3627015494408, 930.8091841172543, 931.1014870649822, 932.324065052838, 933.1788026536605, 526.765589312756, 543.6194663735401, 546.6556069676078, 547.0317537957792, 691.0015028284131, 12202.755944881053, 13646.590602281947, 14215.50245741394, 14266.857331426656, 14548.563543093724, 11472.94263528677, 14074.648133796634, 14103.576892693236, 14161.645958851008, 14184.0, 11365.943170284096, 11434.885651143466, 11563.248388854781, 11607.825882611767, 11636.0, 3628.256207477461, 3680.7423480356388, 3708.8331025103935, 3720.255948810249, 3812.8856134316015, 89761.65357519643, 95846.12461626163, 101925.45186370252, 104220.0, 106976.46511767391, 10819.513121909533, 10892.0, 10970.122390208764, 10983.890161098287, 11243.044341230923, 21913.0, 22161.556768864855, 22186.44533886666, 22309.996050177782, 22430.439239019153, 7722.961385193038, 7735.9613201933635, 7736.922630773733, 7759.961200193963, 8011.919880801117, 4214.367844823301, 4304.4834619845815, 4304.80628371724, 4308.138372325548, 4460.598546130864, 3323.8171900545703, 3383.7123844473003, 3390.0, 3425.0, 3428.074419906661, 602.1088788592907, 604.9818505444844, 605.9091136329586, 612.6354818882758, 623.03118650498, 547.2475346398702, 566.6430149006183, 582.5630776917312, 606.6814922165898, 606.9059295809157, 8656.13438656142, 9325.067493250757, 9351.158395744416, 9431.905680943102, 9498.382605130644, 582.7057336045355, 646.2632598837329, 654.554902666182, 658.706875440434, 669.8325418645338, 3579.266250418658, 3732.2908647356917, 3783.9243215135543, 3788.3938569828697, 3802.1825307558456, 95146.0, 98345.50827245961, 100179.99820001707, 101386.0, 104000.95999040065, 73794.6310268456, 80182.19817801865, 89920.10079899117, 90612.5469372662, 91189.08810911806, 61114.0, 72952.90570641444, 76476.47047059139, 77330.62709966379, 78497.21502785127, 7777.766666999999, 7806.804829879298, 7866.254827786116, 8050.114487406264, 8106.79733006656, 43079.0, 50467.0, 51431.74284128555, 52428.21357679561, 52774.208386875, 69744.0, 70554.29445705477, 71042.57914841778, 71634.64182679054, 73153.0, 11116.221864469733, 11130.16523760705, 11247.887521124683, 11249.417757648123, 11270.436478175894, 11465.713357165803, 11752.059835213333, 12069.0, 12220.450079746255, 12824.743505130033, 10073.899261007296, 11485.138614603771, 11647.767044658889, 11654.533818647498, 11903.46434410471, 10996.725081873017, 11023.503942322453, 11625.418729063344, 11675.241109328206, 11807.291562506278, 11328.773424531628, 11778.705532361759, 11952.521899123938, 12291.50833966667, 12333.075019373404, 9238.935227680899, 9247.815043698954, 9267.907320926704, 9353.345265831598, 9815.705528834147, 9865.704028879145, 9900.059494348025, 10007.431013759913, 10166.237532185263, 10193.133583645473], "value": 7018.937677615908, "unit": "score"}], "name": "dromaeo_css", "value": 7011.1870240322605, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 114.0, 113.0, 113.0, 114.0, 111.0, 113.0, 113.0, 114.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 99.0, 128.0, 180.0, 110.0, 112.0, 109.0, 116.0, 161.0, 141.0], "value": 130.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 179.0, 183.0, 182.0, 184.0, 196.0, 258.0, 184.0, 184.0, 184.0], "value": 191.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 60.0, 60.0, 87.0, 58.0, 60.0, 58.0, 59.0, 74.0, 59.0], "value": 65.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 69.0, 85.0, 69.0, 68.0, 69.0, 83.0, 70.0, 69.0, 83.0], "value": 75.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 108.0, 107.0, 110.0, 106.0, 108.0, 106.0, 109.0, 106.0, 107.0], "value": 107.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 107.0, 151.0, 94.0, 134.0, 152.0, 94.0, 111.0, 151.0, 95.0], "value": 118.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 84.0, 88.0, 85.0, 85.0, 85.0, 85.0, 85.0, 93.0], "value": 86.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 54.0, 54.0, 55.0, 56.0, 55.0, 55.0, 54.0, 55.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 71.0, 77.0, 78.0, 75.0, 72.0, 72.0, 73.0, 73.0, 73.0], "value": 72.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 88.0, 87.0, 90.0, 100.0, 106.0, 108.0, 89.0, 88.0], "value": 93.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 144.0, 133.0, 144.0, 147.0, 147.0, 150.0, 141.0, 186.0, 145.0], "value": 148.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 170.0, 173.0, 171.0, 172.0, 170.0, 171.0, 173.0, 169.0, 170.0], "value": 171.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 68.0, 68.0, 68.0, 67.0, 66.0, 67.0, 66.0, 65.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1493.9, "alertThreshold": 2.0}]} 14:16:02 INFO - Return code: 0 14:16:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:16:03 INFO - # TBPL SUCCESS # 14:16:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:16:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:16:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:16:03 INFO - 2016-12-19 14:16:03.076 screenresolution[1973:12658] starting screenresolution argv=screenresolution get 14:16:03 INFO - 2016-12-19 14:16:03.079 screenresolution[1973:12658] Display 0: 1600x1200x32@60 14:16:03 INFO - 2016-12-19 14:16:03.085 screenresolution[1974:12661] starting screenresolution argv=screenresolution list 14:16:03 INFO - Available Modes on Display 0 14:16:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:16:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:16:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:16:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:16:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:16:03 INFO - Intel Iris: 14:16:03 INFO - Chipset Model: Intel Iris 14:16:03 INFO - Type: GPU 14:16:03 INFO - Bus: Built-In 14:16:03 INFO - VRAM (Dynamic, Max): 1536 MB 14:16:03 INFO - Vendor: Intel (0x8086) 14:16:03 INFO - Device ID: 0x0a2e 14:16:03 INFO - Revision ID: 0x0009 14:16:03 INFO - Displays: 14:16:03 INFO - Display: 14:16:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:16:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:16:03 INFO - Display Serial Number: 1600x1200 60 14:16:03 INFO - Main Display: Yes 14:16:03 INFO - Mirror: Off 14:16:03 INFO - Online: Yes 14:16:03 INFO - Rotation: Supported 14:16:03 INFO - Return code: 0 14:16:03 INFO - Running post-action listener: _resource_record_post_action 14:16:03 INFO - [mozharness: 2016-12-19 22:16:03.321977Z] Finished run-tests step (success) 14:16:03 INFO - Running post-run listener: _resource_record_post_run 14:16:03 INFO - Total resource usage - Wall time: 1203s; CPU: 54.0%; Read bytes: 327680; Write bytes: 549849600; Read time: 8; Write time: 1658 14:16:03 INFO - TinderboxPrint: CPU usage
53.6% 14:16:03 INFO - TinderboxPrint: I/O read bytes / time
327,680 / 8 14:16:03 INFO - TinderboxPrint: I/O write bytes / time
549,849,600 / 1,658 14:16:03 INFO - TinderboxPrint: CPU idle
2,234.7 (46.4%) 14:16:03 INFO - TinderboxPrint: CPU system
963.2 (20.0%) 14:16:03 INFO - TinderboxPrint: CPU user
1,615.7 (33.6%) 14:16:03 INFO - TinderboxPrint: Swap in / out
250,093,568 / 0 14:16:03 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 235153920; Write bytes: 230557184; Read time: 17418; Write time: 480 14:16:03 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 327680; Write bytes: 296379392; Read time: 8; Write time: 1118 14:16:03 INFO - Running post-run listener: _upload_blobber_files 14:16:03 INFO - Blob upload gear active. 14:16:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:16:03 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 14:16:03 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'] 14:16:03 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 14:16:04 INFO - (blobuploader) - INFO - Open directory for files ... 14:16:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:16:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:16:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:16:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:16:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:16:05 INFO - (blobuploader) - INFO - Done attempting. 14:16:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:16:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:16:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:16:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:16:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:16:06 INFO - (blobuploader) - INFO - Done attempting. 14:16:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:16:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:16:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:16:07 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:16:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:16:07 INFO - (blobuploader) - INFO - Done attempting. 14:16:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:16:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:16:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:16:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:16:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:16:10 INFO - (blobuploader) - INFO - Done attempting. 14:16:10 INFO - (blobuploader) - INFO - Iteration through files over. 14:16:10 INFO - Return code: 0 14:16:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:16:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:16:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/84f1308925871e7fb69067d73f024b29cde15aaae58f22abfe64e661cc50ff460a68bb6692f9371b1796de303cbd256dac08dafb0c3b4ed70f5c9d828870f900", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/26c41252a677d612ef1be5391fe8747e2d8c7e8c7aefe209dc69d201e9511870aaba3a98301407d249390eb6dbfd478dfa9183a972d31dfd52f95bd6e9d227d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1999a0e76a47d06341933289e9a830464c1fa335de439811c6ce49849cfe02c949ef6bcc24698cb06926493e92dc0b2a753acfa004aedca52dfedbdba04cb68a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/634d3c2ba7a8741fac8d77157bf884a740c64aa8920c2a344b09b0dcdab493894ee612a7554618c68c2430a9367427576f859f05cd682c136c2bf5ddea72e3dc"} 14:16:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:16:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:16:10 INFO - Contents: 14:16:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/84f1308925871e7fb69067d73f024b29cde15aaae58f22abfe64e661cc50ff460a68bb6692f9371b1796de303cbd256dac08dafb0c3b4ed70f5c9d828870f900", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/26c41252a677d612ef1be5391fe8747e2d8c7e8c7aefe209dc69d201e9511870aaba3a98301407d249390eb6dbfd478dfa9183a972d31dfd52f95bd6e9d227d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1999a0e76a47d06341933289e9a830464c1fa335de439811c6ce49849cfe02c949ef6bcc24698cb06926493e92dc0b2a753acfa004aedca52dfedbdba04cb68a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/634d3c2ba7a8741fac8d77157bf884a740c64aa8920c2a344b09b0dcdab493894ee612a7554618c68c2430a9367427576f859f05cd682c136c2bf5ddea72e3dc"} 14:16:10 INFO - Running post-run listener: copy_logs_to_upload_dir 14:16:10 INFO - Copying logs to upload dir... 14:16:10 INFO - mkdir: /builds/slave/test/build/upload/logs 14:16:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.255469 ========= master_lag: 0.27 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-12-19 14:16:10.446601) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-19 14:16:10.449765) ========= 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.TiolayNXGd/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.lddQaDqBIH/Listeners TMPDIR=/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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/84f1308925871e7fb69067d73f024b29cde15aaae58f22abfe64e661cc50ff460a68bb6692f9371b1796de303cbd256dac08dafb0c3b4ed70f5c9d828870f900", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/26c41252a677d612ef1be5391fe8747e2d8c7e8c7aefe209dc69d201e9511870aaba3a98301407d249390eb6dbfd478dfa9183a972d31dfd52f95bd6e9d227d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1999a0e76a47d06341933289e9a830464c1fa335de439811c6ce49849cfe02c949ef6bcc24698cb06926493e92dc0b2a753acfa004aedca52dfedbdba04cb68a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/634d3c2ba7a8741fac8d77157bf884a740c64aa8920c2a344b09b0dcdab493894ee612a7554618c68c2430a9367427576f859f05cd682c136c2bf5ddea72e3dc"} build_url:https://queue.taskcluster.net/v1/task/aXEeZ5t6TMG3KYq44UfISQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010939 build_url: 'https://queue.taskcluster.net/v1/task/aXEeZ5t6TMG3KYq44UfISQ/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/84f1308925871e7fb69067d73f024b29cde15aaae58f22abfe64e661cc50ff460a68bb6692f9371b1796de303cbd256dac08dafb0c3b4ed70f5c9d828870f900", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/26c41252a677d612ef1be5391fe8747e2d8c7e8c7aefe209dc69d201e9511870aaba3a98301407d249390eb6dbfd478dfa9183a972d31dfd52f95bd6e9d227d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1999a0e76a47d06341933289e9a830464c1fa335de439811c6ce49849cfe02c949ef6bcc24698cb06926493e92dc0b2a753acfa004aedca52dfedbdba04cb68a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/634d3c2ba7a8741fac8d77157bf884a740c64aa8920c2a344b09b0dcdab493894ee612a7554618c68c2430a9367427576f859f05cd682c136c2bf5ddea72e3dc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-19 14:16:10.484757) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 14:16:10.485232) ========= 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.TiolayNXGd/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.lddQaDqBIH/Listeners TMPDIR=/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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.005303 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 14:16:10.535398) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-19 14:16:10.535707) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-19 14:16:10.536158) ========= ========= Total master_lag: 0.41 =========