builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0038 starttime: 1476829923.16 results: success (0) buildid: 20161018132202 builduid: 7e79fb9d326844dfb7750166419998a3 revision: 3ce14ff1acd5816d957b93135174b86d1cb63afa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-18 15:32:03.163490) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-18 15:32:03.164050) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-18 15:32:03.164366) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-18 15:32:03.188113) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 15:32:03.188474) ========= 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.e8uhZ7lvyV/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.fxwiFL4Txv/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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-10-18 15:32:03-- 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% 15.4M=0.001s 2016-10-18 15:32:03 (15.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.402185 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 15:32:03.613198) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 15:32:03.613589) ========= 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.e8uhZ7lvyV/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.fxwiFL4Txv/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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.020060 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 15:32:03.662448) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-18 15:32:03.662880) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 3ce14ff1acd5816d957b93135174b86d1cb63afa --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 3ce14ff1acd5816d957b93135174b86d1cb63afa --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.e8uhZ7lvyV/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.fxwiFL4Txv/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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-10-18 15:32:03,735 truncating revision to first 12 chars 2016-10-18 15:32:03,735 Setting DEBUG logging. 2016-10-18 15:32:03,735 attempt 1/10 2016-10-18 15:32:03,735 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/3ce14ff1acd5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-18 15:32:04,894 unpacking tar archive at: autoland-3ce14ff1acd5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.416273 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-18 15:32:05.101572) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-18 15:32:05.101963) ========= script_repo_revision: 3ce14ff1acd5816d957b93135174b86d1cb63afa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-18 15:32:05.102403) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-18 15:32:05.102723) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-18 15:32:05.120826) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-18 15:32:05.121160) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.e8uhZ7lvyV/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.fxwiFL4Txv/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 15:32:05 INFO - MultiFileLogger online at 20161018 15:32:05 in /builds/slave/test 15:32:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 15:32:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:32:05 INFO - {'append_to_log': False, 15:32:05 INFO - 'base_work_dir': '/builds/slave/test', 15:32:05 INFO - 'blob_upload_branch': 'Autoland', 15:32:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:32:05 INFO - 'branch': 'Autoland', 15:32:05 INFO - 'buildbot_json_path': 'buildprops.json', 15:32:05 INFO - 'config_files': ('talos/mac_config.py',), 15:32:05 INFO - 'default_actions': ('clobber', 15:32:05 INFO - 'read-buildbot-config', 15:32:05 INFO - 'download-and-extract', 15:32:05 INFO - 'populate-webroot', 15:32:05 INFO - 'create-virtualenv', 15:32:05 INFO - 'install', 15:32:05 INFO - 'run-tests'), 15:32:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:32:05 INFO - 'download_minidump_stackwalk': True, 15:32:05 INFO - 'download_symbols': 'ondemand', 15:32:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:32:05 INFO - 'tooltool.py': '/tools/tooltool.py', 15:32:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:32:05 INFO - '/tools/misc-python/virtualenv.py')}, 15:32:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:32:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:32:05 INFO - 'installer_path': 'installer.exe', 15:32:05 INFO - 'log_level': 'info', 15:32:05 INFO - 'log_name': 'talos', 15:32:05 INFO - 'log_to_console': True, 15:32:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:32:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:32:05 INFO - 'opt_config_files': (), 15:32:05 INFO - 'pip_index': False, 15:32:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:32:05 INFO - 'cmd': ('bash', 15:32:05 INFO - '-c', 15:32:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:32:05 INFO - 'enabled': True, 15:32:05 INFO - 'halt_on_failure': False, 15:32:05 INFO - 'name': 'check_screen_resolution'},), 15:32:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:32:05 INFO - 'cmd': ('bash', 15:32:05 INFO - '-c', 15:32:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:32:05 INFO - 'enabled': True, 15:32:05 INFO - 'halt_on_failure': False, 15:32:05 INFO - 'name': 'check_screen_resolution'},), 15:32:05 INFO - 'run_cmd_checks_enabled': True, 15:32:05 INFO - 'sps_profile': False, 15:32:05 INFO - 'sps_profile_interval': 0, 15:32:05 INFO - 'suite': 'dromaeojs', 15:32:05 INFO - 'system_bits': '32', 15:32:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:32:05 INFO - 'title': 't-yosemite-r7-0038', 15:32:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:32:05 INFO - 'use_talos_json': True, 15:32:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:32:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:32:05 INFO - 'work_dir': 'build'} 15:32:05 INFO - [mozharness: 2016-10-18 22:32:05.317166Z] Running clobber step. 15:32:05 INFO - Running pre-action listener: _resource_record_pre_action 15:32:05 INFO - Running main action method: clobber 15:32:05 INFO - rmtree: /builds/slave/test/build 15:32:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:32:05 INFO - Running post-action listener: _resource_record_post_action 15:32:05 INFO - [mozharness: 2016-10-18 22:32:05.851163Z] Finished clobber step (success) 15:32:05 INFO - [mozharness: 2016-10-18 22:32:05.851355Z] Running read-buildbot-config step. 15:32:05 INFO - Running pre-action listener: _resource_record_pre_action 15:32:05 INFO - Running main action method: read_buildbot_config 15:32:05 INFO - Using buildbot properties: 15:32:05 INFO - { 15:32:05 INFO - "project": "", 15:32:05 INFO - "product": "firefox", 15:32:05 INFO - "script_repo_revision": "production", 15:32:05 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 15:32:05 INFO - "repository": "", 15:32:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 15:32:05 INFO - "buildid": "20161018132202", 15:32:05 INFO - "pgo_build": "False", 15:32:05 INFO - "basedir": "/builds/slave/test", 15:32:05 INFO - "buildnumber": 393, 15:32:05 INFO - "slavename": "t-yosemite-r7-0038", 15:32:05 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 15:32:05 INFO - "platform": "yosemite_r7", 15:32:05 INFO - "scheduler": "tests-autoland-macosx64-talos", 15:32:05 INFO - "branch": "autoland", 15:32:05 INFO - "repo_path": "integration/autoland", 15:32:05 INFO - "revision": "3ce14ff1acd5816d957b93135174b86d1cb63afa", 15:32:05 INFO - "stage_platform": "macosx64", 15:32:05 INFO - "builduid": "7e79fb9d326844dfb7750166419998a3", 15:32:05 INFO - "slavebuilddir": "test" 15:32:05 INFO - } 15:32:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/WbqCzpGrTmWbmO2oCt2o7g/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 15:32:05 INFO - Running post-action listener: _resource_record_post_action 15:32:05 INFO - [mozharness: 2016-10-18 22:32:05.854823Z] Finished read-buildbot-config step (success) 15:32:05 INFO - [mozharness: 2016-10-18 22:32:05.854973Z] Running download-and-extract step. 15:32:05 INFO - Running pre-action listener: _resource_record_pre_action 15:32:05 INFO - Running main action method: download_and_extract 15:32:05 INFO - mkdir: /builds/slave/test/build/tests 15:32:05 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')]} 15:32:05 INFO - trying https://queue.taskcluster.net/v1/task/WbqCzpGrTmWbmO2oCt2o7g/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 15:32:05 INFO - Downloading https://queue.taskcluster.net/v1/task/WbqCzpGrTmWbmO2oCt2o7g/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 15:32:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WbqCzpGrTmWbmO2oCt2o7g/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 15:32:07 INFO - Downloaded 1199 bytes. 15:32:07 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 15:32:07 INFO - Using the following test package requirements: 15:32:07 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 15:32:07 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:32:07 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 15:32:07 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:32:07 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 15:32:07 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:32:07 INFO - u'jsshell-mac.zip'], 15:32:07 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:32:07 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 15:32:07 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 15:32:07 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:32:07 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 15:32:07 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:32:07 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 15:32:07 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:32:07 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 15:32:07 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:32:07 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 15:32:07 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:32:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WbqCzpGrTmWbmO2oCt2o7g/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 15:32:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WbqCzpGrTmWbmO2oCt2o7g/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:32:07 INFO - Fetch https://queue.taskcluster.net/v1/task/WbqCzpGrTmWbmO2oCt2o7g/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 15:32:08 INFO - Http code: 200 15:32:08 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 15:32:08 INFO - x-amz-cf-id: uBibo5Cx9SKDwkn1vyzERC6QqTmttyyqqxwl_3KRLScYr9pJcSt14Q== 15:32:08 INFO - x-amz-version-id: oCfrlpVc5U1G_WJAZCckGbTaL_rLGqlQ 15:32:08 INFO - Expected file size: 16483717 15:32:08 INFO - Obtained file size: 16483717 15:32:15 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 15:32:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WbqCzpGrTmWbmO2oCt2o7g/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 15:32:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WbqCzpGrTmWbmO2oCt2o7g/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:32:15 INFO - Fetch https://queue.taskcluster.net/v1/task/WbqCzpGrTmWbmO2oCt2o7g/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 15:32:15 INFO - Http code: 200 15:32:15 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 15:32:15 INFO - x-amz-cf-id: ZEgwvJkiBI57ScSFdugVQdVibj8WdM7zvzCmIhLDPEE-Kq_w3-dLGg== 15:32:15 INFO - x-amz-version-id: oCfrlpVc5U1G_WJAZCckGbTaL_rLGqlQ 15:32:16 INFO - Expected file size: 16483717 15:32:16 INFO - Obtained file size: 16483717 15:32:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WbqCzpGrTmWbmO2oCt2o7g/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 15:32:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WbqCzpGrTmWbmO2oCt2o7g/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 15:32:22 INFO - Fetch https://queue.taskcluster.net/v1/task/WbqCzpGrTmWbmO2oCt2o7g/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 15:32:23 INFO - Http code: 200 15:32:23 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 15:32:23 INFO - x-amz-cf-id: 9_-kuT6esOiovfWTdXlU2RY4CTaMMk35ZnRhIwe4qRDeze7qZM9nGw== 15:32:23 INFO - x-amz-version-id: asstljzpMobM0wJ5DYbZ4Y0diB6uX_bc 15:32:23 INFO - Expected file size: 14409028 15:32:23 INFO - Obtained file size: 14409028 15:32:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:23 INFO - trying https://queue.taskcluster.net/v1/task/WbqCzpGrTmWbmO2oCt2o7g/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 15:32:23 INFO - Downloading https://queue.taskcluster.net/v1/task/WbqCzpGrTmWbmO2oCt2o7g/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 15:32:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WbqCzpGrTmWbmO2oCt2o7g/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 15:32:26 INFO - Downloaded 111627436 bytes. 15:32:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WbqCzpGrTmWbmO2oCt2o7g/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 15:32:26 INFO - mkdir: /builds/slave/test/properties 15:32:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:32:26 INFO - Writing to file /builds/slave/test/properties/build_url 15:32:26 INFO - Contents: 15:32:26 INFO - build_url:https://queue.taskcluster.net/v1/task/WbqCzpGrTmWbmO2oCt2o7g/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 15:32:27 INFO - Running post-action listener: _resource_record_post_action 15:32:27 INFO - Running post-action listener: set_extra_try_arguments 15:32:27 INFO - [mozharness: 2016-10-18 22:32:27.515729Z] Finished download-and-extract step (success) 15:32:27 INFO - [mozharness: 2016-10-18 22:32:27.515901Z] Running populate-webroot step. 15:32:27 INFO - Running pre-action listener: _resource_record_pre_action 15:32:27 INFO - Running main action method: populate_webroot 15:32:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:32:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:32:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:32:27 INFO - '--tppagecycles', 15:32:27 INFO - '7'], 15:32:27 INFO - 'tests': ['tsvgm']}}, 15:32:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:32:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:32:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:32:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:32:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:32:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:32:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:27 INFO - 'talos_options': ['--disable-e10s'], 15:32:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:32:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:32:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:27 INFO - 'talos_options': ['--disable-e10s'], 15:32:27 INFO - 'tests': ['damp', 'tps']}, 15:32:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:27 INFO - 'tests': ['damp', 'tps']}, 15:32:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:32:27 INFO - 'tests': ['dromaeo_dom']}, 15:32:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:32:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:32:27 INFO - 'tests': ['basic_compositor_video']}, 15:32:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:32:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:32:27 INFO - 'tests': ['a11yr', 15:32:27 INFO - 'ts_paint', 15:32:27 INFO - 'tpaint', 15:32:27 INFO - 'sessionrestore', 15:32:27 INFO - 'sessionrestore_no_auto_restore', 15:32:27 INFO - 'tabpaint']}, 15:32:27 INFO - 'other-e10s': {'tests': ['a11yr', 15:32:27 INFO - 'ts_paint', 15:32:27 INFO - 'tpaint', 15:32:27 INFO - 'sessionrestore', 15:32:27 INFO - 'sessionrestore_no_auto_restore', 15:32:27 INFO - 'tabpaint']}, 15:32:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:32:27 INFO - 'ts_paint', 15:32:27 INFO - 'tpaint', 15:32:27 INFO - 'sessionrestore', 15:32:27 INFO - 'sessionrestore_no_auto_restore', 15:32:27 INFO - 'tabpaint']}, 15:32:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:32:27 INFO - 'ts_paint', 15:32:27 INFO - 'tpaint', 15:32:27 INFO - 'sessionrestore', 15:32:27 INFO - 'sessionrestore_no_auto_restore', 15:32:27 INFO - 'tabpaint']}, 15:32:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:32:27 INFO - 'tests': ['a11yr', 15:32:27 INFO - 'ts_paint', 15:32:27 INFO - 'tpaint', 15:32:27 INFO - 'sessionrestore', 15:32:27 INFO - 'sessionrestore_no_auto_restore', 15:32:27 INFO - 'tabpaint']}, 15:32:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:32:27 INFO - 'tests': ['a11yr', 15:32:27 INFO - 'ts_paint', 15:32:27 INFO - 'tpaint', 15:32:27 INFO - 'sessionrestore', 15:32:27 INFO - 'sessionrestore_no_auto_restore', 15:32:27 INFO - 'tabpaint']}, 15:32:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:32:27 INFO - 'tests': ['tsvgx', 15:32:27 INFO - 'tsvgr_opacity', 15:32:27 INFO - 'tart', 15:32:27 INFO - 'tscrollx', 15:32:27 INFO - 'cart']}, 15:32:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:32:27 INFO - 'tsvgr_opacity', 15:32:27 INFO - 'tart', 15:32:27 INFO - 'tscrollx', 15:32:27 INFO - 'cart']}, 15:32:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:27 INFO - 'talos_options': ['--disable-e10s'], 15:32:27 INFO - 'tests': ['tp5o']}, 15:32:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:27 INFO - 'tests': ['tp5o']}, 15:32:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:27 INFO - 'talos_options': ['--disable-e10s', 15:32:27 INFO - '--xperf_path', 15:32:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:32:27 INFO - 'tests': ['tp5n']}, 15:32:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:27 INFO - 'talos_options': ['--xperf_path', 15:32:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:32:27 INFO - 'tests': ['tp5n']}}, 15:32:27 INFO - 'talos.zip': {'path': '', 15:32:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:32:27 INFO - Running post-action listener: _resource_record_post_action 15:32:27 INFO - [mozharness: 2016-10-18 22:32:27.534814Z] Finished populate-webroot step (success) 15:32:27 INFO - [mozharness: 2016-10-18 22:32:27.534926Z] Running create-virtualenv step. 15:32:27 INFO - Running pre-action listener: _resource_record_pre_action 15:32:27 INFO - Running main action method: create_virtualenv 15:32:27 INFO - Creating virtualenv /builds/slave/test/build/venv 15:32:27 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 15:32:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:32:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:32:27 INFO - Using real prefix '/tools/python27' 15:32:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:32:28 INFO - Installing distribute.............................................................................................................................................................................................done. 15:32:31 INFO - Installing pip.................done. 15:32:31 INFO - Return code: 0 15:32:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:32:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:32:31 INFO - Reading from file tmpfile_stdout 15:32:31 INFO - Output received: 15:32:31 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) 15:32:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:32:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:31 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 0x10be4c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdc2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc5b485320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc60d30>, '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 0x10ba86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc58b20>, '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.e8uhZ7lvyV/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.fxwiFL4Txv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 15:32:31 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 15:32:31 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 15:32:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e8uhZ7lvyV/Render', 15:32:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:32:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:32:31 INFO - 'HOME': '/Users/cltbld', 15:32:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:32:31 INFO - 'LOGNAME': 'cltbld', 15:32:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:31 INFO - 'MOZ_NO_REMOTE': '1', 15:32:31 INFO - 'NO_EM_RESTART': '1', 15:32:31 INFO - 'PAGER': '/bin/cat', 15:32:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:32:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:31 INFO - 'PWD': '/builds/slave/test', 15:32:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:32:31 INFO - 'SHELL': '/bin/bash', 15:32:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fxwiFL4Txv/Listeners', 15:32:31 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 15:32:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:32:31 INFO - 'USER': 'cltbld', 15:32:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:32:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:32:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:31 INFO - 'XPC_FLAGS': '0x0', 15:32:31 INFO - 'XPC_SERVICE_NAME': '0', 15:32:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:32:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:31 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 15:32:31 INFO - Cleaning up... 15:32:31 INFO - Return code: 0 15:32:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:32:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:31 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 0x10be4c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdc2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc5b485320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc60d30>, '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 0x10ba86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc58b20>, '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.e8uhZ7lvyV/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.fxwiFL4Txv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 15:32:31 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 15:32:31 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 15:32:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e8uhZ7lvyV/Render', 15:32:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:32:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:32:31 INFO - 'HOME': '/Users/cltbld', 15:32:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:32:31 INFO - 'LOGNAME': 'cltbld', 15:32:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:31 INFO - 'MOZ_NO_REMOTE': '1', 15:32:31 INFO - 'NO_EM_RESTART': '1', 15:32:31 INFO - 'PAGER': '/bin/cat', 15:32:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:32:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:31 INFO - 'PWD': '/builds/slave/test', 15:32:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:32:31 INFO - 'SHELL': '/bin/bash', 15:32:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fxwiFL4Txv/Listeners', 15:32:31 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 15:32:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:32:31 INFO - 'USER': 'cltbld', 15:32:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:32:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:32:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:31 INFO - 'XPC_FLAGS': '0x0', 15:32:31 INFO - 'XPC_SERVICE_NAME': '0', 15:32:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:32:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:31 INFO - Downloading/unpacking psutil>=3.1.1 15:32:31 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 15:32:31 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 15:32:31 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 15:32:31 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 15:32:31 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 15:32:31 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 15:32:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:32:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:32:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:32:35 INFO - Installing collected packages: psutil 15:32:35 INFO - Running setup.py install for psutil 15:32:35 INFO - building 'psutil._psutil_osx' extension 15:32:35 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 15:32:35 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 15:32:35 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 15:32:36 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 15:32:36 INFO - building 'psutil._psutil_posix' extension 15:32:36 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 15:32:36 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:32:36 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:32:36 INFO - ^ 15:32:36 INFO - 1 warning generated. 15:32:36 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 15:32:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:32:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:32:36 INFO - Successfully installed psutil 15:32:36 INFO - Cleaning up... 15:32:36 INFO - Return code: 0 15:32:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:32:36 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')]} 15:32:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:36 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')]} 15:32:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:36 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 0x10be4c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdc2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc5b485320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc60d30>, '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 0x10ba86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc58b20>, '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.e8uhZ7lvyV/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.fxwiFL4Txv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 15:32:36 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 15:32:36 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 15:32:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e8uhZ7lvyV/Render', 15:32:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:32:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:32:36 INFO - 'HOME': '/Users/cltbld', 15:32:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:32:36 INFO - 'LOGNAME': 'cltbld', 15:32:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:36 INFO - 'MOZ_NO_REMOTE': '1', 15:32:36 INFO - 'NO_EM_RESTART': '1', 15:32:36 INFO - 'PAGER': '/bin/cat', 15:32:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:32:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:36 INFO - 'PWD': '/builds/slave/test', 15:32:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:32:36 INFO - 'SHELL': '/bin/bash', 15:32:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fxwiFL4Txv/Listeners', 15:32:36 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 15:32:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:32:36 INFO - 'USER': 'cltbld', 15:32:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:32:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:32:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:36 INFO - 'XPC_FLAGS': '0x0', 15:32:36 INFO - 'XPC_SERVICE_NAME': '0', 15:32:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:32:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:32:36 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 15:32:36 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 15:32:36 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 15:32:36 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 15:32:36 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 15:32:36 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 15:32:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:32:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:32:39 INFO - Installing collected packages: mozsystemmonitor 15:32:39 INFO - Running setup.py install for mozsystemmonitor 15:32:39 INFO - Successfully installed mozsystemmonitor 15:32:39 INFO - Cleaning up... 15:32:39 INFO - Return code: 0 15:32:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:32: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')]} 15:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32: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')]} 15:32:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32: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', '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 0x10be4c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdc2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc5b485320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc60d30>, '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 0x10ba86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc58b20>, '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.e8uhZ7lvyV/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.fxwiFL4Txv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 15:32: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:32: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 jsonschema==2.5.1 15:32:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e8uhZ7lvyV/Render', 15:32:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:32:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:32:39 INFO - 'HOME': '/Users/cltbld', 15:32:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:32:39 INFO - 'LOGNAME': 'cltbld', 15:32:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:39 INFO - 'MOZ_NO_REMOTE': '1', 15:32:39 INFO - 'NO_EM_RESTART': '1', 15:32:39 INFO - 'PAGER': '/bin/cat', 15:32:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:32:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:39 INFO - 'PWD': '/builds/slave/test', 15:32:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:32:39 INFO - 'SHELL': '/bin/bash', 15:32:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fxwiFL4Txv/Listeners', 15:32:39 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 15:32:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:32:39 INFO - 'USER': 'cltbld', 15:32:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:32:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:32:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:39 INFO - 'XPC_FLAGS': '0x0', 15:32:39 INFO - 'XPC_SERVICE_NAME': '0', 15:32:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:32:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:39 INFO - Downloading/unpacking jsonschema==2.5.1 15:32:39 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 15:32:39 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 15:32:39 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 15:32:39 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 15:32:39 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 15:32:39 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 15:32:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:32:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:42 INFO - Downloading functools32-3.2.3-2.tar.gz 15:32:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:32:42 INFO - warning: no files found matching '*.txt' 15:32:42 INFO - no previously-included directories found matching 'build' 15:32:42 INFO - no previously-included directories found matching 'dist' 15:32:42 INFO - no previously-included directories found matching '.git*' 15:32:42 INFO - Installing collected packages: jsonschema, functools32 15:32:42 INFO - Running setup.py install for functools32 15:32:42 INFO - warning: no files found matching '*.txt' 15:32:42 INFO - no previously-included directories found matching 'build' 15:32:42 INFO - no previously-included directories found matching 'dist' 15:32:42 INFO - no previously-included directories found matching '.git*' 15:32:42 INFO - Successfully installed jsonschema functools32 15:32:42 INFO - Cleaning up... 15:32:43 INFO - Return code: 0 15:32:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:32: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')]} 15:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32: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')]} 15:32:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32: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', '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 0x10be4c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdc2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc5b485320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc60d30>, '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 0x10ba86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc58b20>, '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.e8uhZ7lvyV/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.fxwiFL4Txv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 15:32: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:32: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 functools32==3.2.3-2 15:32:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e8uhZ7lvyV/Render', 15:32:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:32:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:32:43 INFO - 'HOME': '/Users/cltbld', 15:32:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:32:43 INFO - 'LOGNAME': 'cltbld', 15:32:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:43 INFO - 'MOZ_NO_REMOTE': '1', 15:32:43 INFO - 'NO_EM_RESTART': '1', 15:32:43 INFO - 'PAGER': '/bin/cat', 15:32:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:32:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:43 INFO - 'PWD': '/builds/slave/test', 15:32:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:32:43 INFO - 'SHELL': '/bin/bash', 15:32:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fxwiFL4Txv/Listeners', 15:32:43 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 15:32:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:32:43 INFO - 'USER': 'cltbld', 15:32:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:32:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:32:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:43 INFO - 'XPC_FLAGS': '0x0', 15:32:43 INFO - 'XPC_SERVICE_NAME': '0', 15:32:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:32:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:32:43 INFO - Cleaning up... 15:32:43 INFO - Return code: 0 15:32:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:32: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')]} 15:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32: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')]} 15:32:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32: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', '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 0x10be4c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdc2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc5b485320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc60d30>, '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 0x10ba86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc58b20>, '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.e8uhZ7lvyV/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.fxwiFL4Txv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 15:32: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:32: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 blobuploader==1.2.4 15:32:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e8uhZ7lvyV/Render', 15:32:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:32:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:32:43 INFO - 'HOME': '/Users/cltbld', 15:32:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:32:43 INFO - 'LOGNAME': 'cltbld', 15:32:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:43 INFO - 'MOZ_NO_REMOTE': '1', 15:32:43 INFO - 'NO_EM_RESTART': '1', 15:32:43 INFO - 'PAGER': '/bin/cat', 15:32:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:32:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:43 INFO - 'PWD': '/builds/slave/test', 15:32:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:32:43 INFO - 'SHELL': '/bin/bash', 15:32:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fxwiFL4Txv/Listeners', 15:32:43 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 15:32:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:32:43 INFO - 'USER': 'cltbld', 15:32:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:32:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:32:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:43 INFO - 'XPC_FLAGS': '0x0', 15:32:43 INFO - 'XPC_SERVICE_NAME': '0', 15:32:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:32:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:43 INFO - Downloading/unpacking blobuploader==1.2.4 15:32: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 15:32: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 15:32: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 15:32: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 15:32: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 15:32: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 15:32:46 INFO - Downloading blobuploader-1.2.4.tar.gz 15:32:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:32:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:32:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:47 INFO - Downloading docopt-0.6.1.tar.gz 15:32:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:32:47 INFO - Installing collected packages: blobuploader, requests, docopt 15:32:47 INFO - Running setup.py install for blobuploader 15:32:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:32:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:32:47 INFO - Running setup.py install for requests 15:32:47 INFO - Running setup.py install for docopt 15:32:48 INFO - Successfully installed blobuploader requests docopt 15:32:48 INFO - Cleaning up... 15:32:48 INFO - Return code: 0 15:32:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:32:48 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')]} 15:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:48 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')]} 15:32:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:48 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 0x10be4c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdc2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc5b485320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc60d30>, '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 0x10ba86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc58b20>, '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.e8uhZ7lvyV/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.fxwiFL4Txv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 15:32:48 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 15:32:48 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 15:32:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e8uhZ7lvyV/Render', 15:32:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:32:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:32:48 INFO - 'HOME': '/Users/cltbld', 15:32:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:32:48 INFO - 'LOGNAME': 'cltbld', 15:32:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:48 INFO - 'MOZ_NO_REMOTE': '1', 15:32:48 INFO - 'NO_EM_RESTART': '1', 15:32:48 INFO - 'PAGER': '/bin/cat', 15:32:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:32:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:48 INFO - 'PWD': '/builds/slave/test', 15:32:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:32:48 INFO - 'SHELL': '/bin/bash', 15:32:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fxwiFL4Txv/Listeners', 15:32:48 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 15:32:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:32:48 INFO - 'USER': 'cltbld', 15:32:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:32:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:32:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:48 INFO - 'XPC_FLAGS': '0x0', 15:32:48 INFO - 'XPC_SERVICE_NAME': '0', 15:32:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:32:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:32:48 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-uwJaDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:32:48 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-2C8_3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:32:48 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-zYVxZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:32:48 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-Fol9Zx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:32:48 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-N7SglA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:32:49 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-w4HqJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:32:49 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-7pQk9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:32:49 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-fgQzBd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:32:49 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-FYGjA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:32:49 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-BQHM_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:32:49 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-Jk4tnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:32:49 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-p6t4rT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:32:49 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-dE4Yc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:32:49 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-HYmMdo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:32:49 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-nlIH2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:32:50 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-gHN1NQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:32:50 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-ZZHEUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:32:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:32:50 INFO - Running setup.py install for manifestparser 15:32:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:32:50 INFO - Running setup.py install for mozcrash 15:32:50 INFO - Running setup.py install for mozdebug 15:32:50 INFO - Running setup.py install for mozdevice 15:32:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:32:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:32:50 INFO - Running setup.py install for mozfile 15:32:51 INFO - Running setup.py install for mozhttpd 15:32:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:32:51 INFO - Running setup.py install for mozinfo 15:32:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:32:51 INFO - Running setup.py install for mozInstall 15:32:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:32:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:32:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:32:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:32:51 INFO - Running setup.py install for mozleak 15:32:51 INFO - Running setup.py install for mozlog 15:32:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:32:51 INFO - Running setup.py install for moznetwork 15:32:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:32:51 INFO - Running setup.py install for mozprocess 15:32:52 INFO - Running setup.py install for mozprofile 15:32:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:32:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:32:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:32:52 INFO - Running setup.py install for mozrunner 15:32:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:32:52 INFO - Running setup.py install for mozscreenshot 15:32:52 INFO - Running setup.py install for moztest 15:32:52 INFO - Running setup.py install for mozversion 15:32:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:32:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:32:52 INFO - Cleaning up... 15:32:52 INFO - Return code: 0 15:32:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10be4c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdc2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc5b485320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc60d30>, '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 0x10ba86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc58b20>, '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.e8uhZ7lvyV/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.fxwiFL4Txv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 15:32:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:32:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:32:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e8uhZ7lvyV/Render', 15:32:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:32:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:32:52 INFO - 'HOME': '/Users/cltbld', 15:32:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:32:52 INFO - 'LOGNAME': 'cltbld', 15:32:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:52 INFO - 'MOZ_NO_REMOTE': '1', 15:32:52 INFO - 'NO_EM_RESTART': '1', 15:32:52 INFO - 'PAGER': '/bin/cat', 15:32:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:32:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:52 INFO - 'PWD': '/builds/slave/test', 15:32:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:32:52 INFO - 'SHELL': '/bin/bash', 15:32:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fxwiFL4Txv/Listeners', 15:32:52 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 15:32:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:32:52 INFO - 'USER': 'cltbld', 15:32:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:32:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:32:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:52 INFO - 'XPC_FLAGS': '0x0', 15:32:52 INFO - 'XPC_SERVICE_NAME': '0', 15:32:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:32:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:32:53 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-YPrMS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:32:53 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)) 15:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:32:53 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-zvHdIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:32:53 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)) 15:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:32:53 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-8y7cRp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:32:53 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)) 15:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:32:53 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-1EThAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:32:53 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)) 15:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:32:53 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-uEVDWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:32:53 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)) 15:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:32:53 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-LQZEOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:32:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:32:53 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-SIdLtH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:32:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:32:53 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-Ww_v5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:32:54 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)) 15:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:32:54 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-Vm7SRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:32:54 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)) 15:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:32:54 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-5p_syK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:32:54 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)) 15:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:32:54 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-PTu2Bi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:32:54 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)) 15:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:32:54 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-A8bdH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:32:54 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)) 15:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:32:54 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-vIK6rT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:32:54 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)) 15:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:32:54 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-GPFeAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:32:54 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)) 15:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:32:54 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-tX6xox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:32:54 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-BHCl_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:32:54 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-vPxp1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:32:55 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)) 15:32:55 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)) 15:32:55 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)) 15:32:55 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)) 15:32:55 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)) 15:32:55 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)) 15:32:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:32:55 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 15:32:55 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 15:32:55 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 15:32:55 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 15:32:55 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 15:32:55 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 15:32:57 INFO - Downloading blessings-1.6.tar.gz 15:32:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:32:57 INFO - Installing collected packages: blessings 15:32:57 INFO - Running setup.py install for blessings 15:32:57 INFO - Successfully installed blessings 15:32:57 INFO - Cleaning up... 15:32:57 INFO - Return code: 0 15:32:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:32:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:32:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:32:58 INFO - Reading from file tmpfile_stdout 15:32:58 INFO - Current package versions: 15:32:58 INFO - blessings == 1.6 15:32:58 INFO - blobuploader == 1.2.4 15:32:58 INFO - docopt == 0.6.1 15:32:58 INFO - functools32 == 3.2.3-2 15:32:58 INFO - jsonschema == 2.5.1 15:32:58 INFO - manifestparser == 1.1 15:32:58 INFO - mozInstall == 1.12 15:32:58 INFO - mozcrash == 0.17 15:32:58 INFO - mozdebug == 0.1 15:32:58 INFO - mozdevice == 0.48 15:32:58 INFO - mozfile == 1.2 15:32:58 INFO - mozhttpd == 0.7 15:32:58 INFO - mozinfo == 0.9 15:32:58 INFO - mozleak == 0.1 15:32:58 INFO - mozlog == 3.4 15:32:58 INFO - moznetwork == 0.27 15:32:58 INFO - mozprocess == 0.23 15:32:58 INFO - mozprofile == 0.28 15:32:58 INFO - mozrunner == 6.12 15:32:58 INFO - mozscreenshot == 0.1 15:32:58 INFO - mozsystemmonitor == 0.3 15:32:58 INFO - moztest == 0.7 15:32:58 INFO - mozversion == 1.4 15:32:58 INFO - psutil == 3.1.1 15:32:58 INFO - requests == 1.2.3 15:32:58 INFO - wsgiref == 0.1.2 15:32:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:32:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10be4c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdc2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc5b485320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc60d30>, '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 0x10ba86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc58b20>, '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.e8uhZ7lvyV/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.fxwiFL4Txv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 15:32:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:32:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:32:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e8uhZ7lvyV/Render', 15:32:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:32:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:32:58 INFO - 'HOME': '/Users/cltbld', 15:32:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:32:58 INFO - 'LOGNAME': 'cltbld', 15:32:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:58 INFO - 'MOZ_NO_REMOTE': '1', 15:32:58 INFO - 'NO_EM_RESTART': '1', 15:32:58 INFO - 'PAGER': '/bin/cat', 15:32:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:32:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:58 INFO - 'PWD': '/builds/slave/test', 15:32:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:32:58 INFO - 'SHELL': '/bin/bash', 15:32:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fxwiFL4Txv/Listeners', 15:32:58 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 15:32:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:32:58 INFO - 'USER': 'cltbld', 15:32:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:32:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:32:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:58 INFO - 'XPC_FLAGS': '0x0', 15:32:58 INFO - 'XPC_SERVICE_NAME': '0', 15:32:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:32:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:32:58 INFO - Cleaning up... 15:32:58 INFO - Return code: 0 15:32:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:32:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:58 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 0x10be4c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdc2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc5b485320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc60d30>, '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 0x10ba86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc58b20>, '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.e8uhZ7lvyV/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.fxwiFL4Txv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 15:32:58 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 15:32:58 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 15:32:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e8uhZ7lvyV/Render', 15:32:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:32:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:32:58 INFO - 'HOME': '/Users/cltbld', 15:32:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:32:58 INFO - 'LOGNAME': 'cltbld', 15:32:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:58 INFO - 'MOZ_NO_REMOTE': '1', 15:32:58 INFO - 'NO_EM_RESTART': '1', 15:32:58 INFO - 'PAGER': '/bin/cat', 15:32:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:32:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:58 INFO - 'PWD': '/builds/slave/test', 15:32:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:32:58 INFO - 'SHELL': '/bin/bash', 15:32:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fxwiFL4Txv/Listeners', 15:32:58 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 15:32:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:32:58 INFO - 'USER': 'cltbld', 15:32:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:32:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:32:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:58 INFO - 'XPC_FLAGS': '0x0', 15:32:58 INFO - 'XPC_SERVICE_NAME': '0', 15:32:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:32:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:32:58 INFO - Cleaning up... 15:32:58 INFO - Return code: 0 15:32:58 INFO - Running post-action listener: _resource_record_post_action 15:32:58 INFO - Running post-action listener: _start_resource_monitoring 15:32:58 INFO - Starting resource monitoring. 15:32:58 INFO - [mozharness: 2016-10-18 22:32:58.761899Z] Finished create-virtualenv step (success) 15:32:58 INFO - [mozharness: 2016-10-18 22:32:58.763009Z] Running install step. 15:32:58 INFO - Running pre-action listener: _resource_record_pre_action 15:32:58 INFO - Running main action method: install 15:32:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:32:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:32:59 INFO - Reading from file tmpfile_stdout 15:32:59 INFO - Detecting whether we're running mozinstall >=1.0... 15:32:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:32:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:32:59 INFO - Reading from file tmpfile_stdout 15:32:59 INFO - Output received: 15:32:59 INFO - Usage: mozinstall [options] installer 15:32:59 INFO - Options: 15:32:59 INFO - -h, --help show this help message and exit 15:32:59 INFO - -d DEST, --destination=DEST 15:32:59 INFO - Directory to install application into. [default: 15:32:59 INFO - "/builds/slave/test"] 15:32:59 INFO - --app=APP Application being installed. [default: firefox] 15:32:59 INFO - mkdir: /builds/slave/test/build/application 15:32:59 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'] 15:32:59 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 15:33:33 INFO - Reading from file tmpfile_stdout 15:33:33 INFO - Output received: 15:33:33 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:33:33 INFO - Running post-action listener: _resource_record_post_action 15:33:33 INFO - [mozharness: 2016-10-18 22:33:33.542427Z] Finished install step (success) 15:33:33 INFO - [mozharness: 2016-10-18 22:33:33.542540Z] Running run-tests step. 15:33:33 INFO - Running pre-action listener: _resource_record_pre_action 15:33:33 INFO - Running main action method: run_tests 15:33:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:33:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:33:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:33:33 INFO - 2016-10-18 15:33:33.556 screenresolution[3028:41812] starting screenresolution argv=screenresolution get 15:33:33 INFO - 2016-10-18 15:33:33.559 screenresolution[3028:41812] Display 0: 1600x1200x32@60 15:33:33 INFO - 2016-10-18 15:33:33.566 screenresolution[3029:41814] starting screenresolution argv=screenresolution list 15:33:33 INFO - Available Modes on Display 0 15:33:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:33:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:33:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:33:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:33:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:33:33 INFO - Intel Iris: 15:33:33 INFO - Chipset Model: Intel Iris 15:33:33 INFO - Type: GPU 15:33:33 INFO - Bus: Built-In 15:33:33 INFO - VRAM (Dynamic, Max): 1536 MB 15:33:33 INFO - Vendor: Intel (0x8086) 15:33:33 INFO - Device ID: 0x0a2e 15:33:33 INFO - Revision ID: 0x0009 15:33:33 INFO - Displays: 15:33:33 INFO - Display: 15:33:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:33:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:33:33 INFO - Display Serial Number: 1600x1200 60 15:33:33 INFO - Main Display: Yes 15:33:33 INFO - Mirror: Off 15:33:33 INFO - Online: Yes 15:33:33 INFO - Rotation: Supported 15:33:33 INFO - Return code: 0 15:33:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:33:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:33:33 INFO - Python 2.7.3 15:33:33 INFO - Return code: 0 15:33:33 INFO - grabbing minidump binary from tooltool 15:33:33 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')]} 15:33:33 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 0x10bc60d30>, '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 0x10ba86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc58b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:33:33 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 15:33:33 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 15:33:33 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 15:33:33 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:33:33 INFO - Return code: 0 15:33:33 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:33:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:33:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:33:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:33:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:33:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WbqCzpGrTmWbmO2oCt2o7g/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0038', '--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 15:33:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WbqCzpGrTmWbmO2oCt2o7g/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0038 --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 15:33:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e8uhZ7lvyV/Render', 15:33:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:33 INFO - 'HOME': '/Users/cltbld', 15:33:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:33 INFO - 'LOGNAME': 'cltbld', 15:33:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:33:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:33:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:33 INFO - 'MOZ_NO_REMOTE': '1', 15:33:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:33:33 INFO - 'NO_EM_RESTART': '1', 15:33:33 INFO - 'PAGER': '/bin/cat', 15:33:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:33 INFO - 'PWD': '/builds/slave/test', 15:33:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:33:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:33 INFO - 'SHELL': '/bin/bash', 15:33:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fxwiFL4Txv/Listeners', 15:33:33 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 15:33:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:33 INFO - 'USER': 'cltbld', 15:33:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:33 INFO - 'XPC_FLAGS': '0x0', 15:33:33 INFO - 'XPC_SERVICE_NAME': '0', 15:33:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WbqCzpGrTmWbmO2oCt2o7g/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0038', '--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 15:33:34 INFO - mozversion application_buildid: 20161018132202 15:33:34 INFO - mozversion application_changeset: 3ce14ff1acd5816d957b93135174b86d1cb63afa 15:33:34 INFO - mozversion application_display_name: Nightly 15:33:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:33:34 INFO - mozversion application_name: Firefox 15:33:34 INFO - mozversion application_remotingname: firefox 15:33:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 15:33:34 INFO - mozversion application_vendor: Mozilla 15:33:34 INFO - mozversion application_version: 52.0a1 15:33:34 INFO - mozversion platform_buildid: 20161018132202 15:33:34 INFO - mozversion platform_changeset: 3ce14ff1acd5816d957b93135174b86d1cb63afa 15:33:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 15:33:34 INFO - mozversion platform_version: 52.0a1 15:33:34 INFO - using testdate: 1476830014 15:33:34 INFO - actual date: 1476830014 15:33:34 INFO - starting webserver on 'localhost:55747' 15:33:34 INFO - SUITE-START | Running 2 tests 15:33:34 INFO - TEST-START | dromaeo_css 15:33:34 INFO - operating with platform_type : mac_ 15:33:34 INFO - Initialising browser for dromaeo_css test... 15:33:34 INFO - TEST-INFO | started process 3039 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmp7GwKg8/profile http://localhost:55747/getInfo.html) 15:33:36 INFO - PROCESS | 3039 | __metrics Screen width/height:1600/1200 15:33:36 INFO - PROCESS | 3039 | colorDepth:24 15:33:36 INFO - PROCESS | 3039 | Browser inner width/height: 1024/689 15:33:36 INFO - PROCESS | 3039 | __metrics 15:33:36 INFO - PROCESS | 3039 | 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" 15:33:36 INFO - PROCESS | 3039 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:33:37 INFO - TEST-INFO | 3039: exit 0 15:33:37 INFO - Browser initialized. 15:33:37 INFO - Running cycle 1/1 for dromaeo_css test... 15:33:37 INFO - TEST-INFO | started process 3041 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmp7GwKg8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:33:49 INFO - PROCESS | 3041 | RSS: Main: 231284736 15:33:49 INFO - PROCESS | 3041 | 15:34:40 INFO - PROCESS | 3041 | 1476830080439 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] 15:36:54 INFO - PROCESS | 3041 | Cycle 1(1): loaded http://localhost:55747/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55747/tests/dromaeo/cssquery-ext.html) 15:36:56 INFO - PROCESS | 3041 | RSS: Main: 402706432 15:36:56 INFO - PROCESS | 3041 | 15:39:58 INFO - PROCESS | 3041 | Cycle 1(1): loaded http://localhost:55747/tests/dromaeo/cssquery-ext.html (next: http://localhost:55747/tests/dromaeo/cssquery-jquery.html) 15:39:59 INFO - PROCESS | 3041 | RSS: Main: 370626560 15:39:59 INFO - PROCESS | 3041 | 15:43:01 INFO - PROCESS | 3041 | Cycle 1(1): loaded http://localhost:55747/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55747/tests/dromaeo/cssquery-mootools.html) 15:43:02 INFO - PROCESS | 3041 | RSS: Main: 330469376 15:43:02 INFO - PROCESS | 3041 | 15:46:04 INFO - PROCESS | 3041 | Cycle 1(1): loaded http://localhost:55747/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55747/tests/dromaeo/cssquery-prototype.html) 15:46:05 INFO - PROCESS | 3041 | RSS: Main: 332427264 15:46:05 INFO - PROCESS | 3041 | 15:49:08 INFO - PROCESS | 3041 | Cycle 1(1): loaded http://localhost:55747/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55747/tests/dromaeo/cssquery-yui.html) 15:49:09 INFO - PROCESS | 3041 | RSS: Main: 328601600 15:49:09 INFO - PROCESS | 3041 | 15:52:12 INFO - PROCESS | 3041 | Cycle 1(1): loaded http://localhost:55747/tests/dromaeo/cssquery-yui.html (next: http://localhost:55747/tests/dromaeo/cssquery-dojo.html) 15:52:12 INFO - PROCESS | 3041 | RSS: Main: 548356096 15:52:12 INFO - PROCESS | 3041 | 15:52:12 INFO - PROCESS | 3041 | __start_tp_report 15:52:12 INFO - PROCESS | 3041 | _x_x_mozilla_page_load 15:52:12 INFO - PROCESS | 3041 | _x_x_mozilla_page_load_details 15:52:12 INFO - PROCESS | 3041 | |i|pagename|runs| 15:52:12 INFO - PROCESS | 3041 | |0;dojo.html;2962.185399015269;3138.497840345545;3260.625028121766;3277.7705560610766;3287.621923478799;5520.309961254843;5601;5622.91565626516;5674.205611214428;5709.942900570993;5614.522765564921;5656.349519805213;5734.569907256962;5742.39704830993;5801.303843538782;4293.978530107345;5157.458466860982;5228.032813929416;5236.371635403757;5236.895262094756;5151.098557752397;5223.921641175385;5236.8690782730355;5244.895102097956;5253.921191182136;5079.3650793650795;5200.92198617021;5216.478352164791;5231.816886408977;5232.502912223333;5086.720230387327;5146.022255771391;5208.192730126818;5208.973955130238;5215.16557350822;5060.962502686941;5117.974410127926;5149.433562308143;5149.76826042829;5153.66501177426;5631.549476041907;5634.464725851038;5637.915431268493;5645.322561292671;5658.405867383906;5001.349824522825;6083.943773510214;6133.095051491853;6133.570650054498;6171.907421388682;6168.228971378578;6176.104464852616;6206.968965155145;6235.438810507031;6261.906071408933;5633.126865335879;5774.878628653641;5784.248047753765;5789.102689083199;5841.766329346821;6163.506919446433;6167.136600875881;6194.473469755031;6205.131281620576;6262.780802671885;6103.298120716086;6106.604636367212;6106.832124512725;6112.224947389871;6125.018737820453;6164.321924588292;6189.81430557075;6191.504679625619;6203.565750397519;6225.937740622536;6012.609180403259;6059.878802424015;6080.543959203077;6096.786612468542;6100.762843515373;6143.846403839851;6156.415140561639;6174.44430001293;6176.8764624707255;6179.721912513947;4852.199387101089;4868;4899.853004409873;4917.283066889312;4926.989967056745;3815.8361699681864;4370.972821386971;4434;4452.866414007585;4458.509563947963;5676.120201368794;5687.630304030225;5691.459311365414;5701.914471282934;5702.686352250583;6147.938520614826;6154;6154.969225153845;6157.107219453154;6171.352008039091;5701.629394089371;5746.195532625436;5758.510526605201;5769;5826.184334193216;5383;5387.24578559002;5397.4062853086125;5399.217113518596;5438.91841622376;6262.81211563663;6271.655058971709;6278.874422511432;6281.497480201664;6295.370462953668;6104.974570883654;6108.8778224436155;6137.162486020116;6142.590862071594;6217.129601855653;6236.407541283571;6244.438000579969;6254.21822272216;6262.780802671885;6266.811995640138;6106.57253992234;6111.083337499233;6114.266288045463;6124.265088189446;6146.938530614637;6097.298810636834;6177.413145751147;6189.473894718999;6197.938020619736;6207.379262073937;5955.731992060281;5956.37458066914;5972.492338151305;5975.40245975399;6038.245219347582;6014.278286605635;6020.277566692025;6020.969895150496;6026.367231440811;6050.576459647782;5829.7959571416495;5831.475167234969;5840.678762668094;5861.35525092248;5894.6757928314355;5839.182514448065;5915.556333274935;5918;6005.90991135142;6029.9698501508965;5845.064789633639;5870.589058765845;5888.793892213752;5892.292924849045;5938.762449501972 15:52:12 INFO - PROCESS | 3041 | |1;ext.html;434.48079544943795;506.50362644608305;506.5441103007291;520.7396301849076;542.0595267211389;24008.87995560022;30663.540046899314;31270.84364578174;31329.530057049105;31343.902963396256;31139.844300778463;40257;41480.37779433311;41516.75449736505;42503.14993700124;9388.061193880609;9502.47736374499;9520;9524.904750952506;9528.523573821316;9397.718068457923;9485.051494850495;9492.288078394147;9499.81000379992;9501.904980950205;9407.81184376312;9442.858357124649;9477.526123693822;9483.33616646835;9486.383385079947;9417.340786144972;9470;9470.337076404654;9484.573194206243;9485.33602647815;9321;9386.700258436658;9410.106039926197;9414.388064775767;9416.387934784285;38679.80660096682;38978.610213898064;38982.61017389818;38982.80508597439;39010.02474938149;3362.6469220731715;3370.612379576331;3377.594688637379;3544.149404143013;3558.867986650517;29546.852265738748;29793.702062979308;30173.396532069237;30327;30358.241043973856;3146.181992681896;3152.574402455662;3169.762267829899;3175.333180032196;3266.8856590019236;466380.6680966573;469712;471900;471904;481566;55415.168772468445;55664.72167639136;55701.1644825328;55740.442595574335;55762.72118639381;33604.83197583997;34221.82889085539;58902.410975889696;59010;59142;15501.302441390164;15936.282867271;15938.521844344688;15942.20288985546;15972.920135399481;12187.964023057963;12290.385480725929;12305.56930507428;12311.69220769488;12343.07426942965;18375.816241837678;18441.170147343135;18449.354272600394;18545.35091271799;18551.886886786837;6580.795433529725;8011.959940200261;8058;8095.190480951976;8101.675932962733;811.5009269299338;907.5636934760736;945.2485274207022;994.0953732103895;1024.9743756406;24030.639540406908;24070.87964560166;29346.706532934826;30294.84852575723;30452;884.9380543362032;1016.1515134862325;1036.8600238967642;1182.9885447942058;1199.1605875886914;12778.9361053196;15196.316165772567;15236.390544378322;15385.922985390915;15628.374865005273;646717;650676;653204;653772;654722;55858.720706396205;56220.718896405255;56347.87304253892;56400;56516.43483565194;1270.7776139175608;1307.8103674967076;1379.5792283353674;1394.4910107810576;1408.253625578445;28735.568966465937;30602;30769.076927692204;30819.662345673372;31215.84392078025;47121.52878471308;47555;47638.523614764796;47693.761531192125;47817.76091119522;508438;509644;510913;511177;511683;25807.870960645076;26974;27149.321266968484;27211.86394068017;27487.45025099527;45914.540854591025;46023.76988115038;46098.308525371474;46615.766921165174;46645;37517;38197.23605527818;39314.410283845194;39769.80115099406;41312.554060607734;37377;37772.45698568364;37845.43231851579;39017.80491097526;39329.016774580865;34401.17844867414;35096.29807403889;37590;38302.233955321295;38433.2313353737;30138.698613014465;31534.684653153174;34205.65794342025;34503.82748086344;34530.82734586311;22306.77693223047;22692.319230423112;24054.518909621358;24960.50078998446;25764.484710306064 15:52:12 INFO - PROCESS | 3041 | |2;jquery.html;350.22250603659865;370.71454979665657;371.56341298973706;379.4232766195382;399.2693371130831;14959.775603365959;15123.773143402857;15729.314531884467;20690.96545172743;20793.064312105955;16989;18139.45581632553;19886.204551817948;20460.87465189414;20949.685754713653;5761.193432919385;6046.727897244635;6047.879042419149;6052.485538729214;6058.1518587397795;5513.228148059255;5881.823545293648;5922.318933322658;5925.733341999598;5928.318243402021;5612.41069687683;5858.970705146468;5896;5896.174535565025;5897.911531327033;5826.873191285193;5908.615939963888;5975.611585246988;5981.730822113015;5985.551083668743;5109.974450127763;5175.508326708957;5177.145770947826;5182.740862956837;5383.273258110184;12731.681707957283;13044.152130111608;13055.21668699881;13064.477420903153;20172.596548069105;2113.9154433822628;2132.157797669912;2260.9524187625284;2481.280428675682;2517.2196619048154;9704.417734935927;9744.366616169926;9820.017998200194;10086.495675216283;10240.334378265388;1806.2594336322177;1839.678056340135;1851.583393736412;1894.5453091258137;1977.6539105656595;114767;117842;120367;120506.39746801298;122525;9306.2089722373;9360.672376466791;9944.038095805612;10013.49932503372;11199.552017919355;12224.877751222373;12324;12328.75342493145;12332.136750427384;12342.074344424203;7938.56337901421;8069.435139540294;8105.230003149692;8232.958835205785;8249.422540422232;8036;8264.049634292012;8295.958520207481;8421.90515233028;8668.349873759493;3302.570665813477;3806.5812760596314;3852.210296889131;3875.3024455597697;3886.4364667123673;1712.571857035741;1795.7037088880188;1924.5477312831474;1931.777845547752;1965.4398496428448;790.4190420041265;837.7068026190906;846.4202021615213;935.9003171273727;943.7829299261072;19493.707594386095;20499.487512812;20747.481312966996;20852.578329634405;21140.47148821292;888.4802390601441;922.524899676667;934.243262957007;941.8634298026885;996.6063404955147;8059.677612895536;9833.754156146153;11030;11222.551097956153;11238.887611123784;499797;571556;577718;577740;584560;95791.56312655316;102351.4882425583;127803;133650;134096;965.7247684409909;1012.731626119079;1044.8693913260843;1045.696747943088;1046.4506134279563;14614.488492902698;18583.72124418162;18876.622467550846;19375.709364359263;19530.21879124819;56056.15915761185;56420.8715825673;56891.466280058325;57269.42730572807;57269.71365143148;56824.623937049924;77222;77443.61278193574;78880.60559697165;80989.59505202436;5257.187404738599;5385.676859388449;7659.961700191463;8036.981509245377;8151.63317650719;12349.691257718629;12481.812772808233;12687.873121268669;12838.16551924122;13187.53843615469;11093.611723589636;11099.60202802169;11163.888361116286;11356.318620882774;11453.08375329955;10054.095131438205;10378.844317335397;10542.314749541256;10602.20483463728;10973.945130274298;10186.337888037255;10193.490325483845;11251.324920504796;11587.188896777145;11627.59303424376;6789.253182149861;7270.6728197232305;7384.630768461663;8041;8336.7915802103;11167.678770603545;11440.599579014695;11620.302781833117;11714.589989350672;11754.294742315147 15:52:12 INFO - PROCESS | 3041 | |3;mootools.html;1542.4986879264238;1575.787268718723;1795.3716199330236;1912.2733361322696;1951.6291904538136;8279;8781.824363512726;8794.604242809073;8814.559272036397;8825.691100811473;7742.303192712655;7984.081830589484;7992.160823113562;8328.250457458827;8548.444351117174;2324.1981516376823;2365.95268094638;2370.383700237933;2371.8695471749047;2374.631932050535;2019.7881271237213;2306.907723691059;2341.4146463384154;2353.399883029825;2354.858708477488;2328.2200462844967;2340.0639744102323;2344.8510229987355;2347.3779448446176;2350.9647355289685;2326.569584626841;2331.743508214095;2332.5801355755957;2333.195047708546;2335.883205839701;2295.690081838947;2302.5970455170445;2341.0167729553627;2346.0967527501866;2355;8688.391812573122;8722.215000649972;8737;8740.694075707383;8753.47479151253;5142.688614403341;5324.54741346986;5324.7071411072375;5334.813281535166;5338.439463856278;2988.6712461629204;3460.1522626956307;3542.3446662367287;3612.1150318171954;3616.7468277220605;1025.5487585462372;1070;1087.4888802262924;1090.0625462102585;1098.3245304137977;11584.073274138049;11610.709732256677;11613.535458581646;11627.476763545576;11628.6511404658;4495.393121928563;4692.319613656001;4722.645801564897;4750.7387093709485;4752.619790416758;9856.260780441495;9881.456519891475;9883.555240014217;9886.30795844284;9895.455749933679;5356.491133342326;5358.46415358461;5358.464153584689;5362;5365.892682146336;4723.31511930775;4827.975860120677;4833.975830120827;4904.877378065506;4922.163232250526;3810.466534685146;3833.769973801581;3846.9807650961566;3940.0346915006007;3948.9210215795524;1093.6227001684406;1276.6489215465822;1278.1308710077237;1289.4390939941156;1291.6706239908951;859.6905114158898;869.8434281829332;884.4958373726914;887.7070566712969;920.9217216536535;5533.584981126432;5660.745266463019;5757.280339957505;5817.731084876901;6003.969980150071;434.3506457845541;439.26642507013366;441.5827043443979;450.4144612004381;450.66425512992373;3827.808609569566;3828.1769419574925;3920.333543297589;3944.783036932939;3969.503812023497;7982.006747469699;10598.788024239471;10608.787824243473;10628.521716522775;10632.46837658114;10592.258541901992;10593.09958653523;10596.152307815357;10600.681979540626;10608.628697995688;7802.219778022152;7981.281684648409;7995.600219989094;8115.837683246302;8123.675052997932;5657;5695.658260504383;5698.287714035746;5702.2016917630735;5776.740046697824;9371.484568348533;9686.049413526329;9836.557354919189;9898.604055837686;9978.451185184884;9147.22248608849;9725.367851089657;9819.85270220933;10075.992400760158;10090.899091009289;6838.247792742894;7083.362497375261;7190.676419561028;7397.519161254501;7411.703531858665;8151.673933042612;8164.306033987177;8192.426530142833;8258.463199891989;8265.83468330642;6064.48451881595;7342.302481264272;7381.298776616213;7401.963725078601;7413.740519081806;7200.207977122408;7216.855662886608;7269.454790890599;7332.450066244946;7349.70601175947;6776.966115169393;6907.6891539879825;6924.3421874921805;6924.757633482804;6935.202451718117;4738.644601654821;4864.854054378375;4878.853634390974;4931.211006239128;5020.523050310215;4766.571008609242;4889.511048895082;4933.457319694902;4986.202207646759;5038.848834534823 15:52:12 INFO - PROCESS | 3041 | |4;prototype.html;297.0894209248653;297.92105092150587;306.09701380926265;311.1691782939551;313.42173689542784;5258.894822103561;5312.840614781563;5314.335708036496;5339;5348.251244825728;4460.330950357448;4781.589431117829;4991.825286114987;5119.948800511994;5256.26412302278;3634.4548317752283;4010.6363836295654;4025.6376926076646;4040.454538637283;4045.474088368508;3245.8701651933893;3317.3579078356247;3931.2334094851517;4034.3055916514986;4057;3475.6176820549717;3771.6039815819354;3881.4371916072155;3963.246983073207;3989.840406383741;3961.643452089297;3964.7224694271413;4000.8399664013405;4014.698897582693;4018.7387819791766;3073.9394908756444;3247.7401807855313;3451.2234747181933;3454.3091381723757;3457.429524128516;4035.334169861999;4430.689851710382;5180.808414064749;5187.766550505198;5190.792368305301;4271.572842715704;4291.828326866922;4354.412154359185;4486.416765820455;4582.6104781093645;4663.717477693627;4785.880352991168;5514.95215908976;5537.778488860441;5608.775648974036;3161.652218256013;3739.383001804726;3740.9812950935343;3830.176512049895;3837.76973381598;5645.8588535286535;5651.778486262831;5666.801661941812;5733.455321744427;5745.368009518991;3382.765290668888;3598.4062629665814;3761.755485893408;3788.431735239681;3790.8294126764363;3282;3837.021559502309;3837.9424308634834;3891.9805400972814;3922.5489068756888;4152.979235103805;4545.3863728396245;4564.908701825945;4591.586757191869;4616.884577885513;4711.269753188261;4762.761861906891;4847.587955023862;5528.917066244009;5544.445555444423;1050.033968748753;1320.6896379350844;1321.1808678619318;1324.205476713964;1326.263923522435;799.2646764976236;818.8198596308803;837.9400058925464;850.59596691571;900.5902314446911;4475.216837053503;4845.9757701211265;5188.6250143711195;5224.268602395668;5276.683398996072;5616.623927137795;5642.548596112301;5649;5662.8301150965535;5675.858103547444;4253.829846806155;4527.3435351873795;4578.473475550354;5007.223880298559;5294.523492885659;2598.389378496052;2909.2145120817263;2917.876617502277;2922.430126125385;2923.63454568179;5473.781048758085;5720.513756330675;5734.942650573525;5743.926999055569;5795.623284486495;5033.697978121324;5147.6654017488745;5558.276934150426;5636.774529018875;5852.590318677737;5161.967606478795;5331.3739309510975;5675.517581005578;5676;5731.340895797037;5156.364762842112;5420.159875219348;5476.233327334096;5529.880239221806;5581.753152037072;4852.8301509447;5448.727563621882;5468.179773034077;5470.589705772003;5480.835574932758;5377.838664840061;5442.727863606883;5637.633553818989;5642.429631998095;5709.7430615623225;3314.784539004957;3611.4582812578324;3612.620674829105;3685.723570732152;3746.475493430867;4528.3660287559105;5265.60507961912;5521.5306698931045;5539;5631.50765047271;5363.812266570651;5396.541293989898;5428.430014848542;5459.2902922619805;5483.287172667688;4683.742394168354;4919.0407870464915;4920.753962301942;5264.866754913928;5464.672119672673;4634.050019745877;4659.858334708018;5307.283516725192;5331.5201631853315;5358.6248962572245;4092.4066010428915;5337.893242135213;5376.301080859464;5429.588307040119;5435.673859568438;4294.506131794884;5157.226416037624;5395.271638328775;5405.594580406564;5410.132629706262 15:52:12 INFO - PROCESS | 3041 | |5;yui.html;698.3226270517596;722.5881247688818;735.3418690272207;778.0041546820069;830.4933990265938;15048.247587620615;15713.214339283048;15751.606209844746;15756.290966906503;15772.132532710697;11801.645950621474;14041.50854720085;14130.64673383166;14148.929255353734;14150.292485375716;696.4915611603533;722.209180946865;735.5072101691879;863.3567991846083;886.3706768194589;881.6870011146048;885.1016218538189;895.5566994337812;900.0864122915247;901.6573701993234;953.4041224234853;953.7901661634429;956.5121787888193;959.6689142245914;960.04475546831;727.3853593713357;946.9952650236705;947.0813311088233;949.5632009275741;952.476138124029;559.3036669346649;683.3337495941418;704.2816327346078;707.9964600177018;713.0801266366382;12645.367731613382;12668.619941401772;12691.428885700165;12712.809307860298;12844.678883027906;13203.801942970864;13786.517471888536;13861.4455421783;13870.791938120836;14087.788683169761;11848.585299514476;12371.319577423239;12427.087991255545;12499.875001249962;13012.284324362156;4421.905285961451;4518.186726389248;4540.841070562515;4549.021960278523;4553.863384098482;106226.46886765595;109514;113322.86677133206;113395.43302283436;113742;10537.789244215073;10846.566137354575;11064.391458469701;11084.168687348481;11141.610043648434;22068.779312206672;22074.558508829734;22081.668774968388;22097;22157.778422215895;7556.842737989344;7696.499727517694;7779.961100194463;7872.84254314922;7935.603219838985;4160.1471698301775;4232.343986682069;4282.143571285756;4296.871093867127;4413.984783499813;3454.3954807908517;3514.1741690702665;3562.1450851795385;3566.8751593694615;3568.892933212008;584.3455330030308;586.6626689653381;591.9970400147972;606.1332294818452;606.9393060693984;502.9446760856303;515.8014164546677;552.6324993879025;597.3369559788631;626.7399029402837;7735.762278035488;8363.623636936352;8644.029682932214;8699.304055675531;8926.196642302224;563.0372063770998;580.4021857486796;609.7865746988518;613.7938949963343;628.8019273928697;4249.192653395845;4252.362145678173;4282.828686852553;4360.912781744348;4433.866983990485;105217;124860;143627.28186359;146281.2685936585;153997.23001385145;122362;125777.37111314385;126619.99999999815;126632;128918.89871683069;102470.97529024615;105076.94923050824;105837;105913.94086059349;108468.45765771279;8142.307903828241;8263.297619702393;8324.334053275845;8470.872936906075;8589;38087.80956095202;55888;59566.70216648889;59767.40232597618;62582.68708656428;89270;89951.55508671496;90604.54697726469;90675.5466222691;95629.5655565181;12686.429110689856;12751.234925904475;12903.935480322538;12995.28525931083;13087.934560327518;11856.644300670994;12100.636980890587;12359.073069519642;12493.500259989498;14590.635234118807;13214.471421143047;13649.590512284647;13746.587602371945;13834;14426.06230595008;13008.739825203633;13294.069415140848;13697.465968795805;13740.244286564335;14220.146791192561;13199.868001320248;13309.600711978655;13409.463621455032;13425.462981480632;13451.730965380442;11143.387113708824;11382.772344552897;11411.771764564495;11460.885391146316;11486.36824974601;9650.517474126125;9679.419234845931;10330.741731456774;11186.57175150178;11369.204155709353 15:52:12 INFO - PROCESS | 3041 | __end_tp_report 15:52:12 INFO - PROCESS | 3041 | __start_cc_report 15:52:12 INFO - PROCESS | 3041 | _x_x_mozilla_cycle_collect,1810 15:52:12 INFO - PROCESS | 3041 | __end_cc_report 15:52:12 INFO - PROCESS | 3041 | __startTimestamp1476831132893__endTimestamp 15:52:12 INFO - PROCESS | 3041 | 15:52:12 INFO - PROCESS | 3041 | ------- Summary: start ------- 15:52:12 INFO - PROCESS | 3041 | Number of tests: 6 15:52:12 INFO - PROCESS | 3041 | 15:52:12 INFO - PROCESS | 3041 | [#0] dojo.html Cycles:165 Average:5678.50 Median:5870.59 stddev:655.02 (11.2%) stddev-sans-first:621.40 15:52:12 INFO - PROCESS | 3041 | Values: 2962.2 3138.5 3260.6 3277.8 3287.6 5520.3 5601.0 5622.9 5674.2 5709.9 5614.5 5656.3 5734.6 5742.4 5801.3 4294.0 5157.5 5228.0 5236.4 5236.9 5151.1 5223.9 5236.9 5244.9 5253.9 5079.4 5200.9 5216.5 5231.8 5232.5 5086.7 5146.0 5208.2 5209.0 5215.2 5061.0 5118.0 5149.4 5149.8 5153.7 5631.5 5634.5 5637.9 5645.3 5658.4 5001.3 6083.9 6133.1 6133.6 6171.9 6168.2 6176.1 6207.0 6235.4 6261.9 5633.1 5774.9 5784.2 5789.1 5841.8 6163.5 6167.1 6194.5 6205.1 6262.8 6103.3 6106.6 6106.8 6112.2 6125.0 6164.3 6189.8 6191.5 6203.6 6225.9 6012.6 6059.9 6080.5 6096.8 6100.8 6143.8 6156.4 6174.4 6176.9 6179.7 4852.2 4868.0 4899.9 4917.3 4927.0 3815.8 4371.0 4434.0 4452.9 4458.5 5676.1 5687.6 5691.5 5701.9 5702.7 6147.9 6154.0 6155.0 6157.1 6171.4 5701.6 5746.2 5758.5 5769.0 5826.2 5383.0 5387.2 5397.4 5399.2 5438.9 6262.8 6271.7 6278.9 6281.5 6295.4 6105.0 6108.9 6137.2 6142.6 6217.1 6236.4 6244.4 6254.2 6262.8 6266.8 6106.6 6111.1 6114.3 6124.3 6146.9 6097.3 6177.4 6189.5 6197.9 6207.4 5955.7 5956.4 5972.5 5975.4 6038.2 6014.3 6020.3 6021.0 6026.4 6050.6 5829.8 5831.5 5840.7 5861.4 5894.7 5839.2 5915.6 5918.0 6005.9 6030.0 5845.1 5870.6 5888.8 5892.3 5938.8 15:52:12 INFO - PROCESS | 3041 | 15:52:12 INFO - PROCESS | 3041 | [#1] ext.html Cycles:180 Average:66957.25 Median:38982.71 stddev:147141.06 (377.5%) stddev-sans-first:147469.06 15:52:12 INFO - PROCESS | 3041 | Values: 434.5 506.5 506.5 520.7 542.1 24008.9 30663.5 31270.8 31329.5 31343.9 31139.8 40257.0 41480.4 41516.8 42503.1 9388.1 9502.5 9520.0 9524.9 9528.5 9397.7 9485.1 9492.3 9499.8 9501.9 9407.8 9442.9 9477.5 9483.3 9486.4 9417.3 9470.0 9470.3 9484.6 9485.3 9321.0 9386.7 9410.1 9414.4 9416.4 38679.8 38978.6 38982.6 38982.8 39010.0 3362.6 3370.6 3377.6 3544.1 3558.9 29546.9 29793.7 30173.4 30327.0 30358.2 3146.2 3152.6 3169.8 3175.3 3266.9 466380.7 469712.0 471900.0 471904.0 481566.0 55415.2 55664.7 55701.2 55740.4 55762.7 33604.8 34221.8 58902.4 59010.0 59142.0 15501.3 15936.3 15938.5 15942.2 15972.9 12188.0 12290.4 12305.6 12311.7 12343.1 18375.8 18441.2 18449.4 18545.4 18551.9 6580.8 8012.0 8058.0 8095.2 8101.7 811.5 907.6 945.2 994.1 1025.0 24030.6 24070.9 29346.7 30294.8 30452.0 884.9 1016.2 1036.9 1183.0 1199.2 12778.9 15196.3 15236.4 15385.9 15628.4 646717.0 650676.0 653204.0 653772.0 654722.0 55858.7 56220.7 56347.9 56400.0 56516.4 1270.8 1307.8 1379.6 1394.5 1408.3 28735.6 30602.0 30769.1 30819.7 31215.8 47121.5 47555.0 47638.5 47693.8 47817.8 508438.0 509644.0 510913.0 511177.0 511683.0 25807.9 26974.0 27149.3 27211.9 27487.5 45914.5 46023.8 46098.3 46615.8 46645.0 37517.0 38197.2 39314.4 39769.8 41312.6 37377.0 37772.5 37845.4 39017.8 39329.0 34401.2 35096.3 37590.0 38302.2 38433.2 30138.7 31534.7 34205.7 34503.8 34530.8 22306.8 22692.3 24054.5 24960.5 25764.5 15:52:12 INFO - PROCESS | 3041 | 15:52:12 INFO - PROCESS | 3041 | [#2] jquery.html Cycles:180 Average:33147.56 Median:1826.40 stddev:94277.10 (5161.9%) stddev-sans-first:94509.41 15:52:12 INFO - PROCESS | 3041 | Values: 350.2 370.7 371.6 379.4 399.3 14959.8 15123.8 15729.3 20691.0 20793.1 16989.0 18139.5 19886.2 20460.9 20949.7 5761.2 6046.7 6047.9 6052.5 6058.2 5513.2 5881.8 5922.3 5925.7 5928.3 5612.4 5859.0 5896.0 5896.2 5897.9 5826.9 5908.6 5975.6 5981.7 5985.6 5110.0 5175.5 5177.1 5182.7 5383.3 12731.7 13044.2 13055.2 13064.5 20172.6 2113.9 2132.2 2261.0 2481.3 2517.2 9704.4 9744.4 9820.0 10086.5 10240.3 1806.3 1839.7 1851.6 1894.5 1977.7 114767.0 117842.0 120367.0 120506.4 122525.0 9306.2 9360.7 9944.0 10013.5 11199.6 12224.9 12324.0 12328.8 12332.1 12342.1 7938.6 8069.4 8105.2 8233.0 8249.4 8036.0 8264.0 8296.0 8421.9 8668.3 3302.6 3806.6 3852.2 3875.3 3886.4 1712.6 1795.7 1924.5 1931.8 1965.4 790.4 837.7 846.4 935.9 943.8 19493.7 20499.5 20747.5 20852.6 21140.5 888.5 922.5 934.2 941.9 996.6 8059.7 9833.8 11030.0 11222.6 11238.9 499797.0 571556.0 577718.0 577740.0 584560.0 95791.6 102351.5 127803.0 133650.0 134096.0 965.7 1012.7 1044.9 1045.7 1046.5 14614.5 18583.7 18876.6 19375.7 19530.2 56056.2 56420.9 56891.5 57269.4 57269.7 56824.6 77222.0 77443.6 78880.6 80989.6 5257.2 5385.7 7660.0 8037.0 8151.6 12349.7 12481.8 12687.9 12838.2 13187.5 11093.6 11099.6 11163.9 11356.3 11453.1 10054.1 10378.8 10542.3 10602.2 10973.9 10186.3 10193.5 11251.3 11587.2 11627.6 6789.3 7270.7 7384.6 8041.0 8336.8 11167.7 11440.6 11620.3 11714.6 11754.3 15:52:12 INFO - PROCESS | 3041 | 15:52:12 INFO - PROCESS | 3041 | [#3] mootools.html Cycles:180 Average:5601.30 Median:4926.69 stddev:3142.30 (63.8%) stddev-sans-first:3136.31 15:52:12 INFO - PROCESS | 3041 | Values: 1542.5 1575.8 1795.4 1912.3 1951.6 8279.0 8781.8 8794.6 8814.6 8825.7 7742.3 7984.1 7992.2 8328.3 8548.4 2324.2 2366.0 2370.4 2371.9 2374.6 2019.8 2306.9 2341.4 2353.4 2354.9 2328.2 2340.1 2344.9 2347.4 2351.0 2326.6 2331.7 2332.6 2333.2 2335.9 2295.7 2302.6 2341.0 2346.1 2355.0 8688.4 8722.2 8737.0 8740.7 8753.5 5142.7 5324.5 5324.7 5334.8 5338.4 2988.7 3460.2 3542.3 3612.1 3616.7 1025.5 1070.0 1087.5 1090.1 1098.3 11584.1 11610.7 11613.5 11627.5 11628.7 4495.4 4692.3 4722.6 4750.7 4752.6 9856.3 9881.5 9883.6 9886.3 9895.5 5356.5 5358.5 5358.5 5362.0 5365.9 4723.3 4828.0 4834.0 4904.9 4922.2 3810.5 3833.8 3847.0 3940.0 3948.9 1093.6 1276.6 1278.1 1289.4 1291.7 859.7 869.8 884.5 887.7 920.9 5533.6 5660.7 5757.3 5817.7 6004.0 434.4 439.3 441.6 450.4 450.7 3827.8 3828.2 3920.3 3944.8 3969.5 7982.0 10598.8 10608.8 10628.5 10632.5 10592.3 10593.1 10596.2 10600.7 10608.6 7802.2 7981.3 7995.6 8115.8 8123.7 5657.0 5695.7 5698.3 5702.2 5776.7 9371.5 9686.0 9836.6 9898.6 9978.5 9147.2 9725.4 9819.9 10076.0 10090.9 6838.2 7083.4 7190.7 7397.5 7411.7 8151.7 8164.3 8192.4 8258.5 8265.8 6064.5 7342.3 7381.3 7402.0 7413.7 7200.2 7216.9 7269.5 7332.5 7349.7 6777.0 6907.7 6924.3 6924.8 6935.2 4738.6 4864.9 4878.9 4931.2 5020.5 4766.6 4889.5 4933.5 4986.2 5038.8 15:52:12 INFO - PROCESS | 3041 | 15:52:12 INFO - PROCESS | 3041 | [#4] prototype.html Cycles:180 Average:4393.29 Median:4885.94 stddev:1354.53 (27.7%) stddev-sans-first:1322.98 15:52:12 INFO - PROCESS | 3041 | Values: 297.1 297.9 306.1 311.2 313.4 5258.9 5312.8 5314.3 5339.0 5348.3 4460.3 4781.6 4991.8 5119.9 5256.3 3634.5 4010.6 4025.6 4040.5 4045.5 3245.9 3317.4 3931.2 4034.3 4057.0 3475.6 3771.6 3881.4 3963.2 3989.8 3961.6 3964.7 4000.8 4014.7 4018.7 3073.9 3247.7 3451.2 3454.3 3457.4 4035.3 4430.7 5180.8 5187.8 5190.8 4271.6 4291.8 4354.4 4486.4 4582.6 4663.7 4785.9 5515.0 5537.8 5608.8 3161.7 3739.4 3741.0 3830.2 3837.8 5645.9 5651.8 5666.8 5733.5 5745.4 3382.8 3598.4 3761.8 3788.4 3790.8 3282.0 3837.0 3837.9 3892.0 3922.5 4153.0 4545.4 4564.9 4591.6 4616.9 4711.3 4762.8 4847.6 5528.9 5544.4 1050.0 1320.7 1321.2 1324.2 1326.3 799.3 818.8 837.9 850.6 900.6 4475.2 4846.0 5188.6 5224.3 5276.7 5616.6 5642.5 5649.0 5662.8 5675.9 4253.8 4527.3 4578.5 5007.2 5294.5 2598.4 2909.2 2917.9 2922.4 2923.6 5473.8 5720.5 5734.9 5743.9 5795.6 5033.7 5147.7 5558.3 5636.8 5852.6 5162.0 5331.4 5675.5 5676.0 5731.3 5156.4 5420.2 5476.2 5529.9 5581.8 4852.8 5448.7 5468.2 5470.6 5480.8 5377.8 5442.7 5637.6 5642.4 5709.7 3314.8 3611.5 3612.6 3685.7 3746.5 4528.4 5265.6 5521.5 5539.0 5631.5 5363.8 5396.5 5428.4 5459.3 5483.3 4683.7 4919.0 4920.8 5264.9 5464.7 4634.1 4659.9 5307.3 5331.5 5358.6 4092.4 5337.9 5376.3 5429.6 5435.7 4294.5 5157.2 5395.3 5405.6 5410.1 15:52:12 INFO - PROCESS | 3041 | 15:52:12 INFO - PROCESS | 3041 | [#5] yui.html Cycles:180 Average:23925.73 Median:3564.51 stddev:37997.60 (1066.0%) stddev-sans-first:38064.17 15:52:12 INFO - PROCESS | 3041 | Values: 698.3 722.6 735.3 778.0 830.5 15048.2 15713.2 15751.6 15756.3 15772.1 11801.6 14041.5 14130.6 14148.9 14150.3 696.5 722.2 735.5 863.4 886.4 881.7 885.1 895.6 900.1 901.7 953.4 953.8 956.5 959.7 960.0 727.4 947.0 947.1 949.6 952.5 559.3 683.3 704.3 708.0 713.1 12645.4 12668.6 12691.4 12712.8 12844.7 13203.8 13786.5 13861.4 13870.8 14087.8 11848.6 12371.3 12427.1 12499.9 13012.3 4421.9 4518.2 4540.8 4549.0 4553.9 106226.5 109514.0 113322.9 113395.4 113742.0 10537.8 10846.6 11064.4 11084.2 11141.6 22068.8 22074.6 22081.7 22097.0 22157.8 7556.8 7696.5 7780.0 7872.8 7935.6 4160.1 4232.3 4282.1 4296.9 4414.0 3454.4 3514.2 3562.1 3566.9 3568.9 584.3 586.7 592.0 606.1 606.9 502.9 515.8 552.6 597.3 626.7 7735.8 8363.6 8644.0 8699.3 8926.2 563.0 580.4 609.8 613.8 628.8 4249.2 4252.4 4282.8 4360.9 4433.9 105217.0 124860.0 143627.3 146281.3 153997.2 122362.0 125777.4 126620.0 126632.0 128918.9 102471.0 105076.9 105837.0 105913.9 108468.5 8142.3 8263.3 8324.3 8470.9 8589.0 38087.8 55888.0 59566.7 59767.4 62582.7 89270.0 89951.6 90604.5 90675.5 95629.6 12686.4 12751.2 12903.9 12995.3 13087.9 11856.6 12100.6 12359.1 12493.5 14590.6 13214.5 13649.6 13746.6 13834.0 14426.1 13008.7 13294.1 13697.5 13740.2 14220.1 13199.9 13309.6 13409.5 13425.5 13451.7 11143.4 11382.8 11411.8 11460.9 11486.4 9650.5 9679.4 10330.7 11186.6 11369.2 15:52:12 INFO - PROCESS | 3041 | -------- Summary: end -------- 15:52:12 INFO - PROCESS | 3041 | 15:52:13 INFO - TEST-INFO | 3041: exit 0 15:52:13 INFO - TEST-OK | dromaeo_css | took 1119407ms 15:52:13 INFO - TEST-START | kraken 15:52:13 INFO - operating with platform_type : mac_ 15:52:13 INFO - Initialising browser for kraken test... 15:52:13 INFO - TEST-INFO | started process 3043 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmpCxPdaP/profile http://localhost:55747/getInfo.html) 15:52:15 INFO - PROCESS | 3043 | __metrics Screen width/height:1600/1200 15:52:15 INFO - PROCESS | 3043 | colorDepth:24 15:52:15 INFO - PROCESS | 3043 | Browser inner width/height: 1024/689 15:52:15 INFO - PROCESS | 3043 | __metrics 15:52:16 INFO - PROCESS | 3043 | 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" 15:52:16 INFO - PROCESS | 3043 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:52:16 INFO - TEST-INFO | 3043: exit 0 15:52:16 INFO - Browser initialized. 15:52:16 INFO - Running cycle 1/1 for kraken test... 15:52:16 INFO - TEST-INFO | started process 3044 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmpCxPdaP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:52:28 INFO - PROCESS | 3044 | RSS: Main: 231657472 15:52:28 INFO - PROCESS | 3044 | 15:52:31 INFO - PROCESS | 3044 | Cycle 1(1): loaded http://localhost:55747/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55747/tests/kraken/driver.html?testName=audio-beat-detection) 15:52:32 INFO - PROCESS | 3044 | RSS: Main: 290504704 15:52:32 INFO - PROCESS | 3044 | 15:52:34 INFO - PROCESS | 3044 | Cycle 1(1): loaded http://localhost:55747/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55747/tests/kraken/driver.html?testName=audio-dft) 15:52:35 INFO - PROCESS | 3044 | RSS: Main: 291782656 15:52:35 INFO - PROCESS | 3044 | 15:52:38 INFO - PROCESS | 3044 | Cycle 1(1): loaded http://localhost:55747/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55747/tests/kraken/driver.html?testName=audio-fft) 15:52:39 INFO - PROCESS | 3044 | RSS: Main: 383221760 15:52:39 INFO - PROCESS | 3044 | 15:52:41 INFO - PROCESS | 3044 | Cycle 1(1): loaded http://localhost:55747/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55747/tests/kraken/driver.html?testName=audio-oscillator) 15:52:42 INFO - PROCESS | 3044 | RSS: Main: 288010240 15:52:42 INFO - PROCESS | 3044 | 15:52:44 INFO - PROCESS | 3044 | Cycle 1(1): loaded http://localhost:55747/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55747/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:52:44 INFO - PROCESS | 3044 | RSS: Main: 289251328 15:52:44 INFO - PROCESS | 3044 | 15:52:47 INFO - PROCESS | 3044 | Cycle 1(1): loaded http://localhost:55747/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55747/tests/kraken/driver.html?testName=imaging-darkroom) 15:52:48 INFO - PROCESS | 3044 | RSS: Main: 326537216 15:52:48 INFO - PROCESS | 3044 | 15:52:51 INFO - PROCESS | 3044 | Cycle 1(1): loaded http://localhost:55747/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55747/tests/kraken/driver.html?testName=imaging-desaturate) 15:52:51 INFO - PROCESS | 3044 | RSS: Main: 326877184 15:52:51 INFO - PROCESS | 3044 | 15:52:54 INFO - PROCESS | 3044 | Cycle 1(1): loaded http://localhost:55747/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55747/tests/kraken/driver.html?testName=json-parse-financial) 15:52:55 INFO - PROCESS | 3044 | RSS: Main: 329039872 15:52:55 INFO - PROCESS | 3044 | 15:52:56 INFO - PROCESS | 3044 | Cycle 1(1): loaded http://localhost:55747/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55747/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:52:57 INFO - PROCESS | 3044 | RSS: Main: 302972928 15:52:57 INFO - PROCESS | 3044 | 15:52:59 INFO - PROCESS | 3044 | Cycle 1(1): loaded http://localhost:55747/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55747/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:53:00 INFO - PROCESS | 3044 | RSS: Main: 306294784 15:53:00 INFO - PROCESS | 3044 | 15:53:02 INFO - PROCESS | 3044 | Cycle 1(1): loaded http://localhost:55747/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55747/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:53:02 INFO - PROCESS | 3044 | RSS: Main: 314163200 15:53:02 INFO - PROCESS | 3044 | 15:53:05 INFO - PROCESS | 3044 | Cycle 1(1): loaded http://localhost:55747/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55747/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:53:06 INFO - PROCESS | 3044 | RSS: Main: 319590400 15:53:06 INFO - PROCESS | 3044 | 15:53:09 INFO - PROCESS | 3044 | Cycle 1(1): loaded http://localhost:55747/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55747/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:53:10 INFO - PROCESS | 3044 | RSS: Main: 319188992 15:53:10 INFO - PROCESS | 3044 | 15:53:11 INFO - PROCESS | 3044 | Cycle 1(1): loaded http://localhost:55747/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55747/tests/kraken/driver.html?testName=ai-astar) 15:53:12 INFO - PROCESS | 3044 | RSS: Main: 363302912 15:53:12 INFO - PROCESS | 3044 | 15:53:12 INFO - PROCESS | 3044 | __start_tp_report 15:53:12 INFO - PROCESS | 3044 | _x_x_mozilla_page_load 15:53:12 INFO - PROCESS | 3044 | _x_x_mozilla_page_load_details 15:53:12 INFO - PROCESS | 3044 | |i|pagename|runs| 15:53:12 INFO - PROCESS | 3044 | |0;ai-astar;104;112;114;112;113;114;112;113;113;112 15:53:12 INFO - PROCESS | 3044 | |1;audio-beat-detection;153;115;112;150;115;112;116;112;145;110 15:53:12 INFO - PROCESS | 3044 | |2;audio-dft;182;184;186;181;184;185;185;187;182;185 15:53:12 INFO - PROCESS | 3044 | |3;audio-fft;80;59;59;93;78;85;84;66;85;59 15:53:12 INFO - PROCESS | 3044 | |4;audio-oscillator;86;70;95;69;70;69;93;67;68;91 15:53:12 INFO - PROCESS | 3044 | |5;imaging-gaussian-blur;87;86;134;122;87;83;87;86;87;84 15:53:12 INFO - PROCESS | 3044 | |6;imaging-darkroom;107;150;151;94;97;94;92;94;94;93 15:53:12 INFO - PROCESS | 3044 | |7;imaging-desaturate;83;83;82;81;91;119;82;85;83;81 15:53:12 INFO - PROCESS | 3044 | |8;json-parse-financial;57;56;53;52;59;54;55;54;54;54 15:53:12 INFO - PROCESS | 3044 | |9;json-stringify-tinderbox;65;73;68;78;75;71;70;72;71;75 15:53:12 INFO - PROCESS | 3044 | |10;stanford-crypto-aes;91;90;90;86;86;84;86;88;86;92 15:53:12 INFO - PROCESS | 3044 | |11;stanford-crypto-ccm;148;141;149;161;130;123;148;164;213;144 15:53:12 INFO - PROCESS | 3044 | |12;stanford-crypto-pbkdf2;177;178;172;168;173;174;168;183;232;172 15:53:12 INFO - PROCESS | 3044 | |13;stanford-crypto-sha256-iterative;67;70;68;69;69;69;69;67;67;68 15:53:12 INFO - PROCESS | 3044 | __end_tp_report 15:53:12 INFO - PROCESS | 3044 | __start_cc_report 15:53:12 INFO - PROCESS | 3044 | _x_x_mozilla_cycle_collect,1962 15:53:12 INFO - PROCESS | 3044 | __end_cc_report 15:53:12 INFO - PROCESS | 3044 | __startTimestamp1476831192246__endTimestamp 15:53:12 INFO - PROCESS | 3044 | 15:53:12 INFO - PROCESS | 3044 | ------- Summary: start ------- 15:53:12 INFO - PROCESS | 3044 | Number of tests: 14 15:53:12 INFO - PROCESS | 3044 | 15:53:12 INFO - PROCESS | 3044 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:2.88 (2.6%) stddev-sans-first:0.83 15:53:12 INFO - PROCESS | 3044 | Values: 104.0 112.0 114.0 112.0 113.0 114.0 112.0 113.0 113.0 112.0 15:53:12 INFO - PROCESS | 3044 | 15:53:12 INFO - PROCESS | 3044 | [#1] audio-beat-detection Cycles:10 Average:124.00 Median:115.50 stddev:17.68 (15.3%) stddev-sans-first:15.32 15:53:12 INFO - PROCESS | 3044 | Values: 153.0 115.0 112.0 150.0 115.0 112.0 116.0 112.0 145.0 110.0 15:53:12 INFO - PROCESS | 3044 | 15:53:12 INFO - PROCESS | 3044 | [#2] audio-dft Cycles:10 Average:184.10 Median:185.00 stddev:1.91 (1.0%) stddev-sans-first:1.87 15:53:12 INFO - PROCESS | 3044 | Values: 182.0 184.0 186.0 181.0 184.0 185.0 185.0 187.0 182.0 185.0 15:53:12 INFO - PROCESS | 3044 | 15:53:12 INFO - PROCESS | 3044 | [#3] audio-fft Cycles:10 Average:74.80 Median:82.00 stddev:12.86 (15.7%) stddev-sans-first:13.50 15:53:12 INFO - PROCESS | 3044 | Values: 80.0 59.0 59.0 93.0 78.0 85.0 84.0 66.0 85.0 59.0 15:53:12 INFO - PROCESS | 3044 | 15:53:12 INFO - PROCESS | 3044 | [#4] audio-oscillator Cycles:10 Average:77.80 Median:78.00 stddev:11.82 (15.2%) stddev-sans-first:12.16 15:53:12 INFO - PROCESS | 3044 | Values: 86.0 70.0 95.0 69.0 70.0 69.0 93.0 67.0 68.0 91.0 15:53:12 INFO - PROCESS | 3044 | 15:53:12 INFO - PROCESS | 3044 | [#5] imaging-gaussian-blur Cycles:10 Average:94.30 Median:86.50 stddev:18.04 (20.9%) stddev-sans-first:18.94 15:53:12 INFO - PROCESS | 3044 | Values: 87.0 86.0 134.0 122.0 87.0 83.0 87.0 86.0 87.0 84.0 15:53:12 INFO - PROCESS | 3044 | 15:53:12 INFO - PROCESS | 3044 | [#6] imaging-darkroom Cycles:10 Average:106.60 Median:94.00 stddev:23.52 (25.0%) stddev-sans-first:24.95 15:53:12 INFO - PROCESS | 3044 | Values: 107.0 150.0 151.0 94.0 97.0 94.0 92.0 94.0 94.0 93.0 15:53:12 INFO - PROCESS | 3044 | 15:53:12 INFO - PROCESS | 3044 | [#7] imaging-desaturate Cycles:10 Average:87.00 Median:83.00 stddev:11.61 (14.0%) stddev-sans-first:12.23 15:53:12 INFO - PROCESS | 3044 | Values: 83.0 83.0 82.0 81.0 91.0 119.0 82.0 85.0 83.0 81.0 15:53:12 INFO - PROCESS | 3044 | 15:53:12 INFO - PROCESS | 3044 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:54.50 stddev:2.04 (3.8%) stddev-sans-first:2.01 15:53:12 INFO - PROCESS | 3044 | Values: 57.0 56.0 53.0 52.0 59.0 54.0 55.0 54.0 54.0 54.0 15:53:12 INFO - PROCESS | 3044 | 15:53:12 INFO - PROCESS | 3044 | [#9] json-stringify-tinderbox Cycles:10 Average:71.80 Median:72.50 stddev:3.74 (5.2%) stddev-sans-first:3.05 15:53:12 INFO - PROCESS | 3044 | Values: 65.0 73.0 68.0 78.0 75.0 71.0 70.0 72.0 71.0 75.0 15:53:12 INFO - PROCESS | 3044 | 15:53:12 INFO - PROCESS | 3044 | [#10] stanford-crypto-aes Cycles:10 Average:87.90 Median:89.00 stddev:2.69 (3.0%) stddev-sans-first:2.60 15:53:12 INFO - PROCESS | 3044 | Values: 91.0 90.0 90.0 86.0 86.0 84.0 86.0 88.0 86.0 92.0 15:53:12 INFO - PROCESS | 3044 | 15:53:12 INFO - PROCESS | 3044 | [#11] stanford-crypto-ccm Cycles:10 Average:152.10 Median:148.50 stddev:24.71 (16.6%) stddev-sans-first:26.17 15:53:12 INFO - PROCESS | 3044 | Values: 148.0 141.0 149.0 161.0 130.0 123.0 148.0 164.0 213.0 144.0 15:53:12 INFO - PROCESS | 3044 | 15:53:12 INFO - PROCESS | 3044 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.70 Median:175.50 stddev:18.93 (10.8%) stddev-sans-first:20.06 15:53:12 INFO - PROCESS | 3044 | Values: 177.0 178.0 172.0 168.0 173.0 174.0 168.0 183.0 232.0 172.0 15:53:12 INFO - PROCESS | 3044 | 15:53:12 INFO - PROCESS | 3044 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:69.00 stddev:1.06 (1.5%) stddev-sans-first:1.01 15:53:12 INFO - PROCESS | 3044 | Values: 67.0 70.0 68.0 69.0 69.0 69.0 69.0 67.0 67.0 68.0 15:53:12 INFO - PROCESS | 3044 | -------- Summary: end -------- 15:53:12 INFO - PROCESS | 3044 | 15:53:13 INFO - TEST-INFO | 3044: exit 0 15:53:13 INFO - TEST-OK | kraken | took 59612ms 15:53:13 INFO - SUITE-END | took 1179s 15:53:13 INFO - Completed test suite (00:19:39) 15:53:13 INFO - javascript benchmark 15:53:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2962.185399015269, 3138.497840345545, 3260.625028121766, 3277.7705560610766, 3287.621923478799, 5520.309961254843, 5601.0, 5622.91565626516, 5674.205611214428, 5709.942900570993, 5614.522765564921, 5656.349519805213, 5734.569907256962, 5742.39704830993, 5801.303843538782, 4293.978530107345, 5157.458466860982, 5228.032813929416, 5236.371635403757, 5236.895262094756, 5151.098557752397, 5223.921641175385, 5236.8690782730355, 5244.895102097956, 5253.921191182136, 5079.3650793650795, 5200.92198617021, 5216.478352164791, 5231.816886408977, 5232.502912223333, 5086.720230387327, 5146.022255771391, 5208.192730126818, 5208.973955130238, 5215.16557350822, 5060.962502686941, 5117.974410127926, 5149.433562308143, 5149.76826042829, 5153.66501177426, 5631.549476041907, 5634.464725851038, 5637.915431268493, 5645.322561292671, 5658.405867383906, 5001.349824522825, 6083.943773510214, 6133.095051491853, 6133.570650054498, 6171.907421388682, 6168.228971378578, 6176.104464852616, 6206.968965155145, 6235.438810507031, 6261.906071408933, 5633.126865335879, 5774.878628653641, 5784.248047753765, 5789.102689083199, 5841.766329346821, 6163.506919446433, 6167.136600875881, 6194.473469755031, 6205.131281620576, 6262.780802671885, 6103.298120716086, 6106.604636367212, 6106.832124512725, 6112.224947389871, 6125.018737820453, 6164.321924588292, 6189.81430557075, 6191.504679625619, 6203.565750397519, 6225.937740622536, 6012.609180403259, 6059.878802424015, 6080.543959203077, 6096.786612468542, 6100.762843515373, 6143.846403839851, 6156.415140561639, 6174.44430001293, 6176.8764624707255, 6179.721912513947, 4852.199387101089, 4868.0, 4899.853004409873, 4917.283066889312, 4926.989967056745, 3815.8361699681864, 4370.972821386971, 4434.0, 4452.866414007585, 4458.509563947963, 5676.120201368794, 5687.630304030225, 5691.459311365414, 5701.914471282934, 5702.686352250583, 6147.938520614826, 6154.0, 6154.969225153845, 6157.107219453154, 6171.352008039091, 5701.629394089371, 5746.195532625436, 5758.510526605201, 5769.0, 5826.184334193216, 5383.0, 5387.24578559002, 5397.4062853086125, 5399.217113518596, 5438.91841622376, 6262.81211563663, 6271.655058971709, 6278.874422511432, 6281.497480201664, 6295.370462953668, 6104.974570883654, 6108.8778224436155, 6137.162486020116, 6142.590862071594, 6217.129601855653, 6236.407541283571, 6244.438000579969, 6254.21822272216, 6262.780802671885, 6266.811995640138, 6106.57253992234, 6111.083337499233, 6114.266288045463, 6124.265088189446, 6146.938530614637, 6097.298810636834, 6177.413145751147, 6189.473894718999, 6197.938020619736, 6207.379262073937, 5955.731992060281, 5956.37458066914, 5972.492338151305, 5975.40245975399, 6038.245219347582, 6014.278286605635, 6020.277566692025, 6020.969895150496, 6026.367231440811, 6050.576459647782, 5829.7959571416495, 5831.475167234969, 5840.678762668094, 5861.35525092248, 5894.6757928314355, 5839.182514448065, 5915.556333274935, 5918.0, 6005.90991135142, 6029.9698501508965, 5845.064789633639, 5870.589058765845, 5888.793892213752, 5892.292924849045, 5938.762449501972], "value": 5634.06002756384, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [434.48079544943795, 506.50362644608305, 506.5441103007291, 520.7396301849076, 542.0595267211389, 24008.87995560022, 30663.540046899314, 31270.84364578174, 31329.530057049105, 31343.902963396256, 31139.844300778463, 40257.0, 41480.37779433311, 41516.75449736505, 42503.14993700124, 9388.061193880609, 9502.47736374499, 9520.0, 9524.904750952506, 9528.523573821316, 9397.718068457923, 9485.051494850495, 9492.288078394147, 9499.81000379992, 9501.904980950205, 9407.81184376312, 9442.858357124649, 9477.526123693822, 9483.33616646835, 9486.383385079947, 9417.340786144972, 9470.0, 9470.337076404654, 9484.573194206243, 9485.33602647815, 9321.0, 9386.700258436658, 9410.106039926197, 9414.388064775767, 9416.387934784285, 38679.80660096682, 38978.610213898064, 38982.61017389818, 38982.80508597439, 39010.02474938149, 3362.6469220731715, 3370.612379576331, 3377.594688637379, 3544.149404143013, 3558.867986650517, 29546.852265738748, 29793.702062979308, 30173.396532069237, 30327.0, 30358.241043973856, 3146.181992681896, 3152.574402455662, 3169.762267829899, 3175.333180032196, 3266.8856590019236, 466380.6680966573, 469712.0, 471900.0, 471904.0, 481566.0, 55415.168772468445, 55664.72167639136, 55701.1644825328, 55740.442595574335, 55762.72118639381, 33604.83197583997, 34221.82889085539, 58902.410975889696, 59010.0, 59142.0, 15501.302441390164, 15936.282867271, 15938.521844344688, 15942.20288985546, 15972.920135399481, 12187.964023057963, 12290.385480725929, 12305.56930507428, 12311.69220769488, 12343.07426942965, 18375.816241837678, 18441.170147343135, 18449.354272600394, 18545.35091271799, 18551.886886786837, 6580.795433529725, 8011.959940200261, 8058.0, 8095.190480951976, 8101.675932962733, 811.5009269299338, 907.5636934760736, 945.2485274207022, 994.0953732103895, 1024.9743756406, 24030.639540406908, 24070.87964560166, 29346.706532934826, 30294.84852575723, 30452.0, 884.9380543362032, 1016.1515134862325, 1036.8600238967642, 1182.9885447942058, 1199.1605875886914, 12778.9361053196, 15196.316165772567, 15236.390544378322, 15385.922985390915, 15628.374865005273, 646717.0, 650676.0, 653204.0, 653772.0, 654722.0, 55858.720706396205, 56220.718896405255, 56347.87304253892, 56400.0, 56516.43483565194, 1270.7776139175608, 1307.8103674967076, 1379.5792283353674, 1394.4910107810576, 1408.253625578445, 28735.568966465937, 30602.0, 30769.076927692204, 30819.662345673372, 31215.84392078025, 47121.52878471308, 47555.0, 47638.523614764796, 47693.761531192125, 47817.76091119522, 508438.0, 509644.0, 510913.0, 511177.0, 511683.0, 25807.870960645076, 26974.0, 27149.321266968484, 27211.86394068017, 27487.45025099527, 45914.540854591025, 46023.76988115038, 46098.308525371474, 46615.766921165174, 46645.0, 37517.0, 38197.23605527818, 39314.410283845194, 39769.80115099406, 41312.554060607734, 37377.0, 37772.45698568364, 37845.43231851579, 39017.80491097526, 39329.016774580865, 34401.17844867414, 35096.29807403889, 37590.0, 38302.233955321295, 38433.2313353737, 30138.698613014465, 31534.684653153174, 34205.65794342025, 34503.82748086344, 34530.82734586311, 22306.77693223047, 22692.319230423112, 24054.518909621358, 24960.50078998446, 25764.484710306064], "value": 19231.22125977874, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.22250603659865, 370.71454979665657, 371.56341298973706, 379.4232766195382, 399.2693371130831, 14959.775603365959, 15123.773143402857, 15729.314531884467, 20690.96545172743, 20793.064312105955, 16989.0, 18139.45581632553, 19886.204551817948, 20460.87465189414, 20949.685754713653, 5761.193432919385, 6046.727897244635, 6047.879042419149, 6052.485538729214, 6058.1518587397795, 5513.228148059255, 5881.823545293648, 5922.318933322658, 5925.733341999598, 5928.318243402021, 5612.41069687683, 5858.970705146468, 5896.0, 5896.174535565025, 5897.911531327033, 5826.873191285193, 5908.615939963888, 5975.611585246988, 5981.730822113015, 5985.551083668743, 5109.974450127763, 5175.508326708957, 5177.145770947826, 5182.740862956837, 5383.273258110184, 12731.681707957283, 13044.152130111608, 13055.21668699881, 13064.477420903153, 20172.596548069105, 2113.9154433822628, 2132.157797669912, 2260.9524187625284, 2481.280428675682, 2517.2196619048154, 9704.417734935927, 9744.366616169926, 9820.017998200194, 10086.495675216283, 10240.334378265388, 1806.2594336322177, 1839.678056340135, 1851.583393736412, 1894.5453091258137, 1977.6539105656595, 114767.0, 117842.0, 120367.0, 120506.39746801298, 122525.0, 9306.2089722373, 9360.672376466791, 9944.038095805612, 10013.49932503372, 11199.552017919355, 12224.877751222373, 12324.0, 12328.75342493145, 12332.136750427384, 12342.074344424203, 7938.56337901421, 8069.435139540294, 8105.230003149692, 8232.958835205785, 8249.422540422232, 8036.0, 8264.049634292012, 8295.958520207481, 8421.90515233028, 8668.349873759493, 3302.570665813477, 3806.5812760596314, 3852.210296889131, 3875.3024455597697, 3886.4364667123673, 1712.571857035741, 1795.7037088880188, 1924.5477312831474, 1931.777845547752, 1965.4398496428448, 790.4190420041265, 837.7068026190906, 846.4202021615213, 935.9003171273727, 943.7829299261072, 19493.707594386095, 20499.487512812, 20747.481312966996, 20852.578329634405, 21140.47148821292, 888.4802390601441, 922.524899676667, 934.243262957007, 941.8634298026885, 996.6063404955147, 8059.677612895536, 9833.754156146153, 11030.0, 11222.551097956153, 11238.887611123784, 499797.0, 571556.0, 577718.0, 577740.0, 584560.0, 95791.56312655316, 102351.4882425583, 127803.0, 133650.0, 134096.0, 965.7247684409909, 1012.731626119079, 1044.8693913260843, 1045.696747943088, 1046.4506134279563, 14614.488492902698, 18583.72124418162, 18876.622467550846, 19375.709364359263, 19530.21879124819, 56056.15915761185, 56420.8715825673, 56891.466280058325, 57269.42730572807, 57269.71365143148, 56824.623937049924, 77222.0, 77443.61278193574, 78880.60559697165, 80989.59505202436, 5257.187404738599, 5385.676859388449, 7659.961700191463, 8036.981509245377, 8151.63317650719, 12349.691257718629, 12481.812772808233, 12687.873121268669, 12838.16551924122, 13187.53843615469, 11093.611723589636, 11099.60202802169, 11163.888361116286, 11356.318620882774, 11453.08375329955, 10054.095131438205, 10378.844317335397, 10542.314749541256, 10602.20483463728, 10973.945130274298, 10186.337888037255, 10193.490325483845, 11251.324920504796, 11587.188896777145, 11627.59303424376, 6789.253182149861, 7270.6728197232305, 7384.630768461663, 8041.0, 8336.7915802103, 11167.678770603545, 11440.599579014695, 11620.302781833117, 11714.589989350672, 11754.294742315147], "value": 9075.943428674593, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1542.4986879264238, 1575.787268718723, 1795.3716199330236, 1912.2733361322696, 1951.6291904538136, 8279.0, 8781.824363512726, 8794.604242809073, 8814.559272036397, 8825.691100811473, 7742.303192712655, 7984.081830589484, 7992.160823113562, 8328.250457458827, 8548.444351117174, 2324.1981516376823, 2365.95268094638, 2370.383700237933, 2371.8695471749047, 2374.631932050535, 2019.7881271237213, 2306.907723691059, 2341.4146463384154, 2353.399883029825, 2354.858708477488, 2328.2200462844967, 2340.0639744102323, 2344.8510229987355, 2347.3779448446176, 2350.9647355289685, 2326.569584626841, 2331.743508214095, 2332.5801355755957, 2333.195047708546, 2335.883205839701, 2295.690081838947, 2302.5970455170445, 2341.0167729553627, 2346.0967527501866, 2355.0, 8688.391812573122, 8722.215000649972, 8737.0, 8740.694075707383, 8753.47479151253, 5142.688614403341, 5324.54741346986, 5324.7071411072375, 5334.813281535166, 5338.439463856278, 2988.6712461629204, 3460.1522626956307, 3542.3446662367287, 3612.1150318171954, 3616.7468277220605, 1025.5487585462372, 1070.0, 1087.4888802262924, 1090.0625462102585, 1098.3245304137977, 11584.073274138049, 11610.709732256677, 11613.535458581646, 11627.476763545576, 11628.6511404658, 4495.393121928563, 4692.319613656001, 4722.645801564897, 4750.7387093709485, 4752.619790416758, 9856.260780441495, 9881.456519891475, 9883.555240014217, 9886.30795844284, 9895.455749933679, 5356.491133342326, 5358.46415358461, 5358.464153584689, 5362.0, 5365.892682146336, 4723.31511930775, 4827.975860120677, 4833.975830120827, 4904.877378065506, 4922.163232250526, 3810.466534685146, 3833.769973801581, 3846.9807650961566, 3940.0346915006007, 3948.9210215795524, 1093.6227001684406, 1276.6489215465822, 1278.1308710077237, 1289.4390939941156, 1291.6706239908951, 859.6905114158898, 869.8434281829332, 884.4958373726914, 887.7070566712969, 920.9217216536535, 5533.584981126432, 5660.745266463019, 5757.280339957505, 5817.731084876901, 6003.969980150071, 434.3506457845541, 439.26642507013366, 441.5827043443979, 450.4144612004381, 450.66425512992373, 3827.808609569566, 3828.1769419574925, 3920.333543297589, 3944.783036932939, 3969.503812023497, 7982.006747469699, 10598.788024239471, 10608.787824243473, 10628.521716522775, 10632.46837658114, 10592.258541901992, 10593.09958653523, 10596.152307815357, 10600.681979540626, 10608.628697995688, 7802.219778022152, 7981.281684648409, 7995.600219989094, 8115.837683246302, 8123.675052997932, 5657.0, 5695.658260504383, 5698.287714035746, 5702.2016917630735, 5776.740046697824, 9371.484568348533, 9686.049413526329, 9836.557354919189, 9898.604055837686, 9978.451185184884, 9147.22248608849, 9725.367851089657, 9819.85270220933, 10075.992400760158, 10090.899091009289, 6838.247792742894, 7083.362497375261, 7190.676419561028, 7397.519161254501, 7411.703531858665, 8151.673933042612, 8164.306033987177, 8192.426530142833, 8258.463199891989, 8265.83468330642, 6064.48451881595, 7342.302481264272, 7381.298776616213, 7401.963725078601, 7413.740519081806, 7200.207977122408, 7216.855662886608, 7269.454790890599, 7332.450066244946, 7349.70601175947, 6776.966115169393, 6907.6891539879825, 6924.3421874921805, 6924.757633482804, 6935.202451718117, 4738.644601654821, 4864.854054378375, 4878.853634390974, 4931.211006239128, 5020.523050310215, 4766.571008609242, 4889.511048895082, 4933.457319694902, 4986.202207646759, 5038.848834534823], "value": 4440.482878507511, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.0894209248653, 297.92105092150587, 306.09701380926265, 311.1691782939551, 313.42173689542784, 5258.894822103561, 5312.840614781563, 5314.335708036496, 5339.0, 5348.251244825728, 4460.330950357448, 4781.589431117829, 4991.825286114987, 5119.948800511994, 5256.26412302278, 3634.4548317752283, 4010.6363836295654, 4025.6376926076646, 4040.454538637283, 4045.474088368508, 3245.8701651933893, 3317.3579078356247, 3931.2334094851517, 4034.3055916514986, 4057.0, 3475.6176820549717, 3771.6039815819354, 3881.4371916072155, 3963.246983073207, 3989.840406383741, 3961.643452089297, 3964.7224694271413, 4000.8399664013405, 4014.698897582693, 4018.7387819791766, 3073.9394908756444, 3247.7401807855313, 3451.2234747181933, 3454.3091381723757, 3457.429524128516, 4035.334169861999, 4430.689851710382, 5180.808414064749, 5187.766550505198, 5190.792368305301, 4271.572842715704, 4291.828326866922, 4354.412154359185, 4486.416765820455, 4582.6104781093645, 4663.717477693627, 4785.880352991168, 5514.95215908976, 5537.778488860441, 5608.775648974036, 3161.652218256013, 3739.383001804726, 3740.9812950935343, 3830.176512049895, 3837.76973381598, 5645.8588535286535, 5651.778486262831, 5666.801661941812, 5733.455321744427, 5745.368009518991, 3382.765290668888, 3598.4062629665814, 3761.755485893408, 3788.431735239681, 3790.8294126764363, 3282.0, 3837.021559502309, 3837.9424308634834, 3891.9805400972814, 3922.5489068756888, 4152.979235103805, 4545.3863728396245, 4564.908701825945, 4591.586757191869, 4616.884577885513, 4711.269753188261, 4762.761861906891, 4847.587955023862, 5528.917066244009, 5544.445555444423, 1050.033968748753, 1320.6896379350844, 1321.1808678619318, 1324.205476713964, 1326.263923522435, 799.2646764976236, 818.8198596308803, 837.9400058925464, 850.59596691571, 900.5902314446911, 4475.216837053503, 4845.9757701211265, 5188.6250143711195, 5224.268602395668, 5276.683398996072, 5616.623927137795, 5642.548596112301, 5649.0, 5662.8301150965535, 5675.858103547444, 4253.829846806155, 4527.3435351873795, 4578.473475550354, 5007.223880298559, 5294.523492885659, 2598.389378496052, 2909.2145120817263, 2917.876617502277, 2922.430126125385, 2923.63454568179, 5473.781048758085, 5720.513756330675, 5734.942650573525, 5743.926999055569, 5795.623284486495, 5033.697978121324, 5147.6654017488745, 5558.276934150426, 5636.774529018875, 5852.590318677737, 5161.967606478795, 5331.3739309510975, 5675.517581005578, 5676.0, 5731.340895797037, 5156.364762842112, 5420.159875219348, 5476.233327334096, 5529.880239221806, 5581.753152037072, 4852.8301509447, 5448.727563621882, 5468.179773034077, 5470.589705772003, 5480.835574932758, 5377.838664840061, 5442.727863606883, 5637.633553818989, 5642.429631998095, 5709.7430615623225, 3314.784539004957, 3611.4582812578324, 3612.620674829105, 3685.723570732152, 3746.475493430867, 4528.3660287559105, 5265.60507961912, 5521.5306698931045, 5539.0, 5631.50765047271, 5363.812266570651, 5396.541293989898, 5428.430014848542, 5459.2902922619805, 5483.287172667688, 4683.742394168354, 4919.0407870464915, 4920.753962301942, 5264.866754913928, 5464.672119672673, 4634.050019745877, 4659.858334708018, 5307.283516725192, 5331.5201631853315, 5358.6248962572245, 4092.4066010428915, 5337.893242135213, 5376.301080859464, 5429.588307040119, 5435.673859568438, 4294.506131794884, 5157.226416037624, 5395.271638328775, 5405.594580406564, 5410.132629706262], "value": 3962.964821855379, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [698.3226270517596, 722.5881247688818, 735.3418690272207, 778.0041546820069, 830.4933990265938, 15048.247587620615, 15713.214339283048, 15751.606209844746, 15756.290966906503, 15772.132532710697, 11801.645950621474, 14041.50854720085, 14130.64673383166, 14148.929255353734, 14150.292485375716, 696.4915611603533, 722.209180946865, 735.5072101691879, 863.3567991846083, 886.3706768194589, 881.6870011146048, 885.1016218538189, 895.5566994337812, 900.0864122915247, 901.6573701993234, 953.4041224234853, 953.7901661634429, 956.5121787888193, 959.6689142245914, 960.04475546831, 727.3853593713357, 946.9952650236705, 947.0813311088233, 949.5632009275741, 952.476138124029, 559.3036669346649, 683.3337495941418, 704.2816327346078, 707.9964600177018, 713.0801266366382, 12645.367731613382, 12668.619941401772, 12691.428885700165, 12712.809307860298, 12844.678883027906, 13203.801942970864, 13786.517471888536, 13861.4455421783, 13870.791938120836, 14087.788683169761, 11848.585299514476, 12371.319577423239, 12427.087991255545, 12499.875001249962, 13012.284324362156, 4421.905285961451, 4518.186726389248, 4540.841070562515, 4549.021960278523, 4553.863384098482, 106226.46886765595, 109514.0, 113322.86677133206, 113395.43302283436, 113742.0, 10537.789244215073, 10846.566137354575, 11064.391458469701, 11084.168687348481, 11141.610043648434, 22068.779312206672, 22074.558508829734, 22081.668774968388, 22097.0, 22157.778422215895, 7556.842737989344, 7696.499727517694, 7779.961100194463, 7872.84254314922, 7935.603219838985, 4160.1471698301775, 4232.343986682069, 4282.143571285756, 4296.871093867127, 4413.984783499813, 3454.3954807908517, 3514.1741690702665, 3562.1450851795385, 3566.8751593694615, 3568.892933212008, 584.3455330030308, 586.6626689653381, 591.9970400147972, 606.1332294818452, 606.9393060693984, 502.9446760856303, 515.8014164546677, 552.6324993879025, 597.3369559788631, 626.7399029402837, 7735.762278035488, 8363.623636936352, 8644.029682932214, 8699.304055675531, 8926.196642302224, 563.0372063770998, 580.4021857486796, 609.7865746988518, 613.7938949963343, 628.8019273928697, 4249.192653395845, 4252.362145678173, 4282.828686852553, 4360.912781744348, 4433.866983990485, 105217.0, 124860.0, 143627.28186359, 146281.2685936585, 153997.23001385145, 122362.0, 125777.37111314385, 126619.99999999815, 126632.0, 128918.89871683069, 102470.97529024615, 105076.94923050824, 105837.0, 105913.94086059349, 108468.45765771279, 8142.307903828241, 8263.297619702393, 8324.334053275845, 8470.872936906075, 8589.0, 38087.80956095202, 55888.0, 59566.70216648889, 59767.40232597618, 62582.68708656428, 89270.0, 89951.55508671496, 90604.54697726469, 90675.5466222691, 95629.5655565181, 12686.429110689856, 12751.234925904475, 12903.935480322538, 12995.28525931083, 13087.934560327518, 11856.644300670994, 12100.636980890587, 12359.073069519642, 12493.500259989498, 14590.635234118807, 13214.471421143047, 13649.590512284647, 13746.587602371945, 13834.0, 14426.06230595008, 13008.739825203633, 13294.069415140848, 13697.465968795805, 13740.244286564335, 14220.146791192561, 13199.868001320248, 13309.600711978655, 13409.463621455032, 13425.462981480632, 13451.730965380442, 11143.387113708824, 11382.772344552897, 11411.771764564495, 11460.885391146316, 11486.36824974601, 9650.517474126125, 9679.419234845931, 10330.741731456774, 11186.57175150178, 11369.204155709353], "value": 7613.442243628052, "unit": "score"}], "name": "dromaeo_css", "value": 7133.451399378696, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 114.0, 112.0, 113.0, 114.0, 112.0, 113.0, 113.0, 112.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 115.0, 112.0, 150.0, 115.0, 112.0, 116.0, 112.0, 145.0, 110.0], "value": 124.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 184.0, 186.0, 181.0, 184.0, 185.0, 185.0, 187.0, 182.0, 185.0], "value": 184.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 59.0, 93.0, 78.0, 85.0, 84.0, 66.0, 85.0, 59.0], "value": 74.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 70.0, 95.0, 69.0, 70.0, 69.0, 93.0, 67.0, 68.0, 91.0], "value": 77.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 134.0, 122.0, 87.0, 83.0, 87.0, 86.0, 87.0, 84.0], "value": 94.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 150.0, 151.0, 94.0, 97.0, 94.0, 92.0, 94.0, 94.0, 93.0], "value": 106.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 82.0, 81.0, 91.0, 119.0, 82.0, 85.0, 83.0, 81.0], "value": 87.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 53.0, 52.0, 59.0, 54.0, 55.0, 54.0, 54.0, 54.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 73.0, 68.0, 78.0, 75.0, 71.0, 70.0, 72.0, 71.0, 75.0], "value": 71.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 90.0, 90.0, 86.0, 86.0, 84.0, 86.0, 88.0, 86.0, 92.0], "value": 87.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 141.0, 149.0, 161.0, 130.0, 123.0, 148.0, 164.0, 213.0, 144.0], "value": 152.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 178.0, 172.0, 168.0, 173.0, 174.0, 168.0, 183.0, 232.0, 172.0], "value": 179.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 68.0, 69.0, 69.0, 69.0, 69.0, 67.0, 67.0, 68.0], "value": 68.3, "unit": "score"}], "name": "kraken", "value": 1475.1, "alertThreshold": 2.0}]} 15:53:13 INFO - Return code: 0 15:53:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:53:13 INFO - # TBPL SUCCESS # 15:53:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:53:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:53:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:53:13 INFO - 2016-10-18 15:53:13.548 screenresolution[3048:43791] starting screenresolution argv=screenresolution get 15:53:13 INFO - 2016-10-18 15:53:13.551 screenresolution[3048:43791] Display 0: 1600x1200x32@60 15:53:13 INFO - 2016-10-18 15:53:13.557 screenresolution[3049:43794] starting screenresolution argv=screenresolution list 15:53:13 INFO - Available Modes on Display 0 15:53:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:53:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:53:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:53:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:53:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:53:13 INFO - Intel Iris: 15:53:13 INFO - Chipset Model: Intel Iris 15:53:13 INFO - Type: GPU 15:53:13 INFO - Bus: Built-In 15:53:13 INFO - VRAM (Dynamic, Max): 1536 MB 15:53:13 INFO - Vendor: Intel (0x8086) 15:53:13 INFO - Device ID: 0x0a2e 15:53:13 INFO - Revision ID: 0x0009 15:53:13 INFO - Displays: 15:53:13 INFO - Display: 15:53:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:53:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:53:13 INFO - Display Serial Number: 1600x1200 60 15:53:13 INFO - Main Display: Yes 15:53:13 INFO - Mirror: Off 15:53:13 INFO - Online: Yes 15:53:13 INFO - Rotation: Supported 15:53:13 INFO - Return code: 0 15:53:13 INFO - Running post-action listener: _resource_record_post_action 15:53:13 INFO - [mozharness: 2016-10-18 22:53:13.797660Z] Finished run-tests step (success) 15:53:13 INFO - Running post-run listener: _resource_record_post_run 15:53:13 INFO - Total resource usage - Wall time: 1214s; CPU: 53.0%; Read bytes: 212992; Write bytes: 705299456; Read time: 3; Write time: 2127 15:53:13 INFO - TinderboxPrint: CPU usage
53.4% 15:53:13 INFO - TinderboxPrint: I/O read bytes / time
212,992 / 3 15:53:13 INFO - TinderboxPrint: I/O write bytes / time
705,299,456 / 2,127 15:53:13 INFO - TinderboxPrint: CPU idle
2,262.7 (46.6%) 15:53:13 INFO - TinderboxPrint: CPU system
972.0 (20.0%) 15:53:13 INFO - TinderboxPrint: CPU user
1,623.1 (33.4%) 15:53:13 INFO - TinderboxPrint: Swap in / out
405,929,984 / 0 15:53:13 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 391035392; Write bytes: 385385984; Read time: 29601; Write time: 758 15:53:13 INFO - run-tests - Wall time: 1180s; CPU: 53.0%; Read bytes: 212992; Write bytes: 296328704; Read time: 3; Write time: 1322 15:53:14 INFO - Running post-run listener: _upload_blobber_files 15:53:14 INFO - Blob upload gear active. 15:53:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:53:14 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 15:53:14 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:53:14 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:53:14 INFO - (blobuploader) - INFO - Open directory for files ... 15:53:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:53:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:53:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:53:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:53:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:53:15 INFO - (blobuploader) - INFO - Done attempting. 15:53:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:53:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:53:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:53:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:53:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:53:16 INFO - (blobuploader) - INFO - Done attempting. 15:53:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:53:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:53:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:53:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:53:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:53:19 INFO - (blobuploader) - INFO - Done attempting. 15:53:19 INFO - (blobuploader) - INFO - Iteration through files over. 15:53:19 INFO - Return code: 0 15:53:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:53:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:53:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/7fe66ad66bdc415ada808aa0eda9120fb4588beb8c8780140fe2efa401772cb09568f28336b46ece91057abec8198c9f762b5bf8ac596d55726c4b05d3758899", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/297226ac6e096be302d82e7027b76737305751811df4053b1ce1fc105981b6cf439b4a810a12f3a81628626d6bdeb854b333548910586bb206a348030c42519c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5b68241e94f052248c323638516d2cdabb7fbb9cd10b2b06d5d3514966166c87da8d48e886f69207f9bd209a6a84250a40d4a2c00a32357fbb182e86738b6ac6"} 15:53:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:53:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:53:19 INFO - Contents: 15:53:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/7fe66ad66bdc415ada808aa0eda9120fb4588beb8c8780140fe2efa401772cb09568f28336b46ece91057abec8198c9f762b5bf8ac596d55726c4b05d3758899", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/297226ac6e096be302d82e7027b76737305751811df4053b1ce1fc105981b6cf439b4a810a12f3a81628626d6bdeb854b333548910586bb206a348030c42519c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5b68241e94f052248c323638516d2cdabb7fbb9cd10b2b06d5d3514966166c87da8d48e886f69207f9bd209a6a84250a40d4a2c00a32357fbb182e86738b6ac6"} 15:53:19 INFO - Running post-run listener: copy_logs_to_upload_dir 15:53:19 INFO - Copying logs to upload dir... 15:53:19 INFO - mkdir: /builds/slave/test/build/upload/logs 15:53:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.400680 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-18 15:53:19.566362) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-18 15:53:19.570029) ========= 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.e8uhZ7lvyV/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.fxwiFL4Txv/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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/Autoland/sha512/7fe66ad66bdc415ada808aa0eda9120fb4588beb8c8780140fe2efa401772cb09568f28336b46ece91057abec8198c9f762b5bf8ac596d55726c4b05d3758899", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/297226ac6e096be302d82e7027b76737305751811df4053b1ce1fc105981b6cf439b4a810a12f3a81628626d6bdeb854b333548910586bb206a348030c42519c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5b68241e94f052248c323638516d2cdabb7fbb9cd10b2b06d5d3514966166c87da8d48e886f69207f9bd209a6a84250a40d4a2c00a32357fbb182e86738b6ac6"} build_url:https://queue.taskcluster.net/v1/task/WbqCzpGrTmWbmO2oCt2o7g/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011338 build_url: 'https://queue.taskcluster.net/v1/task/WbqCzpGrTmWbmO2oCt2o7g/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/7fe66ad66bdc415ada808aa0eda9120fb4588beb8c8780140fe2efa401772cb09568f28336b46ece91057abec8198c9f762b5bf8ac596d55726c4b05d3758899", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/297226ac6e096be302d82e7027b76737305751811df4053b1ce1fc105981b6cf439b4a810a12f3a81628626d6bdeb854b333548910586bb206a348030c42519c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5b68241e94f052248c323638516d2cdabb7fbb9cd10b2b06d5d3514966166c87da8d48e886f69207f9bd209a6a84250a40d4a2c00a32357fbb182e86738b6ac6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-18 15:53:19.603667) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 15:53:19.604208) ========= 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.e8uhZ7lvyV/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.fxwiFL4Txv/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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.005436 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 15:53:19.653269) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-18 15:53:19.653602) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-18 15:53:19.653911) ========= ========= Total master_lag: 0.18 =========