builder: cedar_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0189 starttime: 1478178305.58 results: success (0) buildid: 20161103034324 builduid: 698915130e414680a2ffac2e239d274f revision: d01ee5312491327d772f064f0a525fd4a492e837 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-03 06:05:05.585266) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-03 06:05:05.585664) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-03 06:05:05.585946) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-03 06:05:05.779724) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 06:05:05.780040) ========= 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.fJq7NTaYHJ/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.5VpPRSVL29/Listeners TMPDIR=/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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-11-03 06:05:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.9M=0.001s 2016-11-03 06:05:06 (14.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.539137 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 06:05:06.353669) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 06:05:06.353982) ========= 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.fJq7NTaYHJ/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.5VpPRSVL29/Listeners TMPDIR=/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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.025970 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 06:05:06.401657) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 06:05:06.401988) ========= bash -c 'python archiver_client.py mozharness --repo projects/cedar --rev d01ee5312491327d772f064f0a525fd4a492e837 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/cedar --rev d01ee5312491327d772f064f0a525fd4a492e837 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fJq7NTaYHJ/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.5VpPRSVL29/Listeners TMPDIR=/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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-11-03 06:05:06,522 truncating revision to first 12 chars 2016-11-03 06:05:06,522 Setting DEBUG logging. 2016-11-03 06:05:06,522 attempt 1/10 2016-11-03 06:05:06,522 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/cedar/d01ee5312491?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-03 06:05:07,220 unpacking tar archive at: cedar-d01ee5312491/testing/mozharness/ program finished with exit code 0 elapsedTime=0.953053 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 06:05:07.378562) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-03 06:05:07.379145) ========= script_repo_revision: d01ee5312491327d772f064f0a525fd4a492e837 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-03 06:05:07.379925) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-03 06:05:07.380490) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-03 06:05:07.400074) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-11-03 06:05:07.400649) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 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', 'Cedar', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Cedar'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fJq7NTaYHJ/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.5VpPRSVL29/Listeners TMPDIR=/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 06:05:07 INFO - MultiFileLogger online at 20161103 06:05:07 in /builds/slave/test 06:05:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 06:05:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:05:07 INFO - {'append_to_log': False, 06:05:07 INFO - 'base_work_dir': '/builds/slave/test', 06:05:07 INFO - 'blob_upload_branch': 'Cedar', 06:05:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:05:07 INFO - 'branch': 'Cedar', 06:05:07 INFO - 'buildbot_json_path': 'buildprops.json', 06:05:07 INFO - 'config_files': ('talos/mac_config.py',), 06:05:07 INFO - 'default_actions': ('clobber', 06:05:07 INFO - 'read-buildbot-config', 06:05:07 INFO - 'download-and-extract', 06:05:07 INFO - 'populate-webroot', 06:05:07 INFO - 'create-virtualenv', 06:05:07 INFO - 'install', 06:05:07 INFO - 'run-tests'), 06:05:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:05:07 INFO - 'download_minidump_stackwalk': True, 06:05:07 INFO - 'download_symbols': 'ondemand', 06:05:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:05:07 INFO - 'tooltool.py': '/tools/tooltool.py', 06:05:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:05:07 INFO - '/tools/misc-python/virtualenv.py')}, 06:05:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:05:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:05:07 INFO - 'installer_path': 'installer.exe', 06:05:07 INFO - 'log_level': 'info', 06:05:07 INFO - 'log_name': 'talos', 06:05:07 INFO - 'log_to_console': True, 06:05:07 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:05:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:05:07 INFO - 'opt_config_files': (), 06:05:07 INFO - 'pip_index': False, 06:05:07 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:05:07 INFO - 'cmd': ('bash', 06:05:07 INFO - '-c', 06:05:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:05:07 INFO - 'enabled': True, 06:05:07 INFO - 'halt_on_failure': False, 06:05:07 INFO - 'name': 'check_screen_resolution'},), 06:05:07 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:05:07 INFO - 'cmd': ('bash', 06:05:07 INFO - '-c', 06:05:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:05:07 INFO - 'enabled': True, 06:05:07 INFO - 'halt_on_failure': False, 06:05:07 INFO - 'name': 'check_screen_resolution'},), 06:05:07 INFO - 'run_cmd_checks_enabled': True, 06:05:07 INFO - 'sps_profile': False, 06:05:07 INFO - 'sps_profile_interval': 0, 06:05:07 INFO - 'suite': 'dromaeojs', 06:05:07 INFO - 'system_bits': '32', 06:05:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:05:07 INFO - 'title': 't-yosemite-r7-0189', 06:05:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:05:07 INFO - 'use_talos_json': True, 06:05:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:05:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:05:07 INFO - 'work_dir': 'build'} 06:05:07 INFO - [mozharness: 2016-11-03 13:05:07.653838Z] Running clobber step. 06:05:07 INFO - Running pre-action listener: _resource_record_pre_action 06:05:07 INFO - Running main action method: clobber 06:05:07 INFO - rmtree: /builds/slave/test/build 06:05:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:05:09 INFO - Running post-action listener: _resource_record_post_action 06:05:09 INFO - [mozharness: 2016-11-03 13:05:09.733120Z] Finished clobber step (success) 06:05:09 INFO - [mozharness: 2016-11-03 13:05:09.733282Z] Running read-buildbot-config step. 06:05:09 INFO - Running pre-action listener: _resource_record_pre_action 06:05:09 INFO - Running main action method: read_buildbot_config 06:05:09 INFO - Using buildbot properties: 06:05:09 INFO - { 06:05:09 INFO - "project": "", 06:05:09 INFO - "product": "firefox", 06:05:09 INFO - "script_repo_revision": "default", 06:05:09 INFO - "builddir": "cedar_yosemite_r7_test-dromaeojs", 06:05:09 INFO - "repository": "", 06:05:09 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 cedar talos dromaeojs", 06:05:09 INFO - "buildid": "20161103034324", 06:05:09 INFO - "pgo_build": "False", 06:05:09 INFO - "basedir": "/builds/slave/test", 06:05:09 INFO - "buildnumber": 0, 06:05:09 INFO - "slavename": "t-yosemite-r7-0189", 06:05:09 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 06:05:09 INFO - "platform": "yosemite_r7", 06:05:09 INFO - "scheduler": "tests-cedar-macosx64-talos", 06:05:09 INFO - "branch": "cedar", 06:05:09 INFO - "repo_path": "projects/cedar", 06:05:09 INFO - "revision": "d01ee5312491327d772f064f0a525fd4a492e837", 06:05:09 INFO - "stage_platform": "macosx64", 06:05:09 INFO - "builduid": "698915130e414680a2ffac2e239d274f", 06:05:09 INFO - "slavebuilddir": "test" 06:05:09 INFO - } 06:05:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/d5pL2COtQLq5g6XMuAO1Pg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 06:05:09 INFO - Running post-action listener: _resource_record_post_action 06:05:09 INFO - [mozharness: 2016-11-03 13:05:09.736523Z] Finished read-buildbot-config step (success) 06:05:09 INFO - [mozharness: 2016-11-03 13:05:09.736623Z] Running download-and-extract step. 06:05:09 INFO - Running pre-action listener: _resource_record_pre_action 06:05:09 INFO - Running main action method: download_and_extract 06:05:09 INFO - mkdir: /builds/slave/test/build/tests 06:05:09 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')]} 06:05:09 INFO - trying https://queue.taskcluster.net/v1/task/d5pL2COtQLq5g6XMuAO1Pg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 06:05:09 INFO - Downloading https://queue.taskcluster.net/v1/task/d5pL2COtQLq5g6XMuAO1Pg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 06:05:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d5pL2COtQLq5g6XMuAO1Pg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 06:05:10 INFO - Downloaded 1199 bytes. 06:05:10 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 06:05:10 INFO - Using the following test package requirements: 06:05:10 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 06:05:10 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:05:10 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 06:05:10 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:05:10 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 06:05:10 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:05:10 INFO - u'jsshell-mac.zip'], 06:05:10 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:05:10 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 06:05:10 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 06:05:10 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:05:10 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 06:05:10 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:05:10 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 06:05:10 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:05:10 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 06:05:10 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:05:10 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 06:05:10 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:05:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d5pL2COtQLq5g6XMuAO1Pg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 06:05:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d5pL2COtQLq5g6XMuAO1Pg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:05:10 INFO - Fetch https://queue.taskcluster.net/v1/task/d5pL2COtQLq5g6XMuAO1Pg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 06:05:11 INFO - Http code: 200 06:05:11 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 06:05:11 INFO - x-amz-cf-id: Y0j3Q9d_oqhKOv8_HRzfDzJ5lUl62Z8--M7-_K_nuZKENHxk0wI-xA== 06:05:11 INFO - x-amz-version-id: 6ccTG1DmwYcTZJ_89tl3VCgqICORkSGl 06:05:11 INFO - Expected file size: 16389189 06:05:11 INFO - Obtained file size: 16389189 06:05:18 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 06:05:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d5pL2COtQLq5g6XMuAO1Pg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 06:05:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d5pL2COtQLq5g6XMuAO1Pg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:05:18 INFO - Fetch https://queue.taskcluster.net/v1/task/d5pL2COtQLq5g6XMuAO1Pg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 06:05:19 INFO - Http code: 200 06:05:19 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 06:05:19 INFO - x-amz-cf-id: XyGOwySjWLhf4rXn5LsI7JFdXyDsvGZNFUPH9rVjUN8impUWsx8ZCA== 06:05:19 INFO - x-amz-version-id: 6ccTG1DmwYcTZJ_89tl3VCgqICORkSGl 06:05:19 INFO - Expected file size: 16389189 06:05:19 INFO - Obtained file size: 16389189 06:05:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d5pL2COtQLq5g6XMuAO1Pg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 06:05:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d5pL2COtQLq5g6XMuAO1Pg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:05:25 INFO - Fetch https://queue.taskcluster.net/v1/task/d5pL2COtQLq5g6XMuAO1Pg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 06:05:26 INFO - Http code: 200 06:05:26 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 06:05:26 INFO - x-amz-cf-id: hYYd3yUBt2QbvEjTH9iHGlmsFP-zfKqErIOycIS33Vdur3oRT1GRrw== 06:05:26 INFO - x-amz-version-id: ImThfWN59iuKw77mxsGhPcLoQrr5ZFgO 06:05:26 INFO - Expected file size: 14409038 06:05:26 INFO - Obtained file size: 14409038 06:05:26 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')]} 06:05:26 INFO - trying https://queue.taskcluster.net/v1/task/d5pL2COtQLq5g6XMuAO1Pg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:05:26 INFO - Downloading https://queue.taskcluster.net/v1/task/d5pL2COtQLq5g6XMuAO1Pg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 06:05:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d5pL2COtQLq5g6XMuAO1Pg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 06:05:29 INFO - Downloaded 111965562 bytes. 06:05:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d5pL2COtQLq5g6XMuAO1Pg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:05:29 INFO - mkdir: /builds/slave/test/properties 06:05:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:05:29 INFO - Writing to file /builds/slave/test/properties/build_url 06:05:29 INFO - Contents: 06:05:29 INFO - build_url:https://queue.taskcluster.net/v1/task/d5pL2COtQLq5g6XMuAO1Pg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:05:30 INFO - Running post-action listener: _resource_record_post_action 06:05:30 INFO - Running post-action listener: set_extra_try_arguments 06:05:30 INFO - [mozharness: 2016-11-03 13:05:30.295973Z] Finished download-and-extract step (success) 06:05:30 INFO - [mozharness: 2016-11-03 13:05:30.296139Z] Running populate-webroot step. 06:05:30 INFO - Running pre-action listener: _resource_record_pre_action 06:05:30 INFO - Running main action method: populate_webroot 06:05:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:05:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:05:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:05:30 INFO - '--tppagecycles', 06:05:30 INFO - '7'], 06:05:30 INFO - 'tests': ['tsvgm']}}, 06:05:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:05:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:05:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:05:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:05:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:05:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:05:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:30 INFO - 'talos_options': ['--disable-e10s'], 06:05:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:05:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:05:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:30 INFO - 'talos_options': ['--disable-e10s'], 06:05:30 INFO - 'tests': ['damp', 'tps']}, 06:05:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:30 INFO - 'tests': ['damp', 'tps']}, 06:05:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:05:30 INFO - 'tests': ['dromaeo_dom']}, 06:05:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:05:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:05:30 INFO - 'tests': ['basic_compositor_video']}, 06:05:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:05:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:05:30 INFO - 'tests': ['a11yr', 06:05:30 INFO - 'ts_paint', 06:05:30 INFO - 'tpaint', 06:05:30 INFO - 'sessionrestore', 06:05:30 INFO - 'sessionrestore_no_auto_restore', 06:05:30 INFO - 'tabpaint']}, 06:05:30 INFO - 'other-e10s': {'tests': ['a11yr', 06:05:30 INFO - 'ts_paint', 06:05:30 INFO - 'tpaint', 06:05:30 INFO - 'sessionrestore', 06:05:30 INFO - 'sessionrestore_no_auto_restore', 06:05:30 INFO - 'tabpaint']}, 06:05:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:05:30 INFO - 'ts_paint', 06:05:30 INFO - 'tpaint', 06:05:30 INFO - 'sessionrestore', 06:05:30 INFO - 'sessionrestore_no_auto_restore', 06:05:30 INFO - 'tabpaint']}, 06:05:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:05:30 INFO - 'ts_paint', 06:05:30 INFO - 'tpaint', 06:05:30 INFO - 'sessionrestore', 06:05:30 INFO - 'sessionrestore_no_auto_restore', 06:05:30 INFO - 'tabpaint']}, 06:05:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:05:30 INFO - 'tests': ['a11yr', 06:05:30 INFO - 'ts_paint', 06:05:30 INFO - 'tpaint', 06:05:30 INFO - 'sessionrestore', 06:05:30 INFO - 'sessionrestore_no_auto_restore', 06:05:30 INFO - 'tabpaint']}, 06:05:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:05:30 INFO - 'tests': ['a11yr', 06:05:30 INFO - 'ts_paint', 06:05:30 INFO - 'tpaint', 06:05:30 INFO - 'sessionrestore', 06:05:30 INFO - 'sessionrestore_no_auto_restore', 06:05:30 INFO - 'tabpaint']}, 06:05:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:05:30 INFO - 'tests': ['tsvgx', 06:05:30 INFO - 'tsvgr_opacity', 06:05:30 INFO - 'tart', 06:05:30 INFO - 'tscrollx', 06:05:30 INFO - 'cart']}, 06:05:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:05:30 INFO - 'tsvgr_opacity', 06:05:30 INFO - 'tart', 06:05:30 INFO - 'tscrollx', 06:05:30 INFO - 'cart']}, 06:05:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:30 INFO - 'talos_options': ['--disable-e10s'], 06:05:30 INFO - 'tests': ['tp5o']}, 06:05:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:30 INFO - 'tests': ['tp5o']}, 06:05:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:30 INFO - 'talos_options': ['--disable-e10s', 06:05:30 INFO - '--xperf_path', 06:05:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:05:30 INFO - 'tests': ['tp5n']}, 06:05:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:30 INFO - 'talos_options': ['--xperf_path', 06:05:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:05:30 INFO - 'tests': ['tp5n']}}, 06:05:30 INFO - 'talos.zip': {'path': '', 06:05:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:05:30 INFO - Running post-action listener: _resource_record_post_action 06:05:30 INFO - [mozharness: 2016-11-03 13:05:30.314826Z] Finished populate-webroot step (success) 06:05:30 INFO - [mozharness: 2016-11-03 13:05:30.314957Z] Running create-virtualenv step. 06:05:30 INFO - Running pre-action listener: _resource_record_pre_action 06:05:30 INFO - Running main action method: create_virtualenv 06:05:30 INFO - Creating virtualenv /builds/slave/test/build/venv 06:05:30 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 06:05:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:05:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:05:30 INFO - Using real prefix '/tools/python27' 06:05:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:05:31 INFO - Installing distribute.............................................................................................................................................................................................done. 06:05:34 INFO - Installing pip.................done. 06:05:34 INFO - Return code: 0 06:05:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:05:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:05:34 INFO - Reading from file tmpfile_stdout 06:05:34 INFO - Output received: 06:05:34 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) 06:05:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:05:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:05:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:34 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 0x1104e7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11045d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa013577c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102fbd30>, '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 0x110121db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102f3b20>, '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.fJq7NTaYHJ/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.5VpPRSVL29/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 06:05:34 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 06:05:34 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 06:05:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fJq7NTaYHJ/Render', 06:05:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:05:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:05:34 INFO - 'HOME': '/Users/cltbld', 06:05:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:05:34 INFO - 'LOGNAME': 'cltbld', 06:05:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:34 INFO - 'MOZ_NO_REMOTE': '1', 06:05:34 INFO - 'NO_EM_RESTART': '1', 06:05:34 INFO - 'PAGER': '/bin/cat', 06:05:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:05:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:34 INFO - 'PWD': '/builds/slave/test', 06:05:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:05:34 INFO - 'SHELL': '/bin/bash', 06:05:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5VpPRSVL29/Listeners', 06:05:34 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 06:05:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:05:34 INFO - 'USER': 'cltbld', 06:05:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:05:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:05:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:34 INFO - 'XPC_FLAGS': '0x0', 06:05:34 INFO - 'XPC_SERVICE_NAME': '0', 06:05:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:05:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:34 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 06:05:34 INFO - Cleaning up... 06:05:34 INFO - Return code: 0 06:05:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:05:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:05:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:34 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 0x1104e7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11045d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa013577c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102fbd30>, '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 0x110121db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102f3b20>, '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.fJq7NTaYHJ/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.5VpPRSVL29/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 06:05:34 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 06:05:34 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 06:05:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fJq7NTaYHJ/Render', 06:05:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:05:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:05:34 INFO - 'HOME': '/Users/cltbld', 06:05:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:05:34 INFO - 'LOGNAME': 'cltbld', 06:05:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:34 INFO - 'MOZ_NO_REMOTE': '1', 06:05:34 INFO - 'NO_EM_RESTART': '1', 06:05:34 INFO - 'PAGER': '/bin/cat', 06:05:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:05:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:34 INFO - 'PWD': '/builds/slave/test', 06:05:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:05:34 INFO - 'SHELL': '/bin/bash', 06:05:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5VpPRSVL29/Listeners', 06:05:34 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 06:05:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:05:34 INFO - 'USER': 'cltbld', 06:05:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:05:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:05:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:34 INFO - 'XPC_FLAGS': '0x0', 06:05:34 INFO - 'XPC_SERVICE_NAME': '0', 06:05:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:05:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:34 INFO - Downloading/unpacking psutil>=3.1.1 06:05:34 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 06:05:34 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 06:05:34 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 06:05:34 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 06:05:34 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 06:05:34 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 06:05:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:05:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:05:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:05:38 INFO - Installing collected packages: psutil 06:05:38 INFO - Running setup.py install for psutil 06:05:38 INFO - building 'psutil._psutil_osx' extension 06:05:38 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 06:05:39 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 06:05:39 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 06:05:39 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 06:05:39 INFO - building 'psutil._psutil_posix' extension 06:05:39 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 06:05:39 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:05:39 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:05:39 INFO - ^ 06:05:39 INFO - 1 warning generated. 06:05:39 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 06:05:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:05:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:05:39 INFO - Successfully installed psutil 06:05:39 INFO - Cleaning up... 06:05:39 INFO - Return code: 0 06:05:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:05:39 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')]} 06:05:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:39 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')]} 06:05:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:39 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 0x1104e7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11045d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa013577c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102fbd30>, '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 0x110121db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102f3b20>, '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.fJq7NTaYHJ/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.5VpPRSVL29/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 06:05:39 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 06:05:39 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 06:05:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fJq7NTaYHJ/Render', 06:05:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:05:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:05:39 INFO - 'HOME': '/Users/cltbld', 06:05:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:05:39 INFO - 'LOGNAME': 'cltbld', 06:05:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:39 INFO - 'MOZ_NO_REMOTE': '1', 06:05:39 INFO - 'NO_EM_RESTART': '1', 06:05:39 INFO - 'PAGER': '/bin/cat', 06:05:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:05:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:39 INFO - 'PWD': '/builds/slave/test', 06:05:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:05:39 INFO - 'SHELL': '/bin/bash', 06:05:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5VpPRSVL29/Listeners', 06:05:39 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 06:05:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:05:39 INFO - 'USER': 'cltbld', 06:05:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:05:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:05:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:39 INFO - 'XPC_FLAGS': '0x0', 06:05:39 INFO - 'XPC_SERVICE_NAME': '0', 06:05:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:05:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:05:40 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 06:05:40 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 06:05:40 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 06:05:40 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 06:05:40 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 06:05:40 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 06:05:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:05:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:05:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:05:42 INFO - Installing collected packages: mozsystemmonitor 06:05:42 INFO - Running setup.py install for mozsystemmonitor 06:05:42 INFO - Successfully installed mozsystemmonitor 06:05:42 INFO - Cleaning up... 06:05:43 INFO - Return code: 0 06:05:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:05:43 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')]} 06:05:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:43 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')]} 06:05:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:43 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 0x1104e7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11045d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa013577c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102fbd30>, '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 0x110121db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102f3b20>, '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.fJq7NTaYHJ/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.5VpPRSVL29/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 06:05:43 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 06:05:43 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 06:05:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fJq7NTaYHJ/Render', 06:05:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:05:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:05:43 INFO - 'HOME': '/Users/cltbld', 06:05:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:05:43 INFO - 'LOGNAME': 'cltbld', 06:05:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:43 INFO - 'MOZ_NO_REMOTE': '1', 06:05:43 INFO - 'NO_EM_RESTART': '1', 06:05:43 INFO - 'PAGER': '/bin/cat', 06:05:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:05:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:43 INFO - 'PWD': '/builds/slave/test', 06:05:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:05:43 INFO - 'SHELL': '/bin/bash', 06:05:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5VpPRSVL29/Listeners', 06:05:43 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 06:05:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:05:43 INFO - 'USER': 'cltbld', 06:05:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:05:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:05:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:43 INFO - 'XPC_FLAGS': '0x0', 06:05:43 INFO - 'XPC_SERVICE_NAME': '0', 06:05:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:05:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:43 INFO - Downloading/unpacking jsonschema==2.5.1 06:05:43 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 06:05:43 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 06:05:43 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 06:05:43 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 06:05:43 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 06:05:43 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 06:05:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:05:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:05: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 06:05: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 06:05: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 06:05: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 06:05: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 06:05: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 06:05:46 INFO - Downloading functools32-3.2.3-2.tar.gz 06:05:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:05:46 INFO - warning: no files found matching '*.txt' 06:05:46 INFO - no previously-included directories found matching 'build' 06:05:46 INFO - no previously-included directories found matching 'dist' 06:05:46 INFO - no previously-included directories found matching '.git*' 06:05:46 INFO - Installing collected packages: jsonschema, functools32 06:05:46 INFO - Running setup.py install for functools32 06:05:46 INFO - warning: no files found matching '*.txt' 06:05:46 INFO - no previously-included directories found matching 'build' 06:05:46 INFO - no previously-included directories found matching 'dist' 06:05:46 INFO - no previously-included directories found matching '.git*' 06:05:46 INFO - Successfully installed jsonschema functools32 06:05:46 INFO - Cleaning up... 06:05:46 INFO - Return code: 0 06:05:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:05:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:05:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1104e7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11045d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa013577c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102fbd30>, '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 0x110121db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102f3b20>, '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.fJq7NTaYHJ/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.5VpPRSVL29/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 06:05:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:05:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:05:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fJq7NTaYHJ/Render', 06:05:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:05:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:05:46 INFO - 'HOME': '/Users/cltbld', 06:05:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:05:46 INFO - 'LOGNAME': 'cltbld', 06:05:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:46 INFO - 'MOZ_NO_REMOTE': '1', 06:05:46 INFO - 'NO_EM_RESTART': '1', 06:05:46 INFO - 'PAGER': '/bin/cat', 06:05:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:05:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:46 INFO - 'PWD': '/builds/slave/test', 06:05:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:05:46 INFO - 'SHELL': '/bin/bash', 06:05:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5VpPRSVL29/Listeners', 06:05:46 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 06:05:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:05:46 INFO - 'USER': 'cltbld', 06:05:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:05:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:05:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:46 INFO - 'XPC_FLAGS': '0x0', 06:05:46 INFO - 'XPC_SERVICE_NAME': '0', 06:05:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:05:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:05:46 INFO - Cleaning up... 06:05:46 INFO - Return code: 0 06:05:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:05:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:05:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1104e7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11045d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa013577c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102fbd30>, '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 0x110121db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102f3b20>, '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.fJq7NTaYHJ/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.5VpPRSVL29/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 06:05:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:05:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:05:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fJq7NTaYHJ/Render', 06:05:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:05:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:05:46 INFO - 'HOME': '/Users/cltbld', 06:05:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:05:46 INFO - 'LOGNAME': 'cltbld', 06:05:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:46 INFO - 'MOZ_NO_REMOTE': '1', 06:05:46 INFO - 'NO_EM_RESTART': '1', 06:05:46 INFO - 'PAGER': '/bin/cat', 06:05:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:05:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:46 INFO - 'PWD': '/builds/slave/test', 06:05:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:05:46 INFO - 'SHELL': '/bin/bash', 06:05:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5VpPRSVL29/Listeners', 06:05:46 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 06:05:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:05:46 INFO - 'USER': 'cltbld', 06:05:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:05:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:05:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:46 INFO - 'XPC_FLAGS': '0x0', 06:05:46 INFO - 'XPC_SERVICE_NAME': '0', 06:05:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:05:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:47 INFO - Downloading/unpacking blobuploader==1.2.4 06:05:47 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 06:05:47 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 06:05:47 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 06:05:47 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 06:05:47 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 06:05:47 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 06:05:49 INFO - Downloading blobuploader-1.2.4.tar.gz 06:05:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:05:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:05:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:05:50 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 06:05:50 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 06:05:50 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 06:05:50 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 06:05:50 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 06:05:50 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 06:05:50 INFO - Downloading docopt-0.6.1.tar.gz 06:05:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:05:50 INFO - Installing collected packages: blobuploader, requests, docopt 06:05:50 INFO - Running setup.py install for blobuploader 06:05:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:05:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:05:51 INFO - Running setup.py install for requests 06:05:51 INFO - Running setup.py install for docopt 06:05:51 INFO - Successfully installed blobuploader requests docopt 06:05:51 INFO - Cleaning up... 06:05:51 INFO - Return code: 0 06:05:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:05:51 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')]} 06:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:51 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')]} 06:05:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:51 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 0x1104e7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11045d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa013577c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102fbd30>, '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 0x110121db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102f3b20>, '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.fJq7NTaYHJ/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.5VpPRSVL29/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 06:05:51 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 06:05:51 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 06:05:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fJq7NTaYHJ/Render', 06:05:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:05:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:05:51 INFO - 'HOME': '/Users/cltbld', 06:05:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:05:51 INFO - 'LOGNAME': 'cltbld', 06:05:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:51 INFO - 'MOZ_NO_REMOTE': '1', 06:05:51 INFO - 'NO_EM_RESTART': '1', 06:05:51 INFO - 'PAGER': '/bin/cat', 06:05:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:05:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:51 INFO - 'PWD': '/builds/slave/test', 06:05:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:05:51 INFO - 'SHELL': '/bin/bash', 06:05:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5VpPRSVL29/Listeners', 06:05:51 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 06:05:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:05:51 INFO - 'USER': 'cltbld', 06:05:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:05:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:05:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:51 INFO - 'XPC_FLAGS': '0x0', 06:05:51 INFO - 'XPC_SERVICE_NAME': '0', 06:05:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:05:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:05:52 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-3L5iA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:05:52 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-TS_38U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:05:52 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-Ikemf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:05:52 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-iWvqbQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:05:52 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-O9N22H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:05:52 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-Xlmexo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:05:52 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-wX_LtG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:05:52 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-TTbT8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:05:52 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-5I4PAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:05:53 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-NG6hRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:05:53 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-BG7ARJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:05:53 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-7vGUvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:05:53 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-WWRI8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:05:53 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-mKVqSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:05:53 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-l3wWP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:05:53 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-PVBcje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:05:53 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-2L73mJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:05:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:05:53 INFO - Running setup.py install for manifestparser 06:05:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:05:53 INFO - Running setup.py install for mozcrash 06:05:54 INFO - Running setup.py install for mozdebug 06:05:54 INFO - Running setup.py install for mozdevice 06:05:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:05:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:05:54 INFO - Running setup.py install for mozfile 06:05:54 INFO - Running setup.py install for mozhttpd 06:05:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:05:54 INFO - Running setup.py install for mozinfo 06:05:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:05:54 INFO - Running setup.py install for mozInstall 06:05:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:05:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:05:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:05:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:05:55 INFO - Running setup.py install for mozleak 06:05:55 INFO - Running setup.py install for mozlog 06:05:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:05:55 INFO - Running setup.py install for moznetwork 06:05:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:05:55 INFO - Running setup.py install for mozprocess 06:05:55 INFO - Running setup.py install for mozprofile 06:05:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:05:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:05:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:05:55 INFO - Running setup.py install for mozrunner 06:05:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:05:55 INFO - Running setup.py install for mozscreenshot 06:05:56 INFO - Running setup.py install for moztest 06:05:56 INFO - Running setup.py install for mozversion 06:05:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:05:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:05:56 INFO - Cleaning up... 06:05:56 INFO - Return code: 0 06:05:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:05:56 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')]} 06:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:56 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')]} 06:05:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:56 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 0x1104e7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11045d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa013577c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102fbd30>, '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 0x110121db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102f3b20>, '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.fJq7NTaYHJ/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.5VpPRSVL29/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 06:05:56 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 06:05:56 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 06:05:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fJq7NTaYHJ/Render', 06:05:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:05:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:05:56 INFO - 'HOME': '/Users/cltbld', 06:05:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:05:56 INFO - 'LOGNAME': 'cltbld', 06:05:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:56 INFO - 'MOZ_NO_REMOTE': '1', 06:05:56 INFO - 'NO_EM_RESTART': '1', 06:05:56 INFO - 'PAGER': '/bin/cat', 06:05:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:05:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:56 INFO - 'PWD': '/builds/slave/test', 06:05:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:05:56 INFO - 'SHELL': '/bin/bash', 06:05:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5VpPRSVL29/Listeners', 06:05:56 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 06:05:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:05:56 INFO - 'USER': 'cltbld', 06:05:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:05:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:05:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:56 INFO - 'XPC_FLAGS': '0x0', 06:05:56 INFO - 'XPC_SERVICE_NAME': '0', 06:05:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:05:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:05:56 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-HeMaCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:05:56 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)) 06:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:05:56 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-ZNqY4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:05:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 06:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:05:56 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-xUIgOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:05:57 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)) 06:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:05:57 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-Zjbjzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:05:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 06:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:05:57 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-c622NL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:05:57 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)) 06:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:05:57 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-on9zxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:05:57 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)) 06:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:05:57 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-wS7ypM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:05:57 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)) 06:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:05:57 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-3F5ErN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:05:57 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)) 06:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:05:57 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-1APCNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:05:57 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)) 06:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:05:57 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-DxCQx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:05:57 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)) 06:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:05:57 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-HYhnc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:05:57 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)) 06:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:05:57 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-od6gda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:05:57 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)) 06:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:05:57 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-MRIjtK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:05:58 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)) 06:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:05:58 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-AadZqX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:05:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 06:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:05:58 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-jJdgSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:05:58 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)) 06:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:05:58 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-4A31Zo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:05:58 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)) 06:05:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:05:58 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-fRUSXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:05:58 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)) 06:05:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:05:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:05:58 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)) 06:05:58 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:05:58 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:05:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:05:58 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 06:05:58 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 06:05:58 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 06:05:58 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 06:05:58 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 06:05:58 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 06:06:01 INFO - Downloading blessings-1.6.tar.gz 06:06:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:06:01 INFO - Installing collected packages: blessings 06:06:01 INFO - Running setup.py install for blessings 06:06:01 INFO - Successfully installed blessings 06:06:01 INFO - Cleaning up... 06:06:01 INFO - Return code: 0 06:06:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:06:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:06:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:06:01 INFO - Reading from file tmpfile_stdout 06:06:01 INFO - Current package versions: 06:06:01 INFO - blessings == 1.6 06:06:01 INFO - blobuploader == 1.2.4 06:06:01 INFO - docopt == 0.6.1 06:06:01 INFO - functools32 == 3.2.3-2 06:06:01 INFO - jsonschema == 2.5.1 06:06:01 INFO - manifestparser == 1.1 06:06:01 INFO - mozInstall == 1.12 06:06:01 INFO - mozcrash == 0.17 06:06:01 INFO - mozdebug == 0.1 06:06:01 INFO - mozdevice == 0.48 06:06:01 INFO - mozfile == 1.2 06:06:01 INFO - mozhttpd == 0.7 06:06:01 INFO - mozinfo == 0.9 06:06:01 INFO - mozleak == 0.1 06:06:01 INFO - mozlog == 3.4 06:06:01 INFO - moznetwork == 0.27 06:06:01 INFO - mozprocess == 0.23 06:06:01 INFO - mozprofile == 0.28 06:06:01 INFO - mozrunner == 6.12 06:06:01 INFO - mozscreenshot == 0.1 06:06:01 INFO - mozsystemmonitor == 0.3 06:06:01 INFO - moztest == 0.7 06:06:01 INFO - mozversion == 1.4 06:06:01 INFO - psutil == 3.1.1 06:06:01 INFO - requests == 1.2.3 06:06:01 INFO - wsgiref == 0.1.2 06:06:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:06:01 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')]} 06:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:06:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:06:01 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')]} 06:06:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:06:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:06:01 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 0x1104e7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11045d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa013577c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102fbd30>, '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 0x110121db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102f3b20>, '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.fJq7NTaYHJ/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.5VpPRSVL29/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 06:06:01 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 06:06:01 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 06:06:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fJq7NTaYHJ/Render', 06:06:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:06:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:06:01 INFO - 'HOME': '/Users/cltbld', 06:06:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:06:01 INFO - 'LOGNAME': 'cltbld', 06:06:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:06:01 INFO - 'MOZ_NO_REMOTE': '1', 06:06:01 INFO - 'NO_EM_RESTART': '1', 06:06:01 INFO - 'PAGER': '/bin/cat', 06:06:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:06:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:06:01 INFO - 'PWD': '/builds/slave/test', 06:06:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:06:01 INFO - 'SHELL': '/bin/bash', 06:06:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5VpPRSVL29/Listeners', 06:06:01 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 06:06:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:06:01 INFO - 'USER': 'cltbld', 06:06:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:06:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:06:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:06:01 INFO - 'XPC_FLAGS': '0x0', 06:06:01 INFO - 'XPC_SERVICE_NAME': '0', 06:06:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:06:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:06:01 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)) 06:06:01 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)) 06:06:01 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)) 06:06:01 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)) 06:06:01 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)) 06:06:01 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)) 06:06:01 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)) 06:06:01 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)) 06:06:01 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)) 06:06:01 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)) 06:06:01 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)) 06:06:01 INFO - Cleaning up... 06:06:01 INFO - Return code: 0 06:06:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:06:01 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')]} 06:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:06:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:06:02 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')]} 06:06:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:06:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:06:02 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 0x1104e7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11045d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa013577c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102fbd30>, '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 0x110121db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102f3b20>, '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.fJq7NTaYHJ/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.5VpPRSVL29/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 06:06:02 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 06:06:02 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 06:06:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fJq7NTaYHJ/Render', 06:06:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:06:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:06:02 INFO - 'HOME': '/Users/cltbld', 06:06:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:06:02 INFO - 'LOGNAME': 'cltbld', 06:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:06:02 INFO - 'MOZ_NO_REMOTE': '1', 06:06:02 INFO - 'NO_EM_RESTART': '1', 06:06:02 INFO - 'PAGER': '/bin/cat', 06:06:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:06:02 INFO - 'PWD': '/builds/slave/test', 06:06:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:06:02 INFO - 'SHELL': '/bin/bash', 06:06:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5VpPRSVL29/Listeners', 06:06:02 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 06:06:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:06:02 INFO - 'USER': 'cltbld', 06:06:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:06:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:06:02 INFO - 'XPC_FLAGS': '0x0', 06:06:02 INFO - 'XPC_SERVICE_NAME': '0', 06:06:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:06:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:06:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:06:02 INFO - Cleaning up... 06:06:02 INFO - Return code: 0 06:06:02 INFO - Running post-action listener: _resource_record_post_action 06:06:02 INFO - Running post-action listener: _start_resource_monitoring 06:06:02 INFO - Starting resource monitoring. 06:06:02 INFO - [mozharness: 2016-11-03 13:06:02.314243Z] Finished create-virtualenv step (success) 06:06:02 INFO - [mozharness: 2016-11-03 13:06:02.315224Z] Running install step. 06:06:02 INFO - Running pre-action listener: _resource_record_pre_action 06:06:02 INFO - Running main action method: install 06:06:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:06:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:06:02 INFO - Reading from file tmpfile_stdout 06:06:02 INFO - Detecting whether we're running mozinstall >=1.0... 06:06:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:06:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:06:02 INFO - Reading from file tmpfile_stdout 06:06:02 INFO - Output received: 06:06:02 INFO - Usage: mozinstall [options] installer 06:06:02 INFO - Options: 06:06:02 INFO - -h, --help show this help message and exit 06:06:02 INFO - -d DEST, --destination=DEST 06:06:02 INFO - Directory to install application into. [default: 06:06:02 INFO - "/builds/slave/test"] 06:06:02 INFO - --app=APP Application being installed. [default: firefox] 06:06:02 INFO - mkdir: /builds/slave/test/build/application 06:06:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:06:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 06:06:37 INFO - Reading from file tmpfile_stdout 06:06:37 INFO - Output received: 06:06:37 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:06:37 INFO - Running post-action listener: _resource_record_post_action 06:06:37 INFO - [mozharness: 2016-11-03 13:06:37.089781Z] Finished install step (success) 06:06:37 INFO - [mozharness: 2016-11-03 13:06:37.089910Z] Running run-tests step. 06:06:37 INFO - Running pre-action listener: _resource_record_pre_action 06:06:37 INFO - Running main action method: run_tests 06:06:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:06:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:06:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:06:37 INFO - 2016-11-03 06:06:37.104 screenresolution[1647:7833] starting screenresolution argv=screenresolution get 06:06:37 INFO - 2016-11-03 06:06:37.107 screenresolution[1647:7833] Display 0: 1600x1200x32@60 06:06:37 INFO - 2016-11-03 06:06:37.112 screenresolution[1648:7835] starting screenresolution argv=screenresolution list 06:06:37 INFO - Available Modes on Display 0 06:06:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:06:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:06:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:06:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:06:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:06:37 INFO - Intel Iris: 06:06:37 INFO - Chipset Model: Intel Iris 06:06:37 INFO - Type: GPU 06:06:37 INFO - Bus: Built-In 06:06:37 INFO - VRAM (Dynamic, Max): 1536 MB 06:06:37 INFO - Vendor: Intel (0x8086) 06:06:37 INFO - Device ID: 0x0a2e 06:06:37 INFO - Revision ID: 0x0009 06:06:37 INFO - Displays: 06:06:37 INFO - Display: 06:06:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:06:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:06:37 INFO - Display Serial Number: 1600x1200 60 06:06:37 INFO - Main Display: Yes 06:06:37 INFO - Mirror: Off 06:06:37 INFO - Online: Yes 06:06:37 INFO - Rotation: Supported 06:06:37 INFO - Return code: 0 06:06:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:06:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:06:37 INFO - Python 2.7.3 06:06:37 INFO - Return code: 0 06:06:37 INFO - grabbing minidump binary from tooltool 06:06:37 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')]} 06:06:37 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 0x1102fbd30>, '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 0x110121db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102f3b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:06:37 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 06:06:37 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 06:06:37 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 06:06:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:06:37 INFO - Return code: 0 06:06:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:06:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:06:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:06:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:06:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:06:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d5pL2COtQLq5g6XMuAO1Pg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0189', '--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 06:06:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Cedar --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/d5pL2COtQLq5g6XMuAO1Pg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0189 --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 06:06:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fJq7NTaYHJ/Render', 06:06:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:06:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:06:37 INFO - 'HOME': '/Users/cltbld', 06:06:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:06:37 INFO - 'LOGNAME': 'cltbld', 06:06:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:06:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:06:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:06:37 INFO - 'MOZ_NO_REMOTE': '1', 06:06:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:06:37 INFO - 'NO_EM_RESTART': '1', 06:06:37 INFO - 'PAGER': '/bin/cat', 06:06:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:06:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:06:37 INFO - 'PWD': '/builds/slave/test', 06:06:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:06:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:06:37 INFO - 'SHELL': '/bin/bash', 06:06:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5VpPRSVL29/Listeners', 06:06:37 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 06:06:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:06:37 INFO - 'USER': 'cltbld', 06:06:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:06:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:06:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:06:37 INFO - 'XPC_FLAGS': '0x0', 06:06:37 INFO - 'XPC_SERVICE_NAME': '0', 06:06:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:06:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d5pL2COtQLq5g6XMuAO1Pg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0189', '--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 06:06:37 INFO - mozversion application_buildid: 20161103034324 06:06:37 INFO - mozversion application_changeset: d01ee5312491327d772f064f0a525fd4a492e837 06:06:37 INFO - mozversion application_display_name: Nightly 06:06:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:06:37 INFO - mozversion application_name: Firefox 06:06:37 INFO - mozversion application_remotingname: firefox 06:06:37 INFO - mozversion application_repository: https://hg.mozilla.org/projects/cedar 06:06:37 INFO - mozversion application_vendor: Mozilla 06:06:37 INFO - mozversion application_version: 52.0a1 06:06:37 INFO - mozversion platform_buildid: 20161103034324 06:06:37 INFO - mozversion platform_changeset: d01ee5312491327d772f064f0a525fd4a492e837 06:06:37 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/cedar 06:06:37 INFO - mozversion platform_version: 52.0a1 06:06:37 INFO - using testdate: 1478178397 06:06:37 INFO - actual date: 1478178397 06:06:37 INFO - starting webserver on 'localhost:49275' 06:06:37 INFO - SUITE-START | Running 2 tests 06:06:37 INFO - TEST-START | dromaeo_css 06:06:37 INFO - operating with platform_type : mac_ 06:06:37 INFO - Initialising browser for dromaeo_css test... 06:06:37 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/tmpea7khv/profile http://localhost:49275/getInfo.html) 06:06:40 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 06:06:40 INFO - PROCESS | 1658 | colorDepth:24 06:06:40 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 06:06:40 INFO - PROCESS | 1658 | __metrics 06:06:40 INFO - PROCESS | 1658 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:06:40 INFO - PROCESS | 1658 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:06:40 INFO - TEST-INFO | 1658: exit 0 06:06:40 INFO - Browser initialized. 06:06:40 INFO - Running cycle 1/1 for dromaeo_css test... 06:06:40 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/tmpea7khv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:06:52 INFO - PROCESS | 1660 | RSS: Main: 240758784 06:06:52 INFO - PROCESS | 1660 | 06:07:44 INFO - PROCESS | 1660 | 1478178464407 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] 06:09:56 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 06:10:00 INFO - PROCESS | 1660 | RSS: Main: 473210880 06:10:00 INFO - PROCESS | 1660 | 06:13:03 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 06:13:04 INFO - PROCESS | 1660 | RSS: Main: 373940224 06:13:04 INFO - PROCESS | 1660 | 06:16:06 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 06:16:07 INFO - PROCESS | 1660 | RSS: Main: 346001408 06:16:07 INFO - PROCESS | 1660 | 06:19:09 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 06:19:10 INFO - PROCESS | 1660 | RSS: Main: 343625728 06:19:10 INFO - PROCESS | 1660 | 06:22:13 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 06:22:14 INFO - PROCESS | 1660 | RSS: Main: 331886592 06:22:14 INFO - PROCESS | 1660 | 06:25:17 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 06:25:17 INFO - PROCESS | 1660 | RSS: Main: 389763072 06:25:17 INFO - PROCESS | 1660 | 06:25:17 INFO - PROCESS | 1660 | __start_tp_report 06:25:17 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 06:25:17 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 06:25:17 INFO - PROCESS | 1660 | |i|pagename|runs| 06:25:17 INFO - PROCESS | 1660 | |0;dojo.html;3272.689094536019;3292.86828526859;3299.670032996702;3311.7350611951015;3349.9950014995497;5387.568994480442;5461.262729531512;5490.81947381313;5530.364008139065;5534.806281780134;4755.500672429397;5338.3060202173665;5445.482679145484;5605.243292155557;5605.27131472908;4985.850424487271;5058.620603454738;5063.392392912837;5086.287919691246;5098.847034588968;5088.160453525164;5203.271541984125;5218.269442278084;5221.39953905302;5272.288241087462;5034.11902916988;5194.558462530689;5206.479352064801;5213.191955246943;5275.235090911816;5107.131787596118;5126.359205099363;5141.177411614161;5146.176611742103;5156.432792392834;5068.239764035387;5111.4121875984365;5124.154514505102;5125.974370128163;5127.154019586764;5527.668339899619;5568.972155139239;5569.331680198362;5581.358143813472;5584.636998595119;6013.248343957005;6015.969920150415;6016.09758536223;6023.608465449732;6041.848953776147;6053.727582258809;6095.438338978142;6127.5404344674325;6139.201903752528;6140.508759299245;5572.4706152915405;5627.606067575231;5628.324601047901;5629.408912064216;5638.097904335327;6183.81448556544;6279.591826531261;6284.654344011124;6296.6851657417865;6334.714937827809;5617.634853734494;5960;5973.104034394875;5976.342602313742;5976.880462390728;5920.5559583031445;6003.309619393738;6005.909911351333;6049.153118563405;6146.078088286793;5986.700664966735;6037.63774173551;6041.5468839837185;6098.756049758049;6112;6073.39266073398;6078.665673388006;6087.756489740449;6097.542684298695;6132.049532322497;4758.666893317504;4800.183968725325;4841.878953026203;4842.5157484251995;4848.321235027099;4263.147370525907;4282.785860706952;4344.847930322424;4358.6295164911335;4402.581754733295;5617.43825617435;5631.549476041907;5652.095664693629;5677.063284558084;5732.942670573324;6191.721372538246;6197.349278325801;6205.596636218631;6208.0998255253635;6213.1922850029205;5489.533389661923;5607.018771714934;5608;5629.943700563023;5681.375048744635;5252.422233554383;5258.158694608921;5259.421463638997;5289.418164001957;5302.946970530323;6371.331010243857;6372.139761132188;6376.426121649074;6378.52161087911;6385.489160867212;6007.639541627516;6172.135900973957;6172.9074063889975;6189.412005859436;6195.752169913153;6274.435300822765;6277.372262773686;6329.7468101275435;6342.587731797418;6346.746130154742;6030.758769649165;6038.064100064497;6038.245219347582;6054.243219597551;6061.72722227492;6039.063945088518;6128.050152226412;6175.4750846176785;6176.289726681489;6197.876042479035;5764.279465066867;5772.076467765138;5803.216565763568;5879.147523609138;5915.112733090071;5878.118282257696;5887.882242355215;5897.941020589739;5907.704614769158;5916.67458289781;5198;5332.82677810881;5705.372409035086;5705.972924873563;5709.97220500314;4815.975920120377;5815.76736930518;5842.38654941225;5866.826634673168;5975.193348897843;5786.884262314646;5786.971065144648;5787.363390027178;5788.971055144697;5796.04365279741 06:25:17 INFO - PROCESS | 1660 | |1;ext.html;480.6419217682825;482.8165297187068;513.463430714903;520.2378515474829;537.5914305128107;29844;31249.53125703116;39100.804495977514;39970.60029399705;40034.19931601366;40687;41078.79460602693;41120.383194252114;41127.70978321727;41192.38211426831;8470.534120623362;9375.81248375032;9565.282603804742;9570.186534144606;9582.856257156149;8540.70107546236;8688.782780430476;8703.869441958344;8707.695230666928;11300.039496642796;11297.717557061098;11300.547978080867;11332.036776873934;11506.482208300604;11578.47896844644;11366;11424.828627570592;11463.484143213574;11476;11498.367589782558;8423.536705481196;8690.608922598498;8726.912730872673;11286.209965302432;11373.260738052;31107.533386999214;31449;38866.417003744966;39294.60705392966;39471.210575788326;3391.576052993376;3911.2790372236127;3949.723519353646;3957.406389041638;4061.1877624475223;27882.605869706433;28125.43749125006;29496;30467.695323046708;30915.22711932197;2606.973930260692;2666.386731051869;3214.4214041472524;3274.5251938468787;3348.430766769655;481649;482592.58703706256;483299;484037;488451;57621;57751.04858746901;57784;58210.417895821345;58311.125333120035;61003.38996609977;61024.389756102755;61035.38964610386;61115;61204.69397652983;15122.848771512365;15338.233088345538;15347.923260383626;15353.309101090254;15371.000884942443;12153.696157595954;12174.086943479275;12180;12194.012466945655;12198.939005305094;13922.354752596973;14282.3572939218;14300;15484.922575387276;16015.839841601435;5921.5558833086825;6093.390660933871;6152.784997400932;6187.659678717714;6192.566520343623;898.3397203055749;964.4550828781715;1000.0899181744578;1001.6344034427382;1049.2655141401049;22394.664080038485;23267.53464930692;23697.612019056087;23758.64362034571;23806.765986340313;1035.6219979707353;1048.4810019040624;1058.1429042475465;1109.9611513597147;1179.2983175010854;13338.466461341437;13600.863991360158;15583.844161558465;15598.688026239412;16000;521202;671431;678590;682733;857730;48558;49895.75052124716;49939.751506211906;54343.18485222725;55071.449285507435;1051.5636011055478;1337.197681391177;1354.7967804829354;1356;1358.3683587132032;29965.400691986473;30014;30113.82016712208;30224.09327720172;30381;48873.02253954972;49771.751141244065;49775.502244977084;49809;49833.50499485021;436595;437863;447014.76492617326;474855;476690;24648.260552183463;24651.876740616182;24870.253892383258;24949.126780562594;25085.24744257675;44558.440454583935;44659;44722.60886856156;45088;45832;32448.702051918604;36411;36778;37630.811845940596;38414.23171536498;29787.851060745423;34125.65874341324;34560.135996600286;35392.646073538934;35495.290094198484;30662.846685766428;36255.81872090622;36612.33442926226;36875.631243688294;37094.629053710196;29267;30932.381352373275;32874.17814554655;32989;33285.66714332825;22422;22626.886865565568;23585.546695444904;24384.756152438957;25045.499090017733 06:25:17 INFO - PROCESS | 1660 | |2;jquery.html;325.3379372975994;349.1515617050569;370.30198076625567;371.8271003983147;401.6846775281403;15114.848851511482;15363.3086511107;18017.90991045043;19418.019306042264;20213.494662633442;19505.41483755486;19883.204671813146;19941.404687624992;20065.799342006576;20088.8995555022;4562.452505699321;5921.171036054956;5965.254343207099;5975.223220981288;5983.9102413463615;5884.235049443566;5892.8214357128745;5902.144189092579;5945.346011938684;5971.98476259037;5630.943690563083;5884.6469211847425;5897.380775018625;5900.468957793798;5903.144044113601;5606.831795046155;5805.24531810864;5824.737886795105;5872.383399743029;5898.8230353089475;5124.359455068116;5125.8718532037;5127.974360128175;5128.871778205537;5132.8460146195675;22743.88628056866;24178.758212418;25119.985601727727;25175.37061573457;25323;2520.810939179569;2530.215633153728;2836.602875597418;3067.7852550321486;3186.23530352716;14215.43138274478;15017.624559386102;15088.755917477794;15100.924495377563;15509.844901550952;1821.681205788995;1890.5368184794813;1891.3947536788232;1893.0818553001784;1898.1268616436455;111640.32539511914;113752.86247137588;113823;116310;117048.99999999914;10197.133243674223;10293.639722609672;10413.53139108742;10478.423686697304;10620.150387968944;11788;12505.56230531927;12507.499700011898;12602.621921342374;12612.432440540199;6386.712597933104;7652.885206721904;8169.30560902318;8643.394962352575;8646.3947523674;8376.706815261437;8424.410291279552;8749.300055995505;8840.292776577859;8896.466212027299;6505.674716264168;6570.8028759137305;6599.505037122139;6600.86798264032;6626.900596491057;1410.640286726878;1784.723367877981;1797.613513094691;1844.603410266799;1844.8339649431616;667.5827607745159;902.1249388093539;930.6184464369576;941.7363138321281;1002.5538635307219;15906.52280431589;21457.570848583255;21463.892680536497;21722.52439609655;21726.674099888514;798.9760307190794;943.6602822983721;962.8748262725801;968.8401413766791;1001.4592120254981;11090.722731931604;11384.71632651045;11422.543098276143;11530.884691152982;11580.247283926517;541715;571304;574045;577366;584076;113364;124424;125172;128470;128751;966.1546147121269;974.7660561465339;1000.6697789729371;1000.9849852252222;1005.4520286443906;18853.905730471808;19077.141528630968;19207.32774352891;19257.614847703248;19322;52930.735346323025;53089.46910530845;53462.73268633632;53759.73120134374;54613;75780.484390313;75815.24184758082;76282.75313845176;77135;77404.2259577397;6740.427063699641;7657.272559106876;7717.151113377637;7814.609269536614;7883.6846526138315;12652.746945061232;12869.264069264069;12971.35143242853;13046.152000119962;13482.52811151605;11010;11048.337099774039;11193.104551635686;11307.717307067389;11386.886131138583;9954.402735835873;10929.672109836718;11135.164862635496;11333;11387.544498219979;8523.914760852313;9227;11369.658910232707;11416.885831141915;11629.76740465203;6914.170299564084;7754.302112809649;7833.92166078332;7846.764597062097;7867.645955931882;9108.817823643358;9541.761455963657;11050.502727377127;11258.043066339453;11291.040261577858 06:25:17 INFO - PROCESS | 1660 | |3;mootools.html;1467.053750331036;1505.5859638599384;1660.4271526323414;1822.4077174918154;1850.9444716658497;7978.800529986746;8378.371622128341;8378.539180345078;8388.83222335553;8388.874166887486;7358.411327093833;7661.92338076619;7676.846463070749;8000.559969201691;8220.794480138;2260.457490202348;2296.9310920672406;2298.069281940817;2300.64340027296;2300.7584203658544;1985.9702104468445;2285.2915596165158;2308.319045881469;2328.860268383902;2330.1844354475884;2270.5231901300663;2273.9886300568473;2288.5079707862806;2302.7697230277004;2303.9884800576056;2256.153942271632;2257.8758168300737;2275.533515629292;2275.874826884529;2277.646964720471;2281.3954302109955;2295.885205739706;2298.253067752987;2298.3564601911494;2300.8389412741117;8155.79610509742;8344.749657510285;8363.832723345498;8370.53962032088;8387.874181887277;4981.676191047571;5153.845384638429;5162.12243918531;5162.148245539482;5166.896662066738;3197.4244635965515;3312.734981201498;3513.086597484647;3524.6475352464804;3532.028692109665;1018.1854516386935;1029.788893276884;1046.5709059285657;1060.9946950265276;1063.1813503602261;10825.188110891635;10828.675139745821;10992.890071099268;10995.230333876632;11001.724956876062;4344.413504176959;4442.400275962768;4526.479454862667;4529.54704529551;4588.747618880927;9358.953205233931;9365;9370.10983956523;9374.765630859147;9390.812183756423;5168.53483186515;5173.534381905646;5173.767180476888;5175;5181.948180518147;4236.004538933348;4400.075984043387;4488.102379524108;4701.506341834127;4761.642876784255;3570.5001299817527;3623.601403845575;3690.132818787583;3708.0173753955223;3725.0501122213664;1198.17924721566;1207.8309036734863;1212.2302338015425;1220.1458978714757;1225.503671013241;770.9498882572615;794.6384395100215;897;897.6768363389175;955.2835373469898;4530.61489773373;4610.216263235258;5386.649867758583;5807.68057756819;5830.3586605473365;860.9483430994161;869.3957699398984;876.5836227791875;938.3572253006712;1001.5843424978552;3070.846457677107;3697.6487233712755;3769.246150769857;3843.3466310727244;3855.4216867469545;9853.901460985442;10149.594016239416;10257.33327333721;10277.229207809443;10314.793704125876;10216.088414801747;10220.591176352862;10221.23340749432;10237.078662920372;10245.231607629457;7349.77950661481;7580.279873412127;7802.570858602831;7878.4091193161885;7888.64501097452;4834.830780922651;5031.295618613471;5594.804181853616;5712.885742285214;5847.502962248256;9260.166585007382;9267.119623635745;9309.72070837876;9346.53267336644;9460.432374057578;9445.913719922297;9487.193588545051;9503;9585.281103917094;9693.369930954465;6576.506761992965;6799.048133261248;6808.217055038734;6978.651067446506;7222.927770722225;7372.63136843145;7520.887186692314;7523.623818809147;7743.651535680795;7823.647935843014;7040.155181378267;7109.680064397011;7111.288871112847;7201.71193152268;7285.307895749896;6976.651167441506;6990.26602206761;7030.578165309893;7060.082189315356;7113.6443177839865;6662.300458451793;6699.899501507579;6748.763793267212;6769.89845152333;6786.796396108125;4459.684393104107;4641.6286697064825;4776.641751868554;4824.638152138534;4943.65394422387;3869.438931354994;4331.068820203672;4589.885252868705;4807.423109226916;4903.239997800347 06:25:17 INFO - PROCESS | 1660 | |4;prototype.html;294.5611039551069;300.8210114981585;303.84503903009465;307.8106964217007;309.5001572460477;4411.294192929132;4985.9750701246485;5059.5193456621655;5060.519250671189;5064.468230835764;4050.3721923101966;4993.500649935014;5010.123228435027;5068.366454193226;5089.414717307511;3639.5450568678916;3758.004128905842;3791.6729144799306;3796.791176485292;3881.844726210948;3285.802851828886;3843.2121415109973;3863.194753168127;3879.282332768447;3890.455336252927;3844.5587052221763;3850.5379354477363;3860.092878173627;3880.7477513961644;3903.2974064668347;3298.5217143514055;3633.1652515479514;3868.400397938324;3874.8643797466952;3902.6682731967817;3366.5118557809224;3377.2475432522415;3384.272381437978;3392.6268110507826;3393.304372603635;4147.6474499667265;4827.637927155442;4836.105320515716;4840.886596082921;4872.731999740013;3713.3846776652244;4234.724742891703;4250.659947204247;4280.828766849322;4336.197803406349;5177.404598471148;5190.728271573489;5198.454162312978;5199.220116982445;5202.479752024805;3241.2221066944;3686.944695829565;3694.261147770457;3697.280764444546;3729.3287208302495;4391.736495810262;4706.082313948781;5253.9072252459255;5418.7019713915715;5529.695866727328;3395.9490607640905;3687.8524859005875;3738.5887552369218;3749.0692293468887;3758.661720445173;3528.665411186404;3804.2201348723447;3815.37046387343;3824;3844.6539811417106;4360.454943132108;4371.584699453547;4371.644790115074;4381.5618438155925;4421.823127074881;4810.807567697253;4985.401751789808;5175.3697585260525;5236.528712415901;5268.710220937808;1132.7822590715014;1284.036972270797;1285.1710646632869;1308.574713218208;1308.6586249094564;719.0795781399817;793.6666600027887;800.966752888767;815.3436483630734;816.7876352148365;4131.380292956021;4138.52406973196;4590.921133533617;4864.391951006124;4975.477574854661;4074.2055299216368;4579.313103034505;5239.502247286502;5503.036968530491;5536.0900489331925;4064.3293856513937;4707.293905914072;4933.432655244693;4976.751162441863;5112.948870511247;2033.7762846086919;2401.327628264089;2822.6753923299084;2848.3591191982055;2852.944410568062;5522.889542209214;5568.883824146798;5597.51665808561;5602.582424720917;5639.984802735547;5263.894722105537;5463.071277882769;5483.036543589619;5530.474604912527;5533.071519221317;4657.301404789308;5098.6685865417885;5474.835754927359;5608.607397482218;5625.774969001194;5350.464953504618;5360.3299587551555;5425.565954723692;5429.647072940246;5439.292891924025;4981.8007279709855;5278.047122564676;5312.574994000393;5356.223347614652;5364.517193452608;4343.175866136167;5249;5561.943230786138;5598.3282006159525;5611.971940140274;3275.5414242006614;3310.8841190558214;3476.2526056897887;3741.8690345837763;3775.905602359963;5177.637565370388;5362.9463705364005;5384.353877534721;5435.673859568438;5483.8080667176455;4585.633149348111;4602.286645569942;5026.447090819934;5236.816711415082;5249.553787927916;4504.2793153095345;4550.5859316462975;4551.726896386227;5083.949160508348;5237.057329680694;4608.677392582487;4835;5096.1716247483;5200.8818104107795;5206.55744261742;5066.847994560169;5243.947560524346;5314.548263397654;5325.547328477122;5336.199570064521;4801.935167877846;5136.434992150935;5136.794528218829;5146.6911985281;5183.403908550565 06:25:17 INFO - PROCESS | 1660 | |5;yui.html;691.889297712366;699.6326928362612;727.3926271563248;732.3079689693238;747.1892996099234;14337.71324573508;14381.424743010293;14686.63283417915;15020.624484387896;15200.847991520082;13225;13486.865131348684;13496.392662330194;13503.797443038362;13511.662208444794;820.9753707388758;825.8141918068446;828.4490813608973;829.0383155539575;829.1501211258447;660.1550015979553;685.5509641185007;808.3896658023184;837.4431003382743;838.4256784102909;902.1474706402453;902.4946030223064;906.3247880329164;906.3972458315212;907.6324088744069;898.012186594747;898.1871406377239;898.586650140936;900.1043961258524;900.8468560344725;513.4942082049179;531.9787208511655;532.0954377558166;532.2149829002229;670.5004771445256;12411.317377544232;14004.0197186197;14617.19605421712;14623;14661.486847960377;13676;13828.446862125504;13944.790828137484;13971.58085257444;13993.790093148611;11163.386013769239;11260.774784504347;11451.484683189194;11459.885401145964;11517.712057198552;3655;3707.277080969212;3715.814209289552;3719.033051406627;3841.635044670752;84514;85227;85797.57101214454;86705.13294867097;88693.55653221693;10464.372137671764;10484.475776211159;10624.68125956207;10729;11141.387223702774;21197.78802211989;21238;21254;21279.255226067013;21297.254596089064;7379.6679149438405;7480.812979675443;7762.883556746653;7811.960940195263;7914.564698941614;3629.891103266906;4293.162833247487;4370.278903980871;4394.428724265825;4577.542245775462;3434.4504879219203;3517.751198324558;3540.415831387844;3553.378158822196;3554.662307080823;659.2945548263313;660.1714847865993;663.6781161136845;667.9098321726602;670.5339788846802;588.3028611095865;609.7195290166485;652.5399593286721;655.9081728558006;686.4817063117315;8646.740597782076;8684.305255579538;9162;9267.953660231791;9294.814103717888;519.8934218485201;627.3694936588699;649.217692680319;682.5597489619267;689.4693779808816;3965.5637879833193;4364.4980827204645;4632.884177895512;4854.660173787872;4874.618009638294;111065.44467277612;112384;113346.43326783479;114093;120023.39988300177;63663.40841479;64797.67601161964;64997.67501162464;65002.67498662571;96099.51950240204;57140;62296.37703622906;68841;86271;89726.10273897307;9549.952250238704;9584.76038099053;9604.471754053595;9621.9037809621;9669.371490853073;46100;46754.76622616865;47317;47355.28967065566;47448.05103897972;62643.373566263755;63867.52927295045;66540.6672966632;67510.66244668745;68124.3187568118;11838.408079595814;12236.531616206112;12551.309677967434;12578.056645751789;13059.151155174883;13404.798928015893;13916.234607096707;14197.361118749888;14398.496052638107;14863.40546378176;12883.871161288267;12997.155184913328;13180.209187448783;13275.004374671746;13745.518906838213;13071.869281307065;13230.07389482727;13244.80132798028;13464.192148471124;13533.052686311863;12666.683332916382;12741.936290318488;12759.872401275868;12956.416961236955;12964.35178241103;11230.66308010761;11290.096792256436;11494.310341379543;11527;11656.06751459898;10706.946465267623;11052;11200.047995920439;11273.731618104392;11355.659330220107 06:25:17 INFO - PROCESS | 1660 | __end_tp_report 06:25:17 INFO - PROCESS | 1660 | __start_cc_report 06:25:17 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,2948 06:25:17 INFO - PROCESS | 1660 | __end_cc_report 06:25:17 INFO - PROCESS | 1660 | __startTimestamp1478179517677__endTimestamp 06:25:17 INFO - PROCESS | 1660 | 06:25:17 INFO - PROCESS | 1660 | ------- Summary: start ------- 06:25:17 INFO - PROCESS | 1660 | Number of tests: 6 06:25:17 INFO - PROCESS | 1660 | 06:25:17 INFO - PROCESS | 1660 | [#0] dojo.html Cycles:165 Average:5609.72 Median:5764.28 stddev:635.07 (11.0%) stddev-sans-first:609.98 06:25:17 INFO - PROCESS | 1660 | Values: 3272.7 3292.9 3299.7 3311.7 3350.0 5387.6 5461.3 5490.8 5530.4 5534.8 4755.5 5338.3 5445.5 5605.2 5605.3 4985.9 5058.6 5063.4 5086.3 5098.8 5088.2 5203.3 5218.3 5221.4 5272.3 5034.1 5194.6 5206.5 5213.2 5275.2 5107.1 5126.4 5141.2 5146.2 5156.4 5068.2 5111.4 5124.2 5126.0 5127.2 5527.7 5569.0 5569.3 5581.4 5584.6 6013.2 6016.0 6016.1 6023.6 6041.8 6053.7 6095.4 6127.5 6139.2 6140.5 5572.5 5627.6 5628.3 5629.4 5638.1 6183.8 6279.6 6284.7 6296.7 6334.7 5617.6 5960.0 5973.1 5976.3 5976.9 5920.6 6003.3 6005.9 6049.2 6146.1 5986.7 6037.6 6041.5 6098.8 6112.0 6073.4 6078.7 6087.8 6097.5 6132.0 4758.7 4800.2 4841.9 4842.5 4848.3 4263.1 4282.8 4344.8 4358.6 4402.6 5617.4 5631.5 5652.1 5677.1 5732.9 6191.7 6197.3 6205.6 6208.1 6213.2 5489.5 5607.0 5608.0 5629.9 5681.4 5252.4 5258.2 5259.4 5289.4 5302.9 6371.3 6372.1 6376.4 6378.5 6385.5 6007.6 6172.1 6172.9 6189.4 6195.8 6274.4 6277.4 6329.7 6342.6 6346.7 6030.8 6038.1 6038.2 6054.2 6061.7 6039.1 6128.1 6175.5 6176.3 6197.9 5764.3 5772.1 5803.2 5879.1 5915.1 5878.1 5887.9 5897.9 5907.7 5916.7 5198.0 5332.8 5705.4 5706.0 5710.0 4816.0 5815.8 5842.4 5866.8 5975.2 5786.9 5787.0 5787.4 5789.0 5796.0 06:25:17 INFO - PROCESS | 1660 | 06:25:17 INFO - PROCESS | 1660 | [#1] ext.html Cycles:180 Average:66477.06 Median:34976.39 stddev:148299.24 (424.0%) stddev-sans-first:148632.48 06:25:17 INFO - PROCESS | 1660 | Values: 480.6 482.8 513.5 520.2 537.6 29844.0 31249.5 39100.8 39970.6 40034.2 40687.0 41078.8 41120.4 41127.7 41192.4 8470.5 9375.8 9565.3 9570.2 9582.9 8540.7 8688.8 8703.9 8707.7 11300.0 11297.7 11300.5 11332.0 11506.5 11578.5 11366.0 11424.8 11463.5 11476.0 11498.4 8423.5 8690.6 8726.9 11286.2 11373.3 31107.5 31449.0 38866.4 39294.6 39471.2 3391.6 3911.3 3949.7 3957.4 4061.2 27882.6 28125.4 29496.0 30467.7 30915.2 2607.0 2666.4 3214.4 3274.5 3348.4 481649.0 482592.6 483299.0 484037.0 488451.0 57621.0 57751.0 57784.0 58210.4 58311.1 61003.4 61024.4 61035.4 61115.0 61204.7 15122.8 15338.2 15347.9 15353.3 15371.0 12153.7 12174.1 12180.0 12194.0 12198.9 13922.4 14282.4 14300.0 15484.9 16015.8 5921.6 6093.4 6152.8 6187.7 6192.6 898.3 964.5 1000.1 1001.6 1049.3 22394.7 23267.5 23697.6 23758.6 23806.8 1035.6 1048.5 1058.1 1110.0 1179.3 13338.5 13600.9 15583.8 15598.7 16000.0 521202.0 671431.0 678590.0 682733.0 857730.0 48558.0 49895.8 49939.8 54343.2 55071.4 1051.6 1337.2 1354.8 1356.0 1358.4 29965.4 30014.0 30113.8 30224.1 30381.0 48873.0 49771.8 49775.5 49809.0 49833.5 436595.0 437863.0 447014.8 474855.0 476690.0 24648.3 24651.9 24870.3 24949.1 25085.2 44558.4 44659.0 44722.6 45088.0 45832.0 32448.7 36411.0 36778.0 37630.8 38414.2 29787.9 34125.7 34560.1 35392.6 35495.3 30662.8 36255.8 36612.3 36875.6 37094.6 29267.0 30932.4 32874.2 32989.0 33285.7 22422.0 22626.9 23585.5 24384.8 25045.5 06:25:17 INFO - PROCESS | 1660 | 06:25:17 INFO - PROCESS | 1660 | [#2] jquery.html Cycles:180 Average:33930.36 Median:13926.61 stddev:95193.61 (683.5%) stddev-sans-first:95427.22 06:25:17 INFO - PROCESS | 1660 | Values: 325.3 349.2 370.3 371.8 401.7 15114.8 15363.3 18017.9 19418.0 20213.5 19505.4 19883.2 19941.4 20065.8 20088.9 4562.5 5921.2 5965.3 5975.2 5983.9 5884.2 5892.8 5902.1 5945.3 5972.0 5630.9 5884.6 5897.4 5900.5 5903.1 5606.8 5805.2 5824.7 5872.4 5898.8 5124.4 5125.9 5128.0 5128.9 5132.8 22743.9 24178.8 25120.0 25175.4 25323.0 2520.8 2530.2 2836.6 3067.8 3186.2 14215.4 15017.6 15088.8 15100.9 15509.8 1821.7 1890.5 1891.4 1893.1 1898.1 111640.3 113752.9 113823.0 116310.0 117049.0 10197.1 10293.6 10413.5 10478.4 10620.2 11788.0 12505.6 12507.5 12602.6 12612.4 6386.7 7652.9 8169.3 8643.4 8646.4 8376.7 8424.4 8749.3 8840.3 8896.5 6505.7 6570.8 6599.5 6600.9 6626.9 1410.6 1784.7 1797.6 1844.6 1844.8 667.6 902.1 930.6 941.7 1002.6 15906.5 21457.6 21463.9 21722.5 21726.7 799.0 943.7 962.9 968.8 1001.5 11090.7 11384.7 11422.5 11530.9 11580.2 541715.0 571304.0 574045.0 577366.0 584076.0 113364.0 124424.0 125172.0 128470.0 128751.0 966.2 974.8 1000.7 1001.0 1005.5 18853.9 19077.1 19207.3 19257.6 19322.0 52930.7 53089.5 53462.7 53759.7 54613.0 75780.5 75815.2 76282.8 77135.0 77404.2 6740.4 7657.3 7717.2 7814.6 7883.7 12652.7 12869.3 12971.4 13046.2 13482.5 11010.0 11048.3 11193.1 11307.7 11386.9 9954.4 10929.7 11135.2 11333.0 11387.5 8523.9 9227.0 11369.7 11416.9 11629.8 6914.2 7754.3 7833.9 7846.8 7867.6 9108.8 9541.8 11050.5 11258.0 11291.0 06:25:17 INFO - PROCESS | 1660 | 06:25:17 INFO - PROCESS | 1660 | [#3] mootools.html Cycles:180 Average:5390.32 Median:4869.04 stddev:2997.42 (61.6%) stddev-sans-first:2991.33 06:25:17 INFO - PROCESS | 1660 | Values: 1467.1 1505.6 1660.4 1822.4 1850.9 7978.8 8378.4 8378.5 8388.8 8388.9 7358.4 7661.9 7676.8 8000.6 8220.8 2260.5 2296.9 2298.1 2300.6 2300.8 1986.0 2285.3 2308.3 2328.9 2330.2 2270.5 2274.0 2288.5 2302.8 2304.0 2256.2 2257.9 2275.5 2275.9 2277.6 2281.4 2295.9 2298.3 2298.4 2300.8 8155.8 8344.7 8363.8 8370.5 8387.9 4981.7 5153.8 5162.1 5162.1 5166.9 3197.4 3312.7 3513.1 3524.6 3532.0 1018.2 1029.8 1046.6 1061.0 1063.2 10825.2 10828.7 10992.9 10995.2 11001.7 4344.4 4442.4 4526.5 4529.5 4588.7 9359.0 9365.0 9370.1 9374.8 9390.8 5168.5 5173.5 5173.8 5175.0 5181.9 4236.0 4400.1 4488.1 4701.5 4761.6 3570.5 3623.6 3690.1 3708.0 3725.1 1198.2 1207.8 1212.2 1220.1 1225.5 770.9 794.6 897.0 897.7 955.3 4530.6 4610.2 5386.6 5807.7 5830.4 860.9 869.4 876.6 938.4 1001.6 3070.8 3697.6 3769.2 3843.3 3855.4 9853.9 10149.6 10257.3 10277.2 10314.8 10216.1 10220.6 10221.2 10237.1 10245.2 7349.8 7580.3 7802.6 7878.4 7888.6 4834.8 5031.3 5594.8 5712.9 5847.5 9260.2 9267.1 9309.7 9346.5 9460.4 9445.9 9487.2 9503.0 9585.3 9693.4 6576.5 6799.0 6808.2 6978.7 7222.9 7372.6 7520.9 7523.6 7743.7 7823.6 7040.2 7109.7 7111.3 7201.7 7285.3 6976.7 6990.3 7030.6 7060.1 7113.6 6662.3 6699.9 6748.8 6769.9 6786.8 4459.7 4641.6 4776.6 4824.6 4943.7 3869.4 4331.1 4589.9 4807.4 4903.2 06:25:17 INFO - PROCESS | 1660 | 06:25:17 INFO - PROCESS | 1660 | [#4] prototype.html Cycles:180 Average:4259.10 Median:4806.37 stddev:1302.55 (27.1%) stddev-sans-first:1271.76 06:25:17 INFO - PROCESS | 1660 | Values: 294.6 300.8 303.8 307.8 309.5 4411.3 4986.0 5059.5 5060.5 5064.5 4050.4 4993.5 5010.1 5068.4 5089.4 3639.5 3758.0 3791.7 3796.8 3881.8 3285.8 3843.2 3863.2 3879.3 3890.5 3844.6 3850.5 3860.1 3880.7 3903.3 3298.5 3633.2 3868.4 3874.9 3902.7 3366.5 3377.2 3384.3 3392.6 3393.3 4147.6 4827.6 4836.1 4840.9 4872.7 3713.4 4234.7 4250.7 4280.8 4336.2 5177.4 5190.7 5198.5 5199.2 5202.5 3241.2 3686.9 3694.3 3697.3 3729.3 4391.7 4706.1 5253.9 5418.7 5529.7 3395.9 3687.9 3738.6 3749.1 3758.7 3528.7 3804.2 3815.4 3824.0 3844.7 4360.5 4371.6 4371.6 4381.6 4421.8 4810.8 4985.4 5175.4 5236.5 5268.7 1132.8 1284.0 1285.2 1308.6 1308.7 719.1 793.7 801.0 815.3 816.8 4131.4 4138.5 4590.9 4864.4 4975.5 4074.2 4579.3 5239.5 5503.0 5536.1 4064.3 4707.3 4933.4 4976.8 5112.9 2033.8 2401.3 2822.7 2848.4 2852.9 5522.9 5568.9 5597.5 5602.6 5640.0 5263.9 5463.1 5483.0 5530.5 5533.1 4657.3 5098.7 5474.8 5608.6 5625.8 5350.5 5360.3 5425.6 5429.6 5439.3 4981.8 5278.0 5312.6 5356.2 5364.5 4343.2 5249.0 5561.9 5598.3 5612.0 3275.5 3310.9 3476.3 3741.9 3775.9 5177.6 5362.9 5384.4 5435.7 5483.8 4585.6 4602.3 5026.4 5236.8 5249.6 4504.3 4550.6 4551.7 5083.9 5237.1 4608.7 4835.0 5096.2 5200.9 5206.6 5066.8 5243.9 5314.5 5325.5 5336.2 4801.9 5136.4 5136.8 5146.7 5183.4 06:25:17 INFO - PROCESS | 1660 | 06:25:17 INFO - PROCESS | 1660 | [#5] yui.html Cycles:180 Average:19270.65 Median:4485.99 stddev:27574.17 (614.7%) stddev-sans-first:27616.24 06:25:17 INFO - PROCESS | 1660 | Values: 691.9 699.6 727.4 732.3 747.2 14337.7 14381.4 14686.6 15020.6 15200.8 13225.0 13486.9 13496.4 13503.8 13511.7 821.0 825.8 828.4 829.0 829.2 660.2 685.6 808.4 837.4 838.4 902.1 902.5 906.3 906.4 907.6 898.0 898.2 898.6 900.1 900.8 513.5 532.0 532.1 532.2 670.5 12411.3 14004.0 14617.2 14623.0 14661.5 13676.0 13828.4 13944.8 13971.6 13993.8 11163.4 11260.8 11451.5 11459.9 11517.7 3655.0 3707.3 3715.8 3719.0 3841.6 84514.0 85227.0 85797.6 86705.1 88693.6 10464.4 10484.5 10624.7 10729.0 11141.4 21197.8 21238.0 21254.0 21279.3 21297.3 7379.7 7480.8 7762.9 7812.0 7914.6 3629.9 4293.2 4370.3 4394.4 4577.5 3434.5 3517.8 3540.4 3553.4 3554.7 659.3 660.2 663.7 667.9 670.5 588.3 609.7 652.5 655.9 686.5 8646.7 8684.3 9162.0 9268.0 9294.8 519.9 627.4 649.2 682.6 689.5 3965.6 4364.5 4632.9 4854.7 4874.6 111065.4 112384.0 113346.4 114093.0 120023.4 63663.4 64797.7 64997.7 65002.7 96099.5 57140.0 62296.4 68841.0 86271.0 89726.1 9550.0 9584.8 9604.5 9621.9 9669.4 46100.0 46754.8 47317.0 47355.3 47448.1 62643.4 63867.5 66540.7 67510.7 68124.3 11838.4 12236.5 12551.3 12578.1 13059.2 13404.8 13916.2 14197.4 14398.5 14863.4 12883.9 12997.2 13180.2 13275.0 13745.5 13071.9 13230.1 13244.8 13464.2 13533.1 12666.7 12741.9 12759.9 12956.4 12964.4 11230.7 11290.1 11494.3 11527.0 11656.1 10706.9 11052.0 11200.0 11273.7 11355.7 06:25:17 INFO - PROCESS | 1660 | -------- Summary: end -------- 06:25:17 INFO - PROCESS | 1660 | 06:25:18 INFO - TEST-INFO | 1660: exit 0 06:25:18 INFO - TEST-OK | dromaeo_css | took 1120614ms 06:25:18 INFO - TEST-START | kraken 06:25:18 INFO - operating with platform_type : mac_ 06:25:18 INFO - Initialising browser for kraken test... 06:25:18 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/tmpkRhcmG/profile http://localhost:49275/getInfo.html) 06:25:20 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 06:25:20 INFO - PROCESS | 1666 | colorDepth:24 06:25:20 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 06:25:20 INFO - PROCESS | 1666 | __metrics 06:25:20 INFO - PROCESS | 1666 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:25:20 INFO - PROCESS | 1666 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:25:21 INFO - TEST-INFO | 1666: exit 0 06:25:21 INFO - Browser initialized. 06:25:21 INFO - Running cycle 1/1 for kraken test... 06:25:21 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/tmpkRhcmG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:25:33 INFO - PROCESS | 1667 | RSS: Main: 240230400 06:25:33 INFO - PROCESS | 1667 | 06:25:35 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 06:25:36 INFO - PROCESS | 1667 | RSS: Main: 290189312 06:25:36 INFO - PROCESS | 1667 | 06:25:39 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 06:25:40 INFO - PROCESS | 1667 | RSS: Main: 290025472 06:25:40 INFO - PROCESS | 1667 | 06:25:43 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 06:25:44 INFO - PROCESS | 1667 | RSS: Main: 382652416 06:25:44 INFO - PROCESS | 1667 | 06:25:46 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 06:25:46 INFO - PROCESS | 1667 | RSS: Main: 283451392 06:25:46 INFO - PROCESS | 1667 | 06:25:48 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:25:49 INFO - PROCESS | 1667 | RSS: Main: 288063488 06:25:49 INFO - PROCESS | 1667 | 06:25:52 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 06:25:52 INFO - PROCESS | 1667 | RSS: Main: 324489216 06:25:52 INFO - PROCESS | 1667 | 06:25:55 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 06:25:56 INFO - PROCESS | 1667 | RSS: Main: 326782976 06:25:56 INFO - PROCESS | 1667 | 06:25:59 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 06:25:59 INFO - PROCESS | 1667 | RSS: Main: 324399104 06:25:59 INFO - PROCESS | 1667 | 06:26:01 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:26:01 INFO - PROCESS | 1667 | RSS: Main: 302743552 06:26:01 INFO - PROCESS | 1667 | 06:26:03 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:26:04 INFO - PROCESS | 1667 | RSS: Main: 305471488 06:26:04 INFO - PROCESS | 1667 | 06:26:06 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:26:07 INFO - PROCESS | 1667 | RSS: Main: 308502528 06:26:07 INFO - PROCESS | 1667 | 06:26:10 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:26:10 INFO - PROCESS | 1667 | RSS: Main: 323805184 06:26:10 INFO - PROCESS | 1667 | 06:26:13 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:26:14 INFO - PROCESS | 1667 | RSS: Main: 316850176 06:26:14 INFO - PROCESS | 1667 | 06:26:16 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 06:26:16 INFO - PROCESS | 1667 | RSS: Main: 360779776 06:26:16 INFO - PROCESS | 1667 | 06:26:16 INFO - PROCESS | 1667 | __start_tp_report 06:26:16 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 06:26:16 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 06:26:16 INFO - PROCESS | 1667 | |i|pagename|runs| 06:26:16 INFO - PROCESS | 1667 | |0;ai-astar;112;113;112;114;113;113;112;113;112;112 06:26:16 INFO - PROCESS | 1667 | |1;audio-beat-detection;136;112;111;147;112;108;111;114;142;110 06:26:16 INFO - PROCESS | 1667 | |2;audio-dft;184;184;182;181;182;182;181;181;222;181 06:26:16 INFO - PROCESS | 1667 | |3;audio-fft;81;58;60;86;64;59;58;57;81;57 06:26:16 INFO - PROCESS | 1667 | |4;audio-oscillator;93;73;91;71;69;70;89;69;69;92 06:26:16 INFO - PROCESS | 1667 | |5;imaging-gaussian-blur;87;85;88;81;134;130;115;85;88;84 06:26:16 INFO - PROCESS | 1667 | |6;imaging-darkroom;92;93;92;93;93;93;91;96;92;94 06:26:16 INFO - PROCESS | 1667 | |7;imaging-desaturate;82;84;82;82;83;80;84;86;84;82 06:26:16 INFO - PROCESS | 1667 | |8;json-parse-financial;58;55;56;56;55;57;56;55;56;57 06:26:16 INFO - PROCESS | 1667 | |9;json-stringify-tinderbox;66;75;72;75;72;69;71;70;69;72 06:26:16 INFO - PROCESS | 1667 | |10;stanford-crypto-aes;86;90;87;85;86;89;110;109;108;88 06:26:16 INFO - PROCESS | 1667 | |11;stanford-crypto-ccm;148;148;139;162;152;149;149;147;210;160 06:26:16 INFO - PROCESS | 1667 | |12;stanford-crypto-pbkdf2;169;169;222;231;173;174;172;170;171;169 06:26:16 INFO - PROCESS | 1667 | |13;stanford-crypto-sha256-iterative;69;67;67;65;66;68;67;65;66;65 06:26:16 INFO - PROCESS | 1667 | __end_tp_report 06:26:16 INFO - PROCESS | 1667 | __start_cc_report 06:26:16 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,1964 06:26:16 INFO - PROCESS | 1667 | __end_cc_report 06:26:16 INFO - PROCESS | 1667 | __startTimestamp1478179576534__endTimestamp 06:26:16 INFO - PROCESS | 1667 | 06:26:16 INFO - PROCESS | 1667 | ------- Summary: start ------- 06:26:16 INFO - PROCESS | 1667 | Number of tests: 14 06:26:16 INFO - PROCESS | 1667 | 06:26:16 INFO - PROCESS | 1667 | [#0] ai-astar Cycles:10 Average:112.60 Median:113.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 06:26:16 INFO - PROCESS | 1667 | Values: 112.0 113.0 112.0 114.0 113.0 113.0 112.0 113.0 112.0 112.0 06:26:16 INFO - PROCESS | 1667 | 06:26:16 INFO - PROCESS | 1667 | [#1] audio-beat-detection Cycles:10 Average:120.30 Median:113.00 stddev:15.05 (13.3%) stddev-sans-first:14.85 06:26:16 INFO - PROCESS | 1667 | Values: 136.0 112.0 111.0 147.0 112.0 108.0 111.0 114.0 142.0 110.0 06:26:16 INFO - PROCESS | 1667 | 06:26:16 INFO - PROCESS | 1667 | [#2] audio-dft Cycles:10 Average:186.00 Median:182.00 stddev:12.70 (7.0%) stddev-sans-first:13.45 06:26:16 INFO - PROCESS | 1667 | Values: 184.0 184.0 182.0 181.0 182.0 182.0 181.0 181.0 222.0 181.0 06:26:16 INFO - PROCESS | 1667 | 06:26:16 INFO - PROCESS | 1667 | [#3] audio-fft Cycles:10 Average:66.10 Median:62.00 stddev:11.69 (18.8%) stddev-sans-first:11.08 06:26:16 INFO - PROCESS | 1667 | Values: 81.0 58.0 60.0 86.0 64.0 59.0 58.0 57.0 81.0 57.0 06:26:16 INFO - PROCESS | 1667 | 06:26:16 INFO - PROCESS | 1667 | [#4] audio-oscillator Cycles:10 Average:78.60 Median:81.00 stddev:11.00 (13.6%) stddev-sans-first:10.36 06:26:16 INFO - PROCESS | 1667 | Values: 93.0 73.0 91.0 71.0 69.0 70.0 89.0 69.0 69.0 92.0 06:26:16 INFO - PROCESS | 1667 | 06:26:16 INFO - PROCESS | 1667 | [#5] imaging-gaussian-blur Cycles:10 Average:97.70 Median:85.00 stddev:20.42 (24.0%) stddev-sans-first:21.29 06:26:16 INFO - PROCESS | 1667 | Values: 87.0 85.0 88.0 81.0 134.0 130.0 115.0 85.0 88.0 84.0 06:26:16 INFO - PROCESS | 1667 | 06:26:16 INFO - PROCESS | 1667 | [#6] imaging-darkroom Cycles:10 Average:92.90 Median:93.00 stddev:1.37 (1.5%) stddev-sans-first:1.41 06:26:16 INFO - PROCESS | 1667 | Values: 92.0 93.0 92.0 93.0 93.0 93.0 91.0 96.0 92.0 94.0 06:26:16 INFO - PROCESS | 1667 | 06:26:16 INFO - PROCESS | 1667 | [#7] imaging-desaturate Cycles:10 Average:82.90 Median:83.50 stddev:1.66 (2.0%) stddev-sans-first:1.73 06:26:16 INFO - PROCESS | 1667 | Values: 82.0 84.0 82.0 82.0 83.0 80.0 84.0 86.0 84.0 82.0 06:26:16 INFO - PROCESS | 1667 | 06:26:16 INFO - PROCESS | 1667 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.00 stddev:0.99 (1.8%) stddev-sans-first:0.78 06:26:16 INFO - PROCESS | 1667 | Values: 58.0 55.0 56.0 56.0 55.0 57.0 56.0 55.0 56.0 57.0 06:26:16 INFO - PROCESS | 1667 | 06:26:16 INFO - PROCESS | 1667 | [#9] json-stringify-tinderbox Cycles:10 Average:71.10 Median:72.00 stddev:2.77 (3.8%) stddev-sans-first:2.24 06:26:16 INFO - PROCESS | 1667 | Values: 66.0 75.0 72.0 75.0 72.0 69.0 71.0 70.0 69.0 72.0 06:26:16 INFO - PROCESS | 1667 | 06:26:16 INFO - PROCESS | 1667 | [#10] stanford-crypto-aes Cycles:10 Average:93.80 Median:86.50 stddev:10.60 (12.3%) stddev-sans-first:10.86 06:26:16 INFO - PROCESS | 1667 | Values: 86.0 90.0 87.0 85.0 86.0 89.0 110.0 109.0 108.0 88.0 06:26:16 INFO - PROCESS | 1667 | 06:26:16 INFO - PROCESS | 1667 | [#11] stanford-crypto-ccm Cycles:10 Average:156.40 Median:150.50 stddev:19.94 (13.2%) stddev-sans-first:20.92 06:26:16 INFO - PROCESS | 1667 | Values: 148.0 148.0 139.0 162.0 152.0 149.0 149.0 147.0 210.0 160.0 06:26:16 INFO - PROCESS | 1667 | 06:26:16 INFO - PROCESS | 1667 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.00 Median:172.50 stddev:23.61 (13.7%) stddev-sans-first:24.57 06:26:16 INFO - PROCESS | 1667 | Values: 169.0 169.0 222.0 231.0 173.0 174.0 172.0 170.0 171.0 169.0 06:26:16 INFO - PROCESS | 1667 | 06:26:16 INFO - PROCESS | 1667 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:1.35 (2.0%) stddev-sans-first:1.09 06:26:16 INFO - PROCESS | 1667 | Values: 69.0 67.0 67.0 65.0 66.0 68.0 67.0 65.0 66.0 65.0 06:26:16 INFO - PROCESS | 1667 | -------- Summary: end -------- 06:26:16 INFO - PROCESS | 1667 | 06:26:17 INFO - TEST-INFO | 1667: exit 0 06:26:17 INFO - TEST-OK | kraken | took 59106ms 06:26:17 INFO - SUITE-END | took 1179s 06:26:17 INFO - Completed test suite (00:19:39) 06:26:17 INFO - javascript benchmark 06:26:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3272.689094536019, 3292.86828526859, 3299.670032996702, 3311.7350611951015, 3349.9950014995497, 5387.568994480442, 5461.262729531512, 5490.81947381313, 5530.364008139065, 5534.806281780134, 4755.500672429397, 5338.3060202173665, 5445.482679145484, 5605.243292155557, 5605.27131472908, 4985.850424487271, 5058.620603454738, 5063.392392912837, 5086.287919691246, 5098.847034588968, 5088.160453525164, 5203.271541984125, 5218.269442278084, 5221.39953905302, 5272.288241087462, 5034.11902916988, 5194.558462530689, 5206.479352064801, 5213.191955246943, 5275.235090911816, 5107.131787596118, 5126.359205099363, 5141.177411614161, 5146.176611742103, 5156.432792392834, 5068.239764035387, 5111.4121875984365, 5124.154514505102, 5125.974370128163, 5127.154019586764, 5527.668339899619, 5568.972155139239, 5569.331680198362, 5581.358143813472, 5584.636998595119, 6013.248343957005, 6015.969920150415, 6016.09758536223, 6023.608465449732, 6041.848953776147, 6053.727582258809, 6095.438338978142, 6127.5404344674325, 6139.201903752528, 6140.508759299245, 5572.4706152915405, 5627.606067575231, 5628.324601047901, 5629.408912064216, 5638.097904335327, 6183.81448556544, 6279.591826531261, 6284.654344011124, 6296.6851657417865, 6334.714937827809, 5617.634853734494, 5960.0, 5973.104034394875, 5976.342602313742, 5976.880462390728, 5920.5559583031445, 6003.309619393738, 6005.909911351333, 6049.153118563405, 6146.078088286793, 5986.700664966735, 6037.63774173551, 6041.5468839837185, 6098.756049758049, 6112.0, 6073.39266073398, 6078.665673388006, 6087.756489740449, 6097.542684298695, 6132.049532322497, 4758.666893317504, 4800.183968725325, 4841.878953026203, 4842.5157484251995, 4848.321235027099, 4263.147370525907, 4282.785860706952, 4344.847930322424, 4358.6295164911335, 4402.581754733295, 5617.43825617435, 5631.549476041907, 5652.095664693629, 5677.063284558084, 5732.942670573324, 6191.721372538246, 6197.349278325801, 6205.596636218631, 6208.0998255253635, 6213.1922850029205, 5489.533389661923, 5607.018771714934, 5608.0, 5629.943700563023, 5681.375048744635, 5252.422233554383, 5258.158694608921, 5259.421463638997, 5289.418164001957, 5302.946970530323, 6371.331010243857, 6372.139761132188, 6376.426121649074, 6378.52161087911, 6385.489160867212, 6007.639541627516, 6172.135900973957, 6172.9074063889975, 6189.412005859436, 6195.752169913153, 6274.435300822765, 6277.372262773686, 6329.7468101275435, 6342.587731797418, 6346.746130154742, 6030.758769649165, 6038.064100064497, 6038.245219347582, 6054.243219597551, 6061.72722227492, 6039.063945088518, 6128.050152226412, 6175.4750846176785, 6176.289726681489, 6197.876042479035, 5764.279465066867, 5772.076467765138, 5803.216565763568, 5879.147523609138, 5915.112733090071, 5878.118282257696, 5887.882242355215, 5897.941020589739, 5907.704614769158, 5916.67458289781, 5198.0, 5332.82677810881, 5705.372409035086, 5705.972924873563, 5709.97220500314, 4815.975920120377, 5815.76736930518, 5842.38654941225, 5866.826634673168, 5975.193348897843, 5786.884262314646, 5786.971065144648, 5787.363390027178, 5788.971055144697, 5796.04365279741], "value": 5568.947634191082, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [480.6419217682825, 482.8165297187068, 513.463430714903, 520.2378515474829, 537.5914305128107, 29844.0, 31249.53125703116, 39100.804495977514, 39970.60029399705, 40034.19931601366, 40687.0, 41078.79460602693, 41120.383194252114, 41127.70978321727, 41192.38211426831, 8470.534120623362, 9375.81248375032, 9565.282603804742, 9570.186534144606, 9582.856257156149, 8540.70107546236, 8688.782780430476, 8703.869441958344, 8707.695230666928, 11300.039496642796, 11297.717557061098, 11300.547978080867, 11332.036776873934, 11506.482208300604, 11578.47896844644, 11366.0, 11424.828627570592, 11463.484143213574, 11476.0, 11498.367589782558, 8423.536705481196, 8690.608922598498, 8726.912730872673, 11286.209965302432, 11373.260738052, 31107.533386999214, 31449.0, 38866.417003744966, 39294.60705392966, 39471.210575788326, 3391.576052993376, 3911.2790372236127, 3949.723519353646, 3957.406389041638, 4061.1877624475223, 27882.605869706433, 28125.43749125006, 29496.0, 30467.695323046708, 30915.22711932197, 2606.973930260692, 2666.386731051869, 3214.4214041472524, 3274.5251938468787, 3348.430766769655, 481649.0, 482592.58703706256, 483299.0, 484037.0, 488451.0, 57621.0, 57751.04858746901, 57784.0, 58210.417895821345, 58311.125333120035, 61003.38996609977, 61024.389756102755, 61035.38964610386, 61115.0, 61204.69397652983, 15122.848771512365, 15338.233088345538, 15347.923260383626, 15353.309101090254, 15371.000884942443, 12153.696157595954, 12174.086943479275, 12180.0, 12194.012466945655, 12198.939005305094, 13922.354752596973, 14282.3572939218, 14300.0, 15484.922575387276, 16015.839841601435, 5921.5558833086825, 6093.390660933871, 6152.784997400932, 6187.659678717714, 6192.566520343623, 898.3397203055749, 964.4550828781715, 1000.0899181744578, 1001.6344034427382, 1049.2655141401049, 22394.664080038485, 23267.53464930692, 23697.612019056087, 23758.64362034571, 23806.765986340313, 1035.6219979707353, 1048.4810019040624, 1058.1429042475465, 1109.9611513597147, 1179.2983175010854, 13338.466461341437, 13600.863991360158, 15583.844161558465, 15598.688026239412, 16000.0, 521202.0, 671431.0, 678590.0, 682733.0, 857730.0, 48558.0, 49895.75052124716, 49939.751506211906, 54343.18485222725, 55071.449285507435, 1051.5636011055478, 1337.197681391177, 1354.7967804829354, 1356.0, 1358.3683587132032, 29965.400691986473, 30014.0, 30113.82016712208, 30224.09327720172, 30381.0, 48873.02253954972, 49771.751141244065, 49775.502244977084, 49809.0, 49833.50499485021, 436595.0, 437863.0, 447014.76492617326, 474855.0, 476690.0, 24648.260552183463, 24651.876740616182, 24870.253892383258, 24949.126780562594, 25085.24744257675, 44558.440454583935, 44659.0, 44722.60886856156, 45088.0, 45832.0, 32448.702051918604, 36411.0, 36778.0, 37630.811845940596, 38414.23171536498, 29787.851060745423, 34125.65874341324, 34560.135996600286, 35392.646073538934, 35495.290094198484, 30662.846685766428, 36255.81872090622, 36612.33442926226, 36875.631243688294, 37094.629053710196, 29267.0, 30932.381352373275, 32874.17814554655, 32989.0, 33285.66714332825, 22422.0, 22626.886865565568, 23585.546695444904, 24384.756152438957, 25045.499090017733], "value": 19062.570515072508, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.3379372975994, 349.1515617050569, 370.30198076625567, 371.8271003983147, 401.6846775281403, 15114.848851511482, 15363.3086511107, 18017.90991045043, 19418.019306042264, 20213.494662633442, 19505.41483755486, 19883.204671813146, 19941.404687624992, 20065.799342006576, 20088.8995555022, 4562.452505699321, 5921.171036054956, 5965.254343207099, 5975.223220981288, 5983.9102413463615, 5884.235049443566, 5892.8214357128745, 5902.144189092579, 5945.346011938684, 5971.98476259037, 5630.943690563083, 5884.6469211847425, 5897.380775018625, 5900.468957793798, 5903.144044113601, 5606.831795046155, 5805.24531810864, 5824.737886795105, 5872.383399743029, 5898.8230353089475, 5124.359455068116, 5125.8718532037, 5127.974360128175, 5128.871778205537, 5132.8460146195675, 22743.88628056866, 24178.758212418, 25119.985601727727, 25175.37061573457, 25323.0, 2520.810939179569, 2530.215633153728, 2836.602875597418, 3067.7852550321486, 3186.23530352716, 14215.43138274478, 15017.624559386102, 15088.755917477794, 15100.924495377563, 15509.844901550952, 1821.681205788995, 1890.5368184794813, 1891.3947536788232, 1893.0818553001784, 1898.1268616436455, 111640.32539511914, 113752.86247137588, 113823.0, 116310.0, 117048.99999999914, 10197.133243674223, 10293.639722609672, 10413.53139108742, 10478.423686697304, 10620.150387968944, 11788.0, 12505.56230531927, 12507.499700011898, 12602.621921342374, 12612.432440540199, 6386.712597933104, 7652.885206721904, 8169.30560902318, 8643.394962352575, 8646.3947523674, 8376.706815261437, 8424.410291279552, 8749.300055995505, 8840.292776577859, 8896.466212027299, 6505.674716264168, 6570.8028759137305, 6599.505037122139, 6600.86798264032, 6626.900596491057, 1410.640286726878, 1784.723367877981, 1797.613513094691, 1844.603410266799, 1844.8339649431616, 667.5827607745159, 902.1249388093539, 930.6184464369576, 941.7363138321281, 1002.5538635307219, 15906.52280431589, 21457.570848583255, 21463.892680536497, 21722.52439609655, 21726.674099888514, 798.9760307190794, 943.6602822983721, 962.8748262725801, 968.8401413766791, 1001.4592120254981, 11090.722731931604, 11384.71632651045, 11422.543098276143, 11530.884691152982, 11580.247283926517, 541715.0, 571304.0, 574045.0, 577366.0, 584076.0, 113364.0, 124424.0, 125172.0, 128470.0, 128751.0, 966.1546147121269, 974.7660561465339, 1000.6697789729371, 1000.9849852252222, 1005.4520286443906, 18853.905730471808, 19077.141528630968, 19207.32774352891, 19257.614847703248, 19322.0, 52930.735346323025, 53089.46910530845, 53462.73268633632, 53759.73120134374, 54613.0, 75780.484390313, 75815.24184758082, 76282.75313845176, 77135.0, 77404.2259577397, 6740.427063699641, 7657.272559106876, 7717.151113377637, 7814.609269536614, 7883.6846526138315, 12652.746945061232, 12869.264069264069, 12971.35143242853, 13046.152000119962, 13482.52811151605, 11010.0, 11048.337099774039, 11193.104551635686, 11307.717307067389, 11386.886131138583, 9954.402735835873, 10929.672109836718, 11135.164862635496, 11333.0, 11387.544498219979, 8523.914760852313, 9227.0, 11369.658910232707, 11416.885831141915, 11629.76740465203, 6914.170299564084, 7754.302112809649, 7833.92166078332, 7846.764597062097, 7867.645955931882, 9108.817823643358, 9541.761455963657, 11050.502727377127, 11258.043066339453, 11291.040261577858], "value": 9535.606816847663, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1467.053750331036, 1505.5859638599384, 1660.4271526323414, 1822.4077174918154, 1850.9444716658497, 7978.800529986746, 8378.371622128341, 8378.539180345078, 8388.83222335553, 8388.874166887486, 7358.411327093833, 7661.92338076619, 7676.846463070749, 8000.559969201691, 8220.794480138, 2260.457490202348, 2296.9310920672406, 2298.069281940817, 2300.64340027296, 2300.7584203658544, 1985.9702104468445, 2285.2915596165158, 2308.319045881469, 2328.860268383902, 2330.1844354475884, 2270.5231901300663, 2273.9886300568473, 2288.5079707862806, 2302.7697230277004, 2303.9884800576056, 2256.153942271632, 2257.8758168300737, 2275.533515629292, 2275.874826884529, 2277.646964720471, 2281.3954302109955, 2295.885205739706, 2298.253067752987, 2298.3564601911494, 2300.8389412741117, 8155.79610509742, 8344.749657510285, 8363.832723345498, 8370.53962032088, 8387.874181887277, 4981.676191047571, 5153.845384638429, 5162.12243918531, 5162.148245539482, 5166.896662066738, 3197.4244635965515, 3312.734981201498, 3513.086597484647, 3524.6475352464804, 3532.028692109665, 1018.1854516386935, 1029.788893276884, 1046.5709059285657, 1060.9946950265276, 1063.1813503602261, 10825.188110891635, 10828.675139745821, 10992.890071099268, 10995.230333876632, 11001.724956876062, 4344.413504176959, 4442.400275962768, 4526.479454862667, 4529.54704529551, 4588.747618880927, 9358.953205233931, 9365.0, 9370.10983956523, 9374.765630859147, 9390.812183756423, 5168.53483186515, 5173.534381905646, 5173.767180476888, 5175.0, 5181.948180518147, 4236.004538933348, 4400.075984043387, 4488.102379524108, 4701.506341834127, 4761.642876784255, 3570.5001299817527, 3623.601403845575, 3690.132818787583, 3708.0173753955223, 3725.0501122213664, 1198.17924721566, 1207.8309036734863, 1212.2302338015425, 1220.1458978714757, 1225.503671013241, 770.9498882572615, 794.6384395100215, 897.0, 897.6768363389175, 955.2835373469898, 4530.61489773373, 4610.216263235258, 5386.649867758583, 5807.68057756819, 5830.3586605473365, 860.9483430994161, 869.3957699398984, 876.5836227791875, 938.3572253006712, 1001.5843424978552, 3070.846457677107, 3697.6487233712755, 3769.246150769857, 3843.3466310727244, 3855.4216867469545, 9853.901460985442, 10149.594016239416, 10257.33327333721, 10277.229207809443, 10314.793704125876, 10216.088414801747, 10220.591176352862, 10221.23340749432, 10237.078662920372, 10245.231607629457, 7349.77950661481, 7580.279873412127, 7802.570858602831, 7878.4091193161885, 7888.64501097452, 4834.830780922651, 5031.295618613471, 5594.804181853616, 5712.885742285214, 5847.502962248256, 9260.166585007382, 9267.119623635745, 9309.72070837876, 9346.53267336644, 9460.432374057578, 9445.913719922297, 9487.193588545051, 9503.0, 9585.281103917094, 9693.369930954465, 6576.506761992965, 6799.048133261248, 6808.217055038734, 6978.651067446506, 7222.927770722225, 7372.63136843145, 7520.887186692314, 7523.623818809147, 7743.651535680795, 7823.647935843014, 7040.155181378267, 7109.680064397011, 7111.288871112847, 7201.71193152268, 7285.307895749896, 6976.651167441506, 6990.26602206761, 7030.578165309893, 7060.082189315356, 7113.6443177839865, 6662.300458451793, 6699.899501507579, 6748.763793267212, 6769.89845152333, 6786.796396108125, 4459.684393104107, 4641.6286697064825, 4776.641751868554, 4824.638152138534, 4943.65394422387, 3869.438931354994, 4331.068820203672, 4589.885252868705, 4807.423109226916, 4903.239997800347], "value": 4359.036281097914, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.5611039551069, 300.8210114981585, 303.84503903009465, 307.8106964217007, 309.5001572460477, 4411.294192929132, 4985.9750701246485, 5059.5193456621655, 5060.519250671189, 5064.468230835764, 4050.3721923101966, 4993.500649935014, 5010.123228435027, 5068.366454193226, 5089.414717307511, 3639.5450568678916, 3758.004128905842, 3791.6729144799306, 3796.791176485292, 3881.844726210948, 3285.802851828886, 3843.2121415109973, 3863.194753168127, 3879.282332768447, 3890.455336252927, 3844.5587052221763, 3850.5379354477363, 3860.092878173627, 3880.7477513961644, 3903.2974064668347, 3298.5217143514055, 3633.1652515479514, 3868.400397938324, 3874.8643797466952, 3902.6682731967817, 3366.5118557809224, 3377.2475432522415, 3384.272381437978, 3392.6268110507826, 3393.304372603635, 4147.6474499667265, 4827.637927155442, 4836.105320515716, 4840.886596082921, 4872.731999740013, 3713.3846776652244, 4234.724742891703, 4250.659947204247, 4280.828766849322, 4336.197803406349, 5177.404598471148, 5190.728271573489, 5198.454162312978, 5199.220116982445, 5202.479752024805, 3241.2221066944, 3686.944695829565, 3694.261147770457, 3697.280764444546, 3729.3287208302495, 4391.736495810262, 4706.082313948781, 5253.9072252459255, 5418.7019713915715, 5529.695866727328, 3395.9490607640905, 3687.8524859005875, 3738.5887552369218, 3749.0692293468887, 3758.661720445173, 3528.665411186404, 3804.2201348723447, 3815.37046387343, 3824.0, 3844.6539811417106, 4360.454943132108, 4371.584699453547, 4371.644790115074, 4381.5618438155925, 4421.823127074881, 4810.807567697253, 4985.401751789808, 5175.3697585260525, 5236.528712415901, 5268.710220937808, 1132.7822590715014, 1284.036972270797, 1285.1710646632869, 1308.574713218208, 1308.6586249094564, 719.0795781399817, 793.6666600027887, 800.966752888767, 815.3436483630734, 816.7876352148365, 4131.380292956021, 4138.52406973196, 4590.921133533617, 4864.391951006124, 4975.477574854661, 4074.2055299216368, 4579.313103034505, 5239.502247286502, 5503.036968530491, 5536.0900489331925, 4064.3293856513937, 4707.293905914072, 4933.432655244693, 4976.751162441863, 5112.948870511247, 2033.7762846086919, 2401.327628264089, 2822.6753923299084, 2848.3591191982055, 2852.944410568062, 5522.889542209214, 5568.883824146798, 5597.51665808561, 5602.582424720917, 5639.984802735547, 5263.894722105537, 5463.071277882769, 5483.036543589619, 5530.474604912527, 5533.071519221317, 4657.301404789308, 5098.6685865417885, 5474.835754927359, 5608.607397482218, 5625.774969001194, 5350.464953504618, 5360.3299587551555, 5425.565954723692, 5429.647072940246, 5439.292891924025, 4981.8007279709855, 5278.047122564676, 5312.574994000393, 5356.223347614652, 5364.517193452608, 4343.175866136167, 5249.0, 5561.943230786138, 5598.3282006159525, 5611.971940140274, 3275.5414242006614, 3310.8841190558214, 3476.2526056897887, 3741.8690345837763, 3775.905602359963, 5177.637565370388, 5362.9463705364005, 5384.353877534721, 5435.673859568438, 5483.8080667176455, 4585.633149348111, 4602.286645569942, 5026.447090819934, 5236.816711415082, 5249.553787927916, 4504.2793153095345, 4550.5859316462975, 4551.726896386227, 5083.949160508348, 5237.057329680694, 4608.677392582487, 4835.0, 5096.1716247483, 5200.8818104107795, 5206.55744261742, 5066.847994560169, 5243.947560524346, 5314.548263397654, 5325.547328477122, 5336.199570064521, 4801.935167877846, 5136.434992150935, 5136.794528218829, 5146.6911985281, 5183.403908550565], "value": 3845.375275964929, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [691.889297712366, 699.6326928362612, 727.3926271563248, 732.3079689693238, 747.1892996099234, 14337.71324573508, 14381.424743010293, 14686.63283417915, 15020.624484387896, 15200.847991520082, 13225.0, 13486.865131348684, 13496.392662330194, 13503.797443038362, 13511.662208444794, 820.9753707388758, 825.8141918068446, 828.4490813608973, 829.0383155539575, 829.1501211258447, 660.1550015979553, 685.5509641185007, 808.3896658023184, 837.4431003382743, 838.4256784102909, 902.1474706402453, 902.4946030223064, 906.3247880329164, 906.3972458315212, 907.6324088744069, 898.012186594747, 898.1871406377239, 898.586650140936, 900.1043961258524, 900.8468560344725, 513.4942082049179, 531.9787208511655, 532.0954377558166, 532.2149829002229, 670.5004771445256, 12411.317377544232, 14004.0197186197, 14617.19605421712, 14623.0, 14661.486847960377, 13676.0, 13828.446862125504, 13944.790828137484, 13971.58085257444, 13993.790093148611, 11163.386013769239, 11260.774784504347, 11451.484683189194, 11459.885401145964, 11517.712057198552, 3655.0, 3707.277080969212, 3715.814209289552, 3719.033051406627, 3841.635044670752, 84514.0, 85227.0, 85797.57101214454, 86705.13294867097, 88693.55653221693, 10464.372137671764, 10484.475776211159, 10624.68125956207, 10729.0, 11141.387223702774, 21197.78802211989, 21238.0, 21254.0, 21279.255226067013, 21297.254596089064, 7379.6679149438405, 7480.812979675443, 7762.883556746653, 7811.960940195263, 7914.564698941614, 3629.891103266906, 4293.162833247487, 4370.278903980871, 4394.428724265825, 4577.542245775462, 3434.4504879219203, 3517.751198324558, 3540.415831387844, 3553.378158822196, 3554.662307080823, 659.2945548263313, 660.1714847865993, 663.6781161136845, 667.9098321726602, 670.5339788846802, 588.3028611095865, 609.7195290166485, 652.5399593286721, 655.9081728558006, 686.4817063117315, 8646.740597782076, 8684.305255579538, 9162.0, 9267.953660231791, 9294.814103717888, 519.8934218485201, 627.3694936588699, 649.217692680319, 682.5597489619267, 689.4693779808816, 3965.5637879833193, 4364.4980827204645, 4632.884177895512, 4854.660173787872, 4874.618009638294, 111065.44467277612, 112384.0, 113346.43326783479, 114093.0, 120023.39988300177, 63663.40841479, 64797.67601161964, 64997.67501162464, 65002.67498662571, 96099.51950240204, 57140.0, 62296.37703622906, 68841.0, 86271.0, 89726.10273897307, 9549.952250238704, 9584.76038099053, 9604.471754053595, 9621.9037809621, 9669.371490853073, 46100.0, 46754.76622616865, 47317.0, 47355.28967065566, 47448.05103897972, 62643.373566263755, 63867.52927295045, 66540.6672966632, 67510.66244668745, 68124.3187568118, 11838.408079595814, 12236.531616206112, 12551.309677967434, 12578.056645751789, 13059.151155174883, 13404.798928015893, 13916.234607096707, 14197.361118749888, 14398.496052638107, 14863.40546378176, 12883.871161288267, 12997.155184913328, 13180.209187448783, 13275.004374671746, 13745.518906838213, 13071.869281307065, 13230.07389482727, 13244.80132798028, 13464.192148471124, 13533.052686311863, 12666.683332916382, 12741.936290318488, 12759.872401275868, 12956.416961236955, 12964.35178241103, 11230.66308010761, 11290.096792256436, 11494.310341379543, 11527.0, 11656.06751459898, 10706.946465267623, 11052.0, 11200.047995920439, 11273.731618104392, 11355.659330220107], "value": 7204.165980848164, "unit": "score"}], "name": "dromaeo_css", "value": 7044.943619749503, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 112.0, 114.0, 113.0, 113.0, 112.0, 113.0, 112.0, 112.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 112.0, 111.0, 147.0, 112.0, 108.0, 111.0, 114.0, 142.0, 110.0], "value": 120.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 184.0, 182.0, 181.0, 182.0, 182.0, 181.0, 181.0, 222.0, 181.0], "value": 186.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 60.0, 86.0, 64.0, 59.0, 58.0, 57.0, 81.0, 57.0], "value": 66.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 73.0, 91.0, 71.0, 69.0, 70.0, 89.0, 69.0, 69.0, 92.0], "value": 78.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 88.0, 81.0, 134.0, 130.0, 115.0, 85.0, 88.0, 84.0], "value": 97.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 92.0, 93.0, 93.0, 93.0, 91.0, 96.0, 92.0, 94.0], "value": 92.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 82.0, 82.0, 83.0, 80.0, 84.0, 86.0, 84.0, 82.0], "value": 82.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 55.0, 56.0, 56.0, 55.0, 57.0, 56.0, 55.0, 56.0, 57.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 75.0, 72.0, 75.0, 72.0, 69.0, 71.0, 70.0, 69.0, 72.0], "value": 71.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 90.0, 87.0, 85.0, 86.0, 89.0, 110.0, 109.0, 108.0, 88.0], "value": 93.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 139.0, 162.0, 152.0, 149.0, 149.0, 147.0, 210.0, 160.0], "value": 156.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 169.0, 222.0, 231.0, 173.0, 174.0, 172.0, 170.0, 171.0, 169.0], "value": 182.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 67.0, 65.0, 66.0, 68.0, 67.0, 65.0, 66.0, 65.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1463.0000000000002, "alertThreshold": 2.0}]} 06:26:17 INFO - Return code: 0 06:26:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:26:17 INFO - # TBPL SUCCESS # 06:26:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:26:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:26:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:26:17 INFO - 2016-11-03 06:26:17.834 screenresolution[1671:10024] starting screenresolution argv=screenresolution get 06:26:17 INFO - 2016-11-03 06:26:17.837 screenresolution[1671:10024] Display 0: 1600x1200x32@60 06:26:17 INFO - 2016-11-03 06:26:17.843 screenresolution[1672:10027] starting screenresolution argv=screenresolution list 06:26:17 INFO - Available Modes on Display 0 06:26:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:26:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:26:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:26:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:26:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:26:18 INFO - Intel Iris: 06:26:18 INFO - Chipset Model: Intel Iris 06:26:18 INFO - Type: GPU 06:26:18 INFO - Bus: Built-In 06:26:18 INFO - VRAM (Dynamic, Max): 1536 MB 06:26:18 INFO - Vendor: Intel (0x8086) 06:26:18 INFO - Device ID: 0x0a2e 06:26:18 INFO - Revision ID: 0x0009 06:26:18 INFO - Displays: 06:26:18 INFO - Display: 06:26:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:26:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:26:18 INFO - Display Serial Number: 1600x1200 60 06:26:18 INFO - Main Display: Yes 06:26:18 INFO - Mirror: Off 06:26:18 INFO - Online: Yes 06:26:18 INFO - Rotation: Supported 06:26:18 INFO - Return code: 0 06:26:18 INFO - Running post-action listener: _resource_record_post_action 06:26:18 INFO - [mozharness: 2016-11-03 13:26:18.080103Z] Finished run-tests step (success) 06:26:18 INFO - Running post-run listener: _resource_record_post_run 06:26:18 INFO - Total resource usage - Wall time: 1215s; CPU: 54.0%; Read bytes: 32451584; Write bytes: 706859008; Read time: 306; Write time: 1903 06:26:18 INFO - TinderboxPrint: CPU usage
53.6% 06:26:18 INFO - TinderboxPrint: I/O read bytes / time
32,451,584 / 306 06:26:18 INFO - TinderboxPrint: I/O write bytes / time
706,859,008 / 1,903 06:26:18 INFO - TinderboxPrint: CPU idle
2,256.9 (46.4%) 06:26:18 INFO - TinderboxPrint: CPU system
971.9 (20.0%) 06:26:18 INFO - TinderboxPrint: CPU user
1,632.8 (33.6%) 06:26:18 INFO - TinderboxPrint: Swap in / out
434,065,408 / 0 06:26:18 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 390593024; Write bytes: 386059776; Read time: 29659; Write time: 718 06:26:18 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 31529984; Write bytes: 296964608; Read time: 293; Write time: 1130 06:26:18 INFO - Running post-run listener: _upload_blobber_files 06:26:18 INFO - Blob upload gear active. 06:26:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:26:18 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 06:26:18 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', 'Cedar', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:26:18 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 Cedar -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:26:19 INFO - (blobuploader) - INFO - Open directory for files ... 06:26:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:26:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:26:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:26:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:26:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:26:19 INFO - (blobuploader) - INFO - Done attempting. 06:26:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:26:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:26:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:26:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:26:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:26:20 INFO - (blobuploader) - INFO - Done attempting. 06:26:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:26:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:26:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:26:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:26:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:26:23 INFO - (blobuploader) - INFO - Done attempting. 06:26:23 INFO - (blobuploader) - INFO - Iteration through files over. 06:26:23 INFO - Return code: 0 06:26:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:26:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:26:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/97890c2c3b2029eb362636d4d0bfad62a4f36a5de751cfb7afe00297a07032e1e0fc28a689baa8d16674032ea2053454fe43f1bbf2c5d4d44472cfea95f76473", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/5e79f5653f8c02b021d97de40de99c06bcc38b89146d5dc64350f14f563c04dc818c13bf782ac681e4c89c17c7a518d7a6a79e1ae56f0d65549cf0021e943d92", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/e3fcf4d68b164cb0c6f2fa75113cd4c3d3086d0dea3d90d1699a58ec1556e99ad9f408928f807a7a3347009dcdb879ab9e96adbc4b86ff92366a3252ae6b49de"} 06:26:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:26:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:26:23 INFO - Contents: 06:26:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/97890c2c3b2029eb362636d4d0bfad62a4f36a5de751cfb7afe00297a07032e1e0fc28a689baa8d16674032ea2053454fe43f1bbf2c5d4d44472cfea95f76473", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/5e79f5653f8c02b021d97de40de99c06bcc38b89146d5dc64350f14f563c04dc818c13bf782ac681e4c89c17c7a518d7a6a79e1ae56f0d65549cf0021e943d92", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/e3fcf4d68b164cb0c6f2fa75113cd4c3d3086d0dea3d90d1699a58ec1556e99ad9f408928f807a7a3347009dcdb879ab9e96adbc4b86ff92366a3252ae6b49de"} 06:26:23 INFO - Running post-run listener: copy_logs_to_upload_dir 06:26:23 INFO - Copying logs to upload dir... 06:26:23 INFO - mkdir: /builds/slave/test/build/upload/logs 06:26:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.754720 ========= master_lag: 1.82 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-11-03 06:26:24.978842) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-03 06:26:24.986653) ========= 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.fJq7NTaYHJ/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.5VpPRSVL29/Listeners TMPDIR=/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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/Cedar/sha512/97890c2c3b2029eb362636d4d0bfad62a4f36a5de751cfb7afe00297a07032e1e0fc28a689baa8d16674032ea2053454fe43f1bbf2c5d4d44472cfea95f76473", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/5e79f5653f8c02b021d97de40de99c06bcc38b89146d5dc64350f14f563c04dc818c13bf782ac681e4c89c17c7a518d7a6a79e1ae56f0d65549cf0021e943d92", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/e3fcf4d68b164cb0c6f2fa75113cd4c3d3086d0dea3d90d1699a58ec1556e99ad9f408928f807a7a3347009dcdb879ab9e96adbc4b86ff92366a3252ae6b49de"} build_url:https://queue.taskcluster.net/v1/task/d5pL2COtQLq5g6XMuAO1Pg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011038 build_url: 'https://queue.taskcluster.net/v1/task/d5pL2COtQLq5g6XMuAO1Pg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/97890c2c3b2029eb362636d4d0bfad62a4f36a5de751cfb7afe00297a07032e1e0fc28a689baa8d16674032ea2053454fe43f1bbf2c5d4d44472cfea95f76473", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/5e79f5653f8c02b021d97de40de99c06bcc38b89146d5dc64350f14f563c04dc818c13bf782ac681e4c89c17c7a518d7a6a79e1ae56f0d65549cf0021e943d92", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/e3fcf4d68b164cb0c6f2fa75113cd4c3d3086d0dea3d90d1699a58ec1556e99ad9f408928f807a7a3347009dcdb879ab9e96adbc4b86ff92366a3252ae6b49de"}' ========= master_lag: 0.96 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-03 06:26:25.960101) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 06:26:25.960432) ========= 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.fJq7NTaYHJ/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.5VpPRSVL29/Listeners TMPDIR=/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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.005173 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 06:26:25.988901) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-03 06:26:25.989226) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-03 06:26:25.990923) ========= ========= Total master_lag: 2.89 =========