builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0369 starttime: 1467302650.6 results: success (0) buildid: 20160630061725 builduid: b74caa2562a74220a1cb97cfc5d3c721 revision: de6b42bae9ddb72f09f04173c306b8fad9fd9a8d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 09:04:10.599473) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 09:04:10.599957) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 09:04:10.600255) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 09:04:10.911975) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 09:04:10.912223) ========= 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.WlLrpSmvN3/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.WZ66v7PCtB/Listeners TMPDIR=/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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-06-30 09:04:10-- 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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 159M=0s 2016-06-30 09:04:11 (159 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.495849 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 09:04:11.430845) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 09:04:11.431154) ========= 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.WlLrpSmvN3/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.WZ66v7PCtB/Listeners TMPDIR=/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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.020475 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 09:04:11.479195) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-30 09:04:11.479533) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev de6b42bae9ddb72f09f04173c306b8fad9fd9a8d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev de6b42bae9ddb72f09f04173c306b8fad9fd9a8d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WlLrpSmvN3/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.WZ66v7PCtB/Listeners TMPDIR=/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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-06-30 09:04:11,559 truncating revision to first 12 chars 2016-06-30 09:04:11,559 Setting DEBUG logging. 2016-06-30 09:04:11,559 attempt 1/10 2016-06-30 09:04:11,559 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/de6b42bae9dd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-30 09:04:12,788 unpacking tar archive at: fx-team-de6b42bae9dd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.505984 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-30 09:04:13.005090) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 09:04:13.005484) ========= script_repo_revision: de6b42bae9ddb72f09f04173c306b8fad9fd9a8d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 09:04:13.005995) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 09:04:13.006344) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 09:04:13.023610) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 32 secs) (at 2016-06-30 09:04:13.024141) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WlLrpSmvN3/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.WZ66v7PCtB/Listeners TMPDIR=/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 09:04:13 INFO - MultiFileLogger online at 20160630 09:04:13 in /builds/slave/test 09:04:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 09:04:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:04:13 INFO - {'append_to_log': False, 09:04:13 INFO - 'base_work_dir': '/builds/slave/test', 09:04:13 INFO - 'blob_upload_branch': 'Fx-Team', 09:04:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:04:13 INFO - 'branch': 'Fx-Team', 09:04:13 INFO - 'buildbot_json_path': 'buildprops.json', 09:04:13 INFO - 'config_files': ('talos/mac_config.py',), 09:04:13 INFO - 'default_actions': ('clobber', 09:04:13 INFO - 'read-buildbot-config', 09:04:13 INFO - 'download-and-extract', 09:04:13 INFO - 'populate-webroot', 09:04:13 INFO - 'create-virtualenv', 09:04:13 INFO - 'install', 09:04:13 INFO - 'run-tests'), 09:04:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:04:13 INFO - 'download_minidump_stackwalk': True, 09:04:13 INFO - 'download_symbols': 'ondemand', 09:04:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:04:13 INFO - 'tooltool.py': '/tools/tooltool.py', 09:04:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:04:13 INFO - '/tools/misc-python/virtualenv.py')}, 09:04:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:04:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:04:13 INFO - 'installer_path': 'installer.exe', 09:04:13 INFO - 'log_level': 'info', 09:04:13 INFO - 'log_name': 'talos', 09:04:13 INFO - 'log_to_console': True, 09:04:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:04:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:04:13 INFO - 'opt_config_files': (), 09:04:13 INFO - 'pip_index': False, 09:04:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:04:13 INFO - 'cmd': ('bash', 09:04:13 INFO - '-c', 09:04:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:04:13 INFO - 'enabled': True, 09:04:13 INFO - 'halt_on_failure': False, 09:04:13 INFO - 'name': 'check_screen_resolution'},), 09:04:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:04:13 INFO - 'cmd': ('bash', 09:04:13 INFO - '-c', 09:04:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:04:13 INFO - 'enabled': True, 09:04:13 INFO - 'halt_on_failure': False, 09:04:13 INFO - 'name': 'check_screen_resolution'},), 09:04:13 INFO - 'run_cmd_checks_enabled': True, 09:04:13 INFO - 'sps_profile': False, 09:04:13 INFO - 'sps_profile_interval': 0, 09:04:13 INFO - 'suite': 'dromaeojs-e10s', 09:04:13 INFO - 'system_bits': '32', 09:04:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:04:13 INFO - 'title': 't-yosemite-r7-0369', 09:04:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:04:13 INFO - 'use_talos_json': True, 09:04:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:04:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:04:13 INFO - 'work_dir': 'build'} 09:04:13 INFO - ##### 09:04:13 INFO - ##### Running clobber step. 09:04:13 INFO - ##### 09:04:13 INFO - Running pre-action listener: _resource_record_pre_action 09:04:13 INFO - Running main action method: clobber 09:04:13 INFO - rmtree: /builds/slave/test/build 09:04:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:04:14 INFO - Running post-action listener: _resource_record_post_action 09:04:14 INFO - ##### 09:04:14 INFO - ##### Finished clobber step (success) 09:04:14 INFO - ##### 09:04:14 INFO - ##### 09:04:14 INFO - ##### Running read-buildbot-config step. 09:04:14 INFO - ##### 09:04:14 INFO - Running pre-action listener: _resource_record_pre_action 09:04:14 INFO - Running main action method: read_buildbot_config 09:04:14 INFO - Using buildbot properties: 09:04:14 INFO - { 09:04:14 INFO - "project": "", 09:04:14 INFO - "product": "firefox", 09:04:14 INFO - "script_repo_revision": "production", 09:04:14 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 09:04:14 INFO - "repository": "", 09:04:14 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 09:04:14 INFO - "buildid": "20160630061725", 09:04:14 INFO - "pgo_build": "False", 09:04:14 INFO - "basedir": "/builds/slave/test", 09:04:14 INFO - "buildnumber": 47, 09:04:14 INFO - "slavename": "t-yosemite-r7-0369", 09:04:14 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 09:04:14 INFO - "platform": "yosemite_r7", 09:04:14 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 09:04:14 INFO - "branch": "fx-team", 09:04:14 INFO - "repo_path": "integration/fx-team", 09:04:14 INFO - "revision": "de6b42bae9ddb72f09f04173c306b8fad9fd9a8d", 09:04:14 INFO - "stage_platform": "macosx64", 09:04:14 INFO - "builduid": "b74caa2562a74220a1cb97cfc5d3c721", 09:04:14 INFO - "slavebuilddir": "test" 09:04:14 INFO - } 09:04:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/RQf05H5fQ2Cnh5Wm_ubArw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 09:04:14 INFO - Running post-action listener: _resource_record_post_action 09:04:14 INFO - ##### 09:04:14 INFO - ##### Finished read-buildbot-config step (success) 09:04:14 INFO - ##### 09:04:14 INFO - ##### 09:04:14 INFO - ##### Running download-and-extract step. 09:04:14 INFO - ##### 09:04:14 INFO - Running pre-action listener: _resource_record_pre_action 09:04:14 INFO - Running main action method: download_and_extract 09:04:14 INFO - mkdir: /builds/slave/test/build/tests 09:04:14 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:14 INFO - https://queue.taskcluster.net/v1/task/RQf05H5fQ2Cnh5Wm_ubArw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 09:04:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQf05H5fQ2Cnh5Wm_ubArw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 09:04:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQf05H5fQ2Cnh5Wm_ubArw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 09:04:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQf05H5fQ2Cnh5Wm_ubArw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 09:04:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQf05H5fQ2Cnh5Wm_ubArw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 09:04:29 INFO - Downloaded 1199 bytes. 09:04:29 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 09:04:29 INFO - Using the following test package requirements: 09:04:29 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 09:04:29 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:04:29 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 09:04:29 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:04:29 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 09:04:29 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:04:29 INFO - u'jsshell-mac.zip'], 09:04:29 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:04:29 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 09:04:29 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 09:04:29 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:04:29 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 09:04:29 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:04:29 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 09:04:29 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:04:29 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 09:04:29 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:04:29 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 09:04:29 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:04:29 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:29 INFO - https://queue.taskcluster.net/v1/task/RQf05H5fQ2Cnh5Wm_ubArw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:04:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQf05H5fQ2Cnh5Wm_ubArw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 09:04:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQf05H5fQ2Cnh5Wm_ubArw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 09:04:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQf05H5fQ2Cnh5Wm_ubArw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 09:04:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQf05H5fQ2Cnh5Wm_ubArw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:04:43 INFO - Downloaded 18788652 bytes. 09:04:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:04:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:04:46 INFO - Return code: 0 09:04:46 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:04:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:46 INFO - https://queue.taskcluster.net/v1/task/RQf05H5fQ2Cnh5Wm_ubArw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:04:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQf05H5fQ2Cnh5Wm_ubArw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 09:04:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQf05H5fQ2Cnh5Wm_ubArw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 09:04:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQf05H5fQ2Cnh5Wm_ubArw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 09:04:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQf05H5fQ2Cnh5Wm_ubArw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:04:47 INFO - Downloaded 18788652 bytes. 09:04:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:04:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:04:51 INFO - Return code: 0 09:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:51 INFO - https://queue.taskcluster.net/v1/task/RQf05H5fQ2Cnh5Wm_ubArw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:04:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQf05H5fQ2Cnh5Wm_ubArw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 09:04:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQf05H5fQ2Cnh5Wm_ubArw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 09:04:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQf05H5fQ2Cnh5Wm_ubArw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 09:04:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQf05H5fQ2Cnh5Wm_ubArw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:04:52 INFO - Downloaded 14405242 bytes. 09:04:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:04:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 09:04:52 INFO - Return code: 0 09:04: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:52 INFO - https://queue.taskcluster.net/v1/task/RQf05H5fQ2Cnh5Wm_ubArw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 09:04:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQf05H5fQ2Cnh5Wm_ubArw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 09:04:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQf05H5fQ2Cnh5Wm_ubArw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 09:04:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQf05H5fQ2Cnh5Wm_ubArw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 09:04:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQf05H5fQ2Cnh5Wm_ubArw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 09:04:57 INFO - Downloaded 112418459 bytes. 09:04:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RQf05H5fQ2Cnh5Wm_ubArw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 09:04:57 INFO - mkdir: /builds/slave/test/properties 09:04:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:04:57 INFO - Writing to file /builds/slave/test/properties/build_url 09:04:57 INFO - Contents: 09:04:57 INFO - build_url:https://queue.taskcluster.net/v1/task/RQf05H5fQ2Cnh5Wm_ubArw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 09:04:58 INFO - Running post-action listener: _resource_record_post_action 09:04:58 INFO - Running post-action listener: set_extra_try_arguments 09:04:58 INFO - ##### 09:04:58 INFO - ##### Finished download-and-extract step (success) 09:04:58 INFO - ##### 09:04:58 INFO - ##### 09:04:58 INFO - ##### Running populate-webroot step. 09:04:58 INFO - ##### 09:04:58 INFO - Running pre-action listener: _resource_record_pre_action 09:04:58 INFO - Running main action method: populate_webroot 09:04:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:04:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:04:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:04:58 INFO - '--tppagecycles', 09:04:58 INFO - '7'], 09:04:58 INFO - 'tests': ['tsvgm']}}, 09:04:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:04:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:04:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:04:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:04:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:04:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:04:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:58 INFO - 'talos_options': ['--disable-e10s'], 09:04:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:04:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:04:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:58 INFO - 'talos_options': ['--disable-e10s'], 09:04:58 INFO - 'tests': ['damp', 'tps']}, 09:04:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:58 INFO - 'tests': ['damp', 'tps']}, 09:04:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:04:58 INFO - 'tests': ['dromaeo_dom']}, 09:04:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:04:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:04:58 INFO - 'tests': ['basic_compositor_video']}, 09:04:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:04:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:04:58 INFO - 'tests': ['a11yr', 09:04:58 INFO - 'ts_paint', 09:04:58 INFO - 'tpaint', 09:04:58 INFO - 'sessionrestore', 09:04:58 INFO - 'sessionrestore_no_auto_restore', 09:04:58 INFO - 'tabpaint']}, 09:04:58 INFO - 'other-e10s': {'tests': ['a11yr', 09:04:58 INFO - 'ts_paint', 09:04:58 INFO - 'tpaint', 09:04:58 INFO - 'sessionrestore', 09:04:58 INFO - 'sessionrestore_no_auto_restore', 09:04:58 INFO - 'tabpaint']}, 09:04:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:04:58 INFO - 'ts_paint', 09:04:58 INFO - 'tpaint', 09:04:58 INFO - 'sessionrestore', 09:04:58 INFO - 'sessionrestore_no_auto_restore', 09:04:58 INFO - 'tabpaint']}, 09:04:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:04:58 INFO - 'ts_paint', 09:04:58 INFO - 'tpaint', 09:04:58 INFO - 'sessionrestore', 09:04:58 INFO - 'sessionrestore_no_auto_restore', 09:04:58 INFO - 'tabpaint']}, 09:04:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:04:58 INFO - 'tests': ['a11yr', 09:04:58 INFO - 'ts_paint', 09:04:58 INFO - 'tpaint', 09:04:58 INFO - 'sessionrestore', 09:04:58 INFO - 'sessionrestore_no_auto_restore', 09:04:58 INFO - 'tabpaint']}, 09:04:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:04:58 INFO - 'tests': ['a11yr', 09:04:58 INFO - 'ts_paint', 09:04:58 INFO - 'tpaint', 09:04:58 INFO - 'sessionrestore', 09:04:58 INFO - 'sessionrestore_no_auto_restore', 09:04:58 INFO - 'tabpaint']}, 09:04:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:04:58 INFO - 'tests': ['tsvgx', 09:04:58 INFO - 'tsvgr_opacity', 09:04:58 INFO - 'tart', 09:04:58 INFO - 'tscrollx', 09:04:58 INFO - 'cart']}, 09:04:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:04:58 INFO - 'tsvgr_opacity', 09:04:58 INFO - 'tart', 09:04:58 INFO - 'tscrollx', 09:04:58 INFO - 'cart']}, 09:04:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:58 INFO - 'talos_options': ['--disable-e10s'], 09:04:58 INFO - 'tests': ['tp5o']}, 09:04:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:58 INFO - 'tests': ['tp5o']}, 09:04:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:58 INFO - 'talos_options': ['--disable-e10s', 09:04:58 INFO - '--xperf_path', 09:04:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:04:58 INFO - 'tests': ['tp5n']}, 09:04:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:58 INFO - 'talos_options': ['--xperf_path', 09:04:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:04:58 INFO - 'tests': ['tp5n']}}, 09:04:58 INFO - 'talos.zip': {'path': '', 09:04:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:04:58 INFO - Running post-action listener: _resource_record_post_action 09:04:58 INFO - ##### 09:04:58 INFO - ##### Finished populate-webroot step (success) 09:04:58 INFO - ##### 09:04:58 INFO - ##### 09:04:58 INFO - ##### Running create-virtualenv step. 09:04:58 INFO - ##### 09:04:58 INFO - Running pre-action listener: _resource_record_pre_action 09:04:58 INFO - Running main action method: create_virtualenv 09:04:58 INFO - Creating virtualenv /builds/slave/test/build/venv 09:04:58 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 09:04:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:04:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:04:59 INFO - Using real prefix '/tools/python27' 09:04:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:04:59 INFO - Installing distribute.............................................................................................................................................................................................done. 09:05:02 INFO - Installing pip.................done. 09:05:02 INFO - Return code: 0 09:05:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102a9da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b32618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef8adac020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a01d30>, '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 0x102766db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1029f9b20>, '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.WlLrpSmvN3/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.WZ66v7PCtB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 09:05:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:05:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:05:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WlLrpSmvN3/Render', 09:05:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:05:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:05:02 INFO - 'HOME': '/Users/cltbld', 09:05:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:05:02 INFO - 'LOGNAME': 'cltbld', 09:05:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:02 INFO - 'MOZ_NO_REMOTE': '1', 09:05:02 INFO - 'NO_EM_RESTART': '1', 09:05:02 INFO - 'PAGER': '/bin/cat', 09:05:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:05:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:02 INFO - 'PWD': '/builds/slave/test', 09:05:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:05:02 INFO - 'SHELL': '/bin/bash', 09:05:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WZ66v7PCtB/Listeners', 09:05:02 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 09:05:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:05:02 INFO - 'USER': 'cltbld', 09:05:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:05:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:05:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:02 INFO - 'XPC_FLAGS': '0x0', 09:05:02 INFO - 'XPC_SERVICE_NAME': '0', 09:05:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:05:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:02 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 09:05:02 INFO - Cleaning up... 09:05:02 INFO - Return code: 0 09:05:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102a9da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b32618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef8adac020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a01d30>, '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 0x102766db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1029f9b20>, '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.WlLrpSmvN3/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.WZ66v7PCtB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 09:05:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:05:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:05:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WlLrpSmvN3/Render', 09:05:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:05:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:05:02 INFO - 'HOME': '/Users/cltbld', 09:05:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:05:02 INFO - 'LOGNAME': 'cltbld', 09:05:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:02 INFO - 'MOZ_NO_REMOTE': '1', 09:05:02 INFO - 'NO_EM_RESTART': '1', 09:05:02 INFO - 'PAGER': '/bin/cat', 09:05:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:05:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:02 INFO - 'PWD': '/builds/slave/test', 09:05:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:05:02 INFO - 'SHELL': '/bin/bash', 09:05:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WZ66v7PCtB/Listeners', 09:05:02 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 09:05:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:05:02 INFO - 'USER': 'cltbld', 09:05:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:05:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:05:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:02 INFO - 'XPC_FLAGS': '0x0', 09:05:02 INFO - 'XPC_SERVICE_NAME': '0', 09:05:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:05:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:03 INFO - Downloading/unpacking psutil>=3.1.1 09:05:03 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 09:05:03 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 09:05:03 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 09:05:03 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 09:05:03 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 09:05:03 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 09:05:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:05:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:05:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:05:06 INFO - Installing collected packages: psutil 09:05:06 INFO - Running setup.py install for psutil 09:05:06 INFO - building 'psutil._psutil_osx' extension 09:05:06 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 09:05:06 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 09:05:06 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 09:05:07 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 09:05:07 INFO - building 'psutil._psutil_posix' extension 09:05:07 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 09:05:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:05:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:05:07 INFO - ^ 09:05:07 INFO - 1 warning generated. 09:05:07 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 09:05:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:05:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:05:07 INFO - Successfully installed psutil 09:05:07 INFO - Cleaning up... 09:05:07 INFO - Return code: 0 09:05:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:05:07 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:07 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:07 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 0x102a9da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b32618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef8adac020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a01d30>, '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 0x102766db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1029f9b20>, '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.WlLrpSmvN3/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.WZ66v7PCtB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 09:05:07 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 09:05:07 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 09:05:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WlLrpSmvN3/Render', 09:05:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:05:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:05:07 INFO - 'HOME': '/Users/cltbld', 09:05:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:05:07 INFO - 'LOGNAME': 'cltbld', 09:05:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:07 INFO - 'MOZ_NO_REMOTE': '1', 09:05:07 INFO - 'NO_EM_RESTART': '1', 09:05:07 INFO - 'PAGER': '/bin/cat', 09:05:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:05:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:07 INFO - 'PWD': '/builds/slave/test', 09:05:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:05:07 INFO - 'SHELL': '/bin/bash', 09:05:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WZ66v7PCtB/Listeners', 09:05:07 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 09:05:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:05:07 INFO - 'USER': 'cltbld', 09:05:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:05:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:05:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:07 INFO - 'XPC_FLAGS': '0x0', 09:05:07 INFO - 'XPC_SERVICE_NAME': '0', 09:05:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:05:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:05:07 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 09:05:07 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 09:05:07 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 09:05:07 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 09:05:07 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 09:05:07 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 09:05:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:05:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:05:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:05:10 INFO - Installing collected packages: mozsystemmonitor 09:05:10 INFO - Running setup.py install for mozsystemmonitor 09:05:10 INFO - Successfully installed mozsystemmonitor 09:05:10 INFO - Cleaning up... 09:05:10 INFO - Return code: 0 09:05:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:05:10 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:10 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:10 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 0x102a9da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b32618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef8adac020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a01d30>, '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 0x102766db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1029f9b20>, '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.WlLrpSmvN3/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.WZ66v7PCtB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 09:05:10 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 09:05:10 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 09:05:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WlLrpSmvN3/Render', 09:05:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:05:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:05:10 INFO - 'HOME': '/Users/cltbld', 09:05:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:05:10 INFO - 'LOGNAME': 'cltbld', 09:05:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:10 INFO - 'MOZ_NO_REMOTE': '1', 09:05:10 INFO - 'NO_EM_RESTART': '1', 09:05:10 INFO - 'PAGER': '/bin/cat', 09:05:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:05:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:10 INFO - 'PWD': '/builds/slave/test', 09:05:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:05:10 INFO - 'SHELL': '/bin/bash', 09:05:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WZ66v7PCtB/Listeners', 09:05:10 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 09:05:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:05:10 INFO - 'USER': 'cltbld', 09:05:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:05:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:05:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:10 INFO - 'XPC_FLAGS': '0x0', 09:05:10 INFO - 'XPC_SERVICE_NAME': '0', 09:05:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:05:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:10 INFO - Downloading/unpacking jsonschema==2.5.1 09:05:10 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 09:05:10 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 09:05:10 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 09:05:10 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 09:05:10 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 09:05:10 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 09:05:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:05:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:05:12 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 09:05:12 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 09:05:12 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 09:05:12 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 09:05:12 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 09:05:12 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 09:05:13 INFO - Downloading functools32-3.2.3-2.tar.gz 09:05:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:05:13 INFO - warning: no files found matching '*.txt' 09:05:13 INFO - no previously-included directories found matching 'build' 09:05:13 INFO - no previously-included directories found matching 'dist' 09:05:13 INFO - no previously-included directories found matching '.git*' 09:05:13 INFO - Installing collected packages: jsonschema, functools32 09:05:13 INFO - Running setup.py install for functools32 09:05:13 INFO - warning: no files found matching '*.txt' 09:05:13 INFO - no previously-included directories found matching 'build' 09:05:13 INFO - no previously-included directories found matching 'dist' 09:05:13 INFO - no previously-included directories found matching '.git*' 09:05:13 INFO - Successfully installed jsonschema functools32 09:05:13 INFO - Cleaning up... 09:05:13 INFO - Return code: 0 09:05:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:05:13 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:13 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:13 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 0x102a9da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b32618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef8adac020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a01d30>, '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 0x102766db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1029f9b20>, '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.WlLrpSmvN3/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.WZ66v7PCtB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 09:05:13 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 09:05:13 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 09:05:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WlLrpSmvN3/Render', 09:05:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:05:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:05:13 INFO - 'HOME': '/Users/cltbld', 09:05:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:05:13 INFO - 'LOGNAME': 'cltbld', 09:05:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:13 INFO - 'MOZ_NO_REMOTE': '1', 09:05:13 INFO - 'NO_EM_RESTART': '1', 09:05:13 INFO - 'PAGER': '/bin/cat', 09:05:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:05:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:13 INFO - 'PWD': '/builds/slave/test', 09:05:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:05:13 INFO - 'SHELL': '/bin/bash', 09:05:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WZ66v7PCtB/Listeners', 09:05:13 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 09:05:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:05:13 INFO - 'USER': 'cltbld', 09:05:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:05:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:05:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:13 INFO - 'XPC_FLAGS': '0x0', 09:05:13 INFO - 'XPC_SERVICE_NAME': '0', 09:05:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:05:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:13 INFO - Downloading/unpacking blobuploader==1.2.4 09:05:13 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 09:05:13 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 09:05:13 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 09:05:13 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 09:05:13 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 09:05:13 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 09:05:16 INFO - Downloading blobuploader-1.2.4.tar.gz 09:05:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:05:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:05:16 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 09:05:16 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 09:05:16 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 09:05:16 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 09:05:16 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 09:05:16 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 09:05:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:05:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:05:17 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 09:05:17 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 09:05:17 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 09:05:17 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 09:05:17 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 09:05:17 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 09:05:18 INFO - Downloading docopt-0.6.1.tar.gz 09:05:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:05:18 INFO - Installing collected packages: blobuploader, requests, docopt 09:05:18 INFO - Running setup.py install for blobuploader 09:05:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:05:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:05:18 INFO - Running setup.py install for requests 09:05:18 INFO - Running setup.py install for docopt 09:05:18 INFO - Successfully installed blobuploader requests docopt 09:05:18 INFO - Cleaning up... 09:05:18 INFO - Return code: 0 09:05:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:05:18 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:19 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:19 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 0x102a9da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b32618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef8adac020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a01d30>, '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 0x102766db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1029f9b20>, '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.WlLrpSmvN3/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.WZ66v7PCtB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 09:05:19 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 09:05:19 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 09:05:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WlLrpSmvN3/Render', 09:05:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:05:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:05:19 INFO - 'HOME': '/Users/cltbld', 09:05:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:05:19 INFO - 'LOGNAME': 'cltbld', 09:05:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:19 INFO - 'MOZ_NO_REMOTE': '1', 09:05:19 INFO - 'NO_EM_RESTART': '1', 09:05:19 INFO - 'PAGER': '/bin/cat', 09:05:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:05:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:19 INFO - 'PWD': '/builds/slave/test', 09:05:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:05:19 INFO - 'SHELL': '/bin/bash', 09:05:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WZ66v7PCtB/Listeners', 09:05:19 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 09:05:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:05:19 INFO - 'USER': 'cltbld', 09:05:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:05:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:05:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:19 INFO - 'XPC_FLAGS': '0x0', 09:05:19 INFO - 'XPC_SERVICE_NAME': '0', 09:05:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:05:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:05:19 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-uzKuvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:05:19 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-ZIZCoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:05:19 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-hScjjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:05:20 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-mcOYDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:05:20 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-y0PI61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:05:20 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-j8stMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:05:20 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-q2bmTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:05:20 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-PWpzjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:05:20 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-EmkcwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:05:20 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-FAz9qo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:05:20 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-Bsf642-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:05:20 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-x4vkoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:05:20 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-89cIuy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:05:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:05:21 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-g4foN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:05:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:21 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-pYdQau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:05:21 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-N7DSAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:05:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:05:21 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-hKkPKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:05:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:05:21 INFO - Running setup.py install for manifestparser 09:05:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:05:21 INFO - Running setup.py install for mozcrash 09:05:21 INFO - Running setup.py install for mozdebug 09:05:21 INFO - Running setup.py install for mozdevice 09:05:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:05:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:05:22 INFO - Running setup.py install for mozfile 09:05:22 INFO - Running setup.py install for mozhttpd 09:05:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:05:22 INFO - Running setup.py install for mozinfo 09:05:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:05:22 INFO - Running setup.py install for mozInstall 09:05:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:05:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:05:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:05:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:05:22 INFO - Running setup.py install for mozleak 09:05:22 INFO - Running setup.py install for mozlog 09:05:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:05:22 INFO - Running setup.py install for moznetwork 09:05:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:05:23 INFO - Running setup.py install for mozprocess 09:05:23 INFO - Running setup.py install for mozprofile 09:05:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:05:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:05:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:05:23 INFO - Running setup.py install for mozrunner 09:05:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:05:23 INFO - Running setup.py install for mozscreenshot 09:05:23 INFO - Running setup.py install for moztest 09:05:23 INFO - Running setup.py install for mozversion 09:05:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:05:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:05:24 INFO - Cleaning up... 09:05:24 INFO - Return code: 0 09:05:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:05:24 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:24 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:24 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 0x102a9da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b32618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef8adac020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a01d30>, '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 0x102766db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1029f9b20>, '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.WlLrpSmvN3/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.WZ66v7PCtB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 09:05:24 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 09:05:24 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 09:05:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WlLrpSmvN3/Render', 09:05:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:05:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:05:24 INFO - 'HOME': '/Users/cltbld', 09:05:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:05:24 INFO - 'LOGNAME': 'cltbld', 09:05:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:24 INFO - 'MOZ_NO_REMOTE': '1', 09:05:24 INFO - 'NO_EM_RESTART': '1', 09:05:24 INFO - 'PAGER': '/bin/cat', 09:05:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:05:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:24 INFO - 'PWD': '/builds/slave/test', 09:05:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:05:24 INFO - 'SHELL': '/bin/bash', 09:05:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WZ66v7PCtB/Listeners', 09:05:24 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 09:05:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:05:24 INFO - 'USER': 'cltbld', 09:05:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:05:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:05:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:24 INFO - 'XPC_FLAGS': '0x0', 09:05:24 INFO - 'XPC_SERVICE_NAME': '0', 09:05:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:05:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:05:24 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-on1t3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:05:24 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)) 09:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:05:24 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-OiIxTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:05:24 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)) 09:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:05:24 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-cOOFeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:05:24 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)) 09:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:05:24 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-8XDXnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:05:24 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)) 09:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:05:24 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-aHTcUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:05:24 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)) 09:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:05:24 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-EYIS09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:05:24 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)) 09:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:05:24 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-JRuOAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:05:25 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)) 09:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:05:25 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-W1qviK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:05:25 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)) 09:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:05:25 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-pNCJra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:05:25 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)) 09:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:05:25 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-e96Rx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:05:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 09:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:05:25 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-gxZNnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:05:25 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)) 09:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:05:25 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-q3ZNsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:05:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 09:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:05:25 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-JfKe2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:05:25 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)) 09:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:05:25 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-i2Eg8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:05:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 09:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:25 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-WUor8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:25 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)) 09:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:05:25 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-yhbkzE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:05:26 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)) 09:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:05:26 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-KptB7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:05:26 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)) 09:05:26 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)) 09:05:26 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)) 09:05:26 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)) 09:05:26 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)) 09:05:26 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)) 09:05:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:05:26 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 09:05:26 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 09:05:26 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 09:05:26 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 09:05:26 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 09:05:26 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 09:05:28 INFO - Downloading blessings-1.6.tar.gz 09:05:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:05:28 INFO - Installing collected packages: blessings 09:05:28 INFO - Running setup.py install for blessings 09:05:28 INFO - Successfully installed blessings 09:05:28 INFO - Cleaning up... 09:05:28 INFO - Return code: 0 09:05:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:05:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:05:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:05:29 INFO - Reading from file tmpfile_stdout 09:05:29 INFO - Current package versions: 09:05:29 INFO - blessings == 1.6 09:05:29 INFO - blobuploader == 1.2.4 09:05:29 INFO - docopt == 0.6.1 09:05:29 INFO - functools32 == 3.2.3-2 09:05:29 INFO - jsonschema == 2.5.1 09:05:29 INFO - manifestparser == 1.1 09:05:29 INFO - mozInstall == 1.12 09:05:29 INFO - mozcrash == 0.17 09:05:29 INFO - mozdebug == 0.1 09:05:29 INFO - mozdevice == 0.48 09:05:29 INFO - mozfile == 1.2 09:05:29 INFO - mozhttpd == 0.7 09:05:29 INFO - mozinfo == 0.9 09:05:29 INFO - mozleak == 0.1 09:05:29 INFO - mozlog == 3.2 09:05:29 INFO - moznetwork == 0.27 09:05:29 INFO - mozprocess == 0.22 09:05:29 INFO - mozprofile == 0.28 09:05:29 INFO - mozrunner == 6.11 09:05:29 INFO - mozscreenshot == 0.1 09:05:29 INFO - mozsystemmonitor == 0.3 09:05:29 INFO - moztest == 0.7 09:05:29 INFO - mozversion == 1.4 09:05:29 INFO - psutil == 3.1.1 09:05:29 INFO - requests == 1.2.3 09:05:29 INFO - wsgiref == 0.1.2 09:05:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:05:29 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:29 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:29 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 0x102a9da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b32618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef8adac020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a01d30>, '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 0x102766db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1029f9b20>, '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.WlLrpSmvN3/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.WZ66v7PCtB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 09:05:29 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 09:05:29 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 09:05:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WlLrpSmvN3/Render', 09:05:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:05:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:05:29 INFO - 'HOME': '/Users/cltbld', 09:05:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:05:29 INFO - 'LOGNAME': 'cltbld', 09:05:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:29 INFO - 'MOZ_NO_REMOTE': '1', 09:05:29 INFO - 'NO_EM_RESTART': '1', 09:05:29 INFO - 'PAGER': '/bin/cat', 09:05:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:05:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:29 INFO - 'PWD': '/builds/slave/test', 09:05:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:05:29 INFO - 'SHELL': '/bin/bash', 09:05:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WZ66v7PCtB/Listeners', 09:05:29 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 09:05:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:05:29 INFO - 'USER': 'cltbld', 09:05:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:05:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:05:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:29 INFO - 'XPC_FLAGS': '0x0', 09:05:29 INFO - 'XPC_SERVICE_NAME': '0', 09:05:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:05:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:29 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)) 09:05:29 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)) 09:05:29 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)) 09:05:29 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)) 09:05:29 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)) 09:05:29 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)) 09:05:29 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)) 09:05:29 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)) 09:05:29 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)) 09:05:29 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)) 09:05:29 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)) 09:05:29 INFO - Cleaning up... 09:05:29 INFO - Return code: 0 09:05:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:05:29 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:29 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:29 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 0x102a9da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b32618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef8adac020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a01d30>, '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 0x102766db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1029f9b20>, '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.WlLrpSmvN3/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.WZ66v7PCtB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 09:05:29 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 09:05:29 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 09:05:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WlLrpSmvN3/Render', 09:05:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:05:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:05:29 INFO - 'HOME': '/Users/cltbld', 09:05:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:05:29 INFO - 'LOGNAME': 'cltbld', 09:05:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:29 INFO - 'MOZ_NO_REMOTE': '1', 09:05:29 INFO - 'NO_EM_RESTART': '1', 09:05:29 INFO - 'PAGER': '/bin/cat', 09:05:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:05:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:29 INFO - 'PWD': '/builds/slave/test', 09:05:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:05:29 INFO - 'SHELL': '/bin/bash', 09:05:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WZ66v7PCtB/Listeners', 09:05:29 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 09:05:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:05:29 INFO - 'USER': 'cltbld', 09:05:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:05:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:05:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:29 INFO - 'XPC_FLAGS': '0x0', 09:05:29 INFO - 'XPC_SERVICE_NAME': '0', 09:05:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:05:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:05:29 INFO - Cleaning up... 09:05:29 INFO - Return code: 0 09:05:29 INFO - Running post-action listener: _resource_record_post_action 09:05:29 INFO - Running post-action listener: _start_resource_monitoring 09:05:29 INFO - Starting resource monitoring. 09:05:29 INFO - ##### 09:05:29 INFO - ##### Finished create-virtualenv step (success) 09:05:29 INFO - ##### 09:05:29 INFO - ##### 09:05:29 INFO - ##### Running install step. 09:05:29 INFO - ##### 09:05:29 INFO - Running pre-action listener: _resource_record_pre_action 09:05:29 INFO - Running main action method: install 09:05:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:05:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:05:30 INFO - Reading from file tmpfile_stdout 09:05:30 INFO - Detecting whether we're running mozinstall >=1.0... 09:05:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:05:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:05:30 INFO - Reading from file tmpfile_stdout 09:05:30 INFO - Output received: 09:05:30 INFO - Usage: mozinstall [options] installer 09:05:30 INFO - Options: 09:05:30 INFO - -h, --help show this help message and exit 09:05:30 INFO - -d DEST, --destination=DEST 09:05:30 INFO - Directory to install application into. [default: 09:05:30 INFO - "/builds/slave/test"] 09:05:30 INFO - --app=APP Application being installed. [default: firefox] 09:05:30 INFO - mkdir: /builds/slave/test/build/application 09:05:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:05:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:06:04 INFO - Reading from file tmpfile_stdout 09:06:04 INFO - Output received: 09:06:04 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:06:04 INFO - Running post-action listener: _resource_record_post_action 09:06:04 INFO - ##### 09:06:04 INFO - ##### Finished install step (success) 09:06:04 INFO - ##### 09:06:04 INFO - ##### 09:06:04 INFO - ##### Running run-tests step. 09:06:04 INFO - ##### 09:06:04 INFO - Running pre-action listener: _resource_record_pre_action 09:06:04 INFO - Running main action method: run_tests 09:06:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:06:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:06:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:06:04 INFO - 2016-06-30 09:06:04.364 screenresolution[1957:18377] starting screenresolution argv=screenresolution get 09:06:04 INFO - 2016-06-30 09:06:04.367 screenresolution[1957:18377] Display 0: 1600x1200x32@60 09:06:04 INFO - 2016-06-30 09:06:04.372 screenresolution[1958:18379] starting screenresolution argv=screenresolution list 09:06:04 INFO - Available Modes on Display 0 09:06:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:06:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:06:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:06:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:06:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:06:04 INFO - Intel Iris: 09:06:04 INFO - Chipset Model: Intel Iris 09:06:04 INFO - Type: GPU 09:06:04 INFO - Bus: Built-In 09:06:04 INFO - VRAM (Dynamic, Max): 1536 MB 09:06:04 INFO - Vendor: Intel (0x8086) 09:06:04 INFO - Device ID: 0x0a2e 09:06:04 INFO - Revision ID: 0x0009 09:06:04 INFO - Displays: 09:06:04 INFO - Display: 09:06:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:06:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:06:04 INFO - Display Serial Number: 1600x1200 60 09:06:04 INFO - Main Display: Yes 09:06:04 INFO - Mirror: Off 09:06:04 INFO - Online: Yes 09:06:04 INFO - Rotation: Supported 09:06:04 INFO - Return code: 0 09:06:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:06:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:06:04 INFO - Python 2.7.3 09:06:04 INFO - Return code: 0 09:06:04 INFO - grabbing minidump binary from tooltool 09:06:04 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:06:04 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 0x102a01d30>, '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 0x102766db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1029f9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:06:04 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 09:06:04 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 09:06:04 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 09:06:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:06:04 INFO - Return code: 0 09:06:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:06:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:06:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:06:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:06:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:06:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RQf05H5fQ2Cnh5Wm_ubArw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0369', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:06:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RQf05H5fQ2Cnh5Wm_ubArw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0369 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:06:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WlLrpSmvN3/Render', 09:06:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:06:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:06:04 INFO - 'HOME': '/Users/cltbld', 09:06:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:06:04 INFO - 'LOGNAME': 'cltbld', 09:06:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:06:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:06:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:04 INFO - 'MOZ_NO_REMOTE': '1', 09:06:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:06:04 INFO - 'NO_EM_RESTART': '1', 09:06:04 INFO - 'PAGER': '/bin/cat', 09:06:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:06:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:04 INFO - 'PWD': '/builds/slave/test', 09:06:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:06:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:06:04 INFO - 'SHELL': '/bin/bash', 09:06:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WZ66v7PCtB/Listeners', 09:06:04 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 09:06:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:06:04 INFO - 'USER': 'cltbld', 09:06:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:06:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:06:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:04 INFO - 'XPC_FLAGS': '0x0', 09:06:04 INFO - 'XPC_SERVICE_NAME': '0', 09:06:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:06:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RQf05H5fQ2Cnh5Wm_ubArw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0369', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:06:04 INFO - mozversion application_buildid: 20160630061725 09:06:04 INFO - mozversion application_changeset: de6b42bae9ddb72f09f04173c306b8fad9fd9a8d 09:06:04 INFO - mozversion application_display_name: Nightly 09:06:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:06:04 INFO - mozversion application_name: Firefox 09:06:04 INFO - mozversion application_remotingname: firefox 09:06:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:06:04 INFO - mozversion application_vendor: Mozilla 09:06:04 INFO - mozversion application_version: 50.0a1 09:06:04 INFO - mozversion platform_buildid: 20160630061725 09:06:04 INFO - mozversion platform_changeset: de6b42bae9ddb72f09f04173c306b8fad9fd9a8d 09:06:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:06:04 INFO - mozversion platform_version: 50.0a1 09:06:04 INFO - using testdate: 1467302764 09:06:04 INFO - actual date: 1467302764 09:06:04 INFO - starting webserver on 'localhost:53262' 09:06:04 INFO - SUITE-START | Running 2 tests 09:06:04 INFO - TEST-START | dromaeo_css 09:06:04 INFO - operating with platform_type : mac_ 09:06:04 INFO - Initialising browser for dromaeo_css test... 09:06:04 INFO - TEST-INFO | started process 1968 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/tmpFhwCSC/profile http://localhost:53262/getInfo.html) 09:06:08 INFO - PROCESS | 1968 | __metrics Screen width/height:1600/1200 09:06:08 INFO - PROCESS | 1968 | colorDepth:24 09:06:08 INFO - PROCESS | 1968 | Browser inner width/height: 1024/689 09:06:08 INFO - PROCESS | 1968 | __metrics 09:06:08 ERROR - PROCESS | 1968 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 09:06:08 INFO - TEST-INFO | 1968: exit 0 09:06:08 INFO - Browser initialized. 09:06:08 INFO - Running cycle 1/1 for dromaeo_css test... 09:06:08 INFO - TEST-INFO | started process 1971 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/tmpFhwCSC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:06:20 INFO - PROCESS | 1971 | RSS: Main: 255660032 09:06:20 INFO - PROCESS | 1971 | 09:07:10 INFO - PROCESS | 1971 | 1467302830576 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] 09:09:23 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:53262/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53262/tests/dromaeo/cssquery-ext.html) 09:09:24 INFO - PROCESS | 1971 | RSS: Main: 268279808 09:09:24 INFO - PROCESS | 1971 | 09:12:26 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:53262/tests/dromaeo/cssquery-ext.html (next: http://localhost:53262/tests/dromaeo/cssquery-jquery.html) 09:12:27 INFO - PROCESS | 1971 | RSS: Main: 276955136 09:12:27 INFO - PROCESS | 1971 | 09:15:29 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:53262/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53262/tests/dromaeo/cssquery-mootools.html) 09:15:29 INFO - PROCESS | 1971 | RSS: Main: 281829376 09:15:29 INFO - PROCESS | 1971 | 09:18:31 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:53262/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53262/tests/dromaeo/cssquery-prototype.html) 09:18:32 INFO - PROCESS | 1971 | RSS: Main: 280985600 09:18:32 INFO - PROCESS | 1971 | 09:21:34 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:53262/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53262/tests/dromaeo/cssquery-yui.html) 09:21:35 INFO - PROCESS | 1971 | RSS: Main: 284110848 09:21:35 INFO - PROCESS | 1971 | 09:24:38 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:53262/tests/dromaeo/cssquery-yui.html (next: http://localhost:53262/tests/dromaeo/cssquery-dojo.html) 09:24:38 INFO - PROCESS | 1971 | RSS: Main: 284499968 09:24:38 INFO - PROCESS | 1971 | 09:24:38 INFO - PROCESS | 1971 | __start_tp_report 09:24:38 INFO - PROCESS | 1971 | _x_x_mozilla_page_load 09:24:38 INFO - PROCESS | 1971 | _x_x_mozilla_page_load_details 09:24:38 INFO - PROCESS | 1971 | |i|pagename|runs| 09:24:38 INFO - PROCESS | 1971 | |0;dojo.html;3442.3459542686887;3443.22527431328;3449.9827500862493;3481.5299934508844;3483.042163405063;4730.9053818923685;5960.64236145831;5972.641641501513;6033.1855199548045;6081.692436126237;5788.652680839153;5938.613990090641;5990.981533139366;5993.1909192259145;6059.727312270948;5344.786208551663;5373.543248823855;5395.892082158354;5472.808451704191;5532.1425179097305;5511.614187006911;5526.41972592878;5545.528630066429;5564.554835613141;5616.876624675061;5324.307839980777;5406.107992181285;5415.864603384947;5451.2640793493165;5471.097268950618;4483.6861419700635;5434.83695489132;5451.754671039773;5455.5908306877145;5471.124620060811;5309.044372013036;5375;5408.594355423359;5424.783008679648;5432.7555260013;5677.261955945701;5901.763929442817;6011.218541589609;6018.969905150446;6073;6188.257409110891;6219.87560248797;6254.3745625437095;6260.311365749764;6277.372262773732;6178.104174894615;6201.503879689659;6325.462335701471;6326;6342.778002769927;5306.946930530646;6019.036954087369;6071.483923866433;6076.969615151896;6131.509479241695;6393.1688880445245;6443.48452123829;6448.3229260927865;6454.903176452357;6456.935430645727;5093.923591146136;5756.992526307963;5934.643921364732;6105.15650299495;6191.783287584913;6263.937360626335;6293.590916590499;6306.085617585424;6315.36846315374;6330.113784070234;6136.05958347471;6149.723262453201;6235.345288744707;6247.687615619201;6300.243970723543;6152.969235153795;6197.566170368121;6261.7182226799905;6266.49868010558;6302.086197501337;5106.591472682177;5133.512316329943;5140.023395554833;5145.588352931756;5183.844484665466;4558.49856515783;4562.977185114053;4587.08258348325;4608.009278005245;4617.0996655651825;5879.147523609053;5933.970330148321;5981.850453738692;6010.068439391901;6032.969835150884;6307.022411526221;6322.71547780351;6333.68331583419;6336.366363363627;6337.841553961188;6037.396260373927;6057.091436284504;6059.272887253558;6068.029115341524;6069.2110025696375;5519.227308176858;5545.861353466195;5560.833175004756;5610.102383618601;5626.831195064155;6509.934900650933;6527.477801775942;6535.313792051861;6552.08270842092;6604.735810567619;6293.150424692791;6321.96839015802;6327.525435592441;6332.050192471166;6332.778352757631;6354.332795056453;6402.519811014099;6440.420362167428;6498.220213574212;6565.146530950946;6212.161358216764;6269.937300626935;6276.121343012073;6293.087502312231;6309.49524038085;6146.985747351637;6304.779332723333;6307.180066591313;6313.43179113882;6324.146240257691;5315.617939335723;6139.952147135157;6166.105914642262;6225.035119556476;6275.309715931336;6203.193584833943;6216.689165541615;6239.344868788712;6297.118403423616;6300.936990630035;5123.666961647481;5819.621724587888;6048.60684055535;6124.724387402666;6226.59527130735;5283.524482796567;5994.890945175157;6129.02260737745;6207.379262073757;6230.314665386713;6201.720922558406;6240.157578726996;6245.344238854855;6250.937490625036;6271.96864015677 09:24:38 INFO - PROCESS | 1971 | |1;ext.html;450.0391663797791;482.3560546670195;501.17556619361153;520.4899198785192;531.1262972410386;32030.199245018885;37862.81068594657;40094.7995260024;40106.59893401065;40192.79903600481;41135;41510.58489415105;41674.37488437676;41702;41824;9443.38617989832;9479.668211612596;9487.335886487948;9598.992105828893;9632.903670963306;9583.616655333813;9594.136527712504;9597.088276613711;9649.855252171223;9685.079917407835;9618.42289462631;9637.132658060773;9649.903500965005;9676.56455459506;9694.515274236295;9525.999770024117;9564.90435095647;9596.760080997961;9652.324337296392;9680.854787178198;9361.20429763471;9496.097870702271;9592.712218633453;9600.567974441097;9614.95192524033;38979;39294.60705392938;39296.41055384171;39323.41014884779;39345.21309573793;3459.066052165901;3567.6432356764376;3861.131245469775;4082.3672330788777;4238.766867822269;31257;31923.52114718281;32148;32503;36379.818100909324;3258.853351599184;3367.848446819899;3419.4870769384543;3429.1427143214196;3453.8100404477746;372900;485398;491658;493466;494543;52102.43692689225;60145;61050.69474652598;61959;62025;63159.10522684327;63234.36765632377;63326.0501092484;63510;63908.04137937935;15577.454789082554;15820.208989550476;15863.444779432664;15993.760093598372;16019.439319623758;12077.335746533849;12104.15270931044;12200;12222.961048310815;12409;17374.13129343528;17684.204210810545;17736;17832.91083544574;17878.28486860537;6343.651099189589;7263.89104163438;7291.489595728248;7358.337749602561;7472.775816725507;697.5047716121509;760.7945854619222;895.1540793949655;971.145392054987;983.8425851863667;27826.582601260998;30352.241193970327;30405;30450.238744031132;30566;1078.6871807175987;1081.5889961814617;1091.3670071358592;1133.9886601134049;1144;15810;15882.126483043312;15939.601509962344;15955.521334359988;16015.439459618858;663523;663961;666305;670220;671416;58428.707856460445;58580.41419585835;58843;58925.41074589199;59074.11388829171;1347.6832944258092;1381.9309034548432;1397.4549925529052;1405.3113974152795;1410.541573988458;29217.41565168727;30093;30206.54690179605;30413.543796842623;30546.541801873434;51264;51336;51388.74305628448;51832.740836295576;51990.74004630104;601618;603727;603928;604270;604750;41893.58106418897;42354.364684530374;42995.140097198506;43119.78440107779;43123;47733.52266477291;48048;48167.5183248163;49168;49206.55554111178;40022.39966400564;40097.99755006148;40177.39733904052;40670.79664601776;40929.79535102305;39208.80395598004;39793.40309895412;40296;40570.758600044195;41144;32102.876399325913;38351.23297534089;39366.80316598398;39449.80275098606;40752;32741.83629081839;35009.474857876645;35373.115672108404;35438.93683189509;35602.10994725049;22008.559828803012;25825.612615811155;25896.354922743692;26007.60988585135;26244.60633090467 09:24:38 INFO - PROCESS | 1971 | |2;jquery.html;386.34321653189585;386.34514497926017;388.62864649168455;389.4664309895444;411.07303031663594;12341.950934170607;20029.1988320467;20219;21227.257046003393;21247.25634602789;20004.89997550014;20405.28581499644;20409.183632654713;21411.430628324622;21447.927603619795;5806.129080637907;5895.64626122434;5990.700464976734;5991.161237426763;6013.098035294719;5819.388964158766;5932.673702946337;5964.612300200473;6012.96993515034;6028.698565071729;6158.907616385758;6570.441512471421;6603.141591593087;6643.103181070566;6648.4681225501845;5580.832575022736;6023.819285421422;6035.396460353973;6048.606840555394;6084.30030546484;5913.0539113742025;5917.585768996172;5991.820245392645;6022.548308876808;6025.668588227646;21719;25185.874070629714;25648.48703025929;26005.73994260052;26306.21081367562;2158.3417057797365;2222.9888850555803;2319.5592837361014;2415.6859608250816;2838.5174520331593;10144.289899707024;10212.029857163558;10268.435236062014;12769.0423218259;14732.55802325932;1875.1561797191182;1899.6105798311312;1904.5820307258077;1909.7230901519201;1942.931997380085;126895.3655231718;128522.714772852;129718;129741.35129324388;129855;8958.552072396355;9436.292278079172;9978.700638980843;10108.898911010943;11531.942340288246;11833.526658933719;12401.62795116148;12468.501259949682;12470.81293780594;12509.374531273399;7861.095973962953;8079.515229086273;8088.797780055545;8117.350611951029;8179.672813087529;7264.600446975362;7453.217412171753;7753.340966017839;8343.54110523927;8366.07973122956;3913.0804260998643;3919.980400097981;3938.7636741795586;3945.1715139820385;3952.466417033721;1658.363202508018;1972.0829814136496;1976.4861136104716;1991.3727175939823;1994.262123014494;870.3994243971639;932.4638332958576;938.9530523473799;943.8112377524523;1013;20829.479263018547;21496.78503214979;21643.67534486984;21776.782232177793;21869.234576789735;905.8143080668447;951.134120820808;972.6887396033343;995.1193194023197;998.5656239535825;9875.407475551347;10611.469426528643;10759.677209683721;11066.28069175501;11417.828732569018;596528;601272;601844;616896;617209;134374;137873;140334.2983285077;140584;140793.5920640801;1009.5255230041869;1011.4032720694826;1026.6047571685103;1028.3521381529588;1037.3775734559356;17501.47495575135;19655;20055.398338049883;20056.796592204515;20089.698654519903;54928.72535637296;56523.15215271692;56748.432515675966;57424.71287643535;57545;58219.4178058231;80582;81878.77181842396;82007.58996204981;82104.58947705223;6836.897446538405;7286.052813134259;7323.560586364835;7934.761957141295;8420.073791882765;9712.514374281116;12900.419481123185;13118.278494682883;13181;13184.670383240496;11071.667849964513;11138.554457821596;11364.488598012944;11473.483693233658;11585.6524304271;10433.843492347773;10561.947190264;10917.508712107816;11456.140789440991;11497.137714671266;9246.352755307063;11296.209265351346;11327.716807079889;11490.023348015513;11585.710357241136;8188.631511582113;8193.754187374388;8244.134365891496;8314.08545060055;8381.036180839037;8174.019117705913;10456.424896630759;11054.778904421706;11203.271787333797;11319 09:24:38 INFO - PROCESS | 1971 | |3;mootools.html;1363.4682473835205;1515.2878147270783;1720.440856721565;1846.8799528030668;1857.3127942661217;7950.64222110005;8502.914970850297;8540.871886921701;8984.820303593933;9007.144321289476;8675.73972780816;8724.694635687752;8794.736157915273;8806.251468625174;8842.071582483843;2348.600737874561;2384.7615238476187;2385.5586716457424;2386.7493913139133;2389.390705370128;2347.4718188407555;2364.598018336887;2382.1781485387514;2387.9761202387926;2389.3190440724397;2359.681443005198;2368.135630494874;2380.9166679166233;2385.821063420242;2406.795422389099;2343.425860664131;2346.272655476799;2366.3965688749345;2370.383700237942;2371.7983971362455;1961.892095934723;2316.5945959457026;2316.745158032615;2319.9652005219937;2320.431494283894;8810.207081362643;8870.556472176366;8909.465432074096;8915.509646969414;8919.910800891972;4268.935965960513;5221.738913054332;5335.093034184198;5338.412774594792;5345.812896548641;3553.6979356754705;3681.9263614727824;3684.042149041242;3703.148275896559;3706.869404831525;1081.729567608098;1097.5225776787124;1106.7122548137543;1107.385401102388;1123.9438028098562;11585.478653460614;11782.941085294604;11784.351860647661;11798.351090690008;11825.704357390961;4609.608183304456;4627.167109920179;4839.225723884161;4846.345743324606;4847.175980083394;9943.80112397748;9965.053319934595;9966.451845148586;9971.40171589707;9975.650852220137;5376.301080859464;5376.677399356051;5388.622796404293;5402.270693456333;5405.297311349499;4433.778311084433;4759.23852183649;4924.8030078797165;4937.481564435754;4944.035912997003;3302.3065156317443;3987.3819557968563;4037.031112532971;4049.858254961121;4091.8772436826944;983.6606370802061;1165.551262763842;1176.87054424015;1181.468339247342;1259.6347059352868;736.5727877830846;828.1718281718282;864.5158711121792;904.3217586809892;927.7541451515353;5564.582656300794;5791.333996590446;5811.767529298781;5853.5317174625925;5920.940790592125;413.136544621742;426.8058033594707;433.6769107015294;434.39835827378676;435.1058574629104;4022.3966405039478;4046.635802777705;4068.6541643960595;4134;4140.648044916215;8241.587920604066;10749.570017199381;10833.187510936712;10846.023857852831;10868.945655271831;10635.574577016832;10661.573537058432;10734.73163170927;10809.189310801721;10850.240483166102;8059.355251579859;8071.313938315191;8132.349412047022;8140.918590814134;8144.633491492897;5778.942210578009;5823.126531020381;5851.1515830205235;5996.610220335664;6055.3944605540855;9875.604975800887;9976;10025.197984161396;10026.248031397528;10117.392956422638;8744.344174187088;10281;10361.326513776581;10378.481075946323;10445.634402795866;6897.931020689729;7529.661165247468;7606.277403646644;7934.880976785237;8293.917060829315;8290.87563686533;8376.99476062852;8469.78825529342;8476.915230847859;8490.745277641434;7332.230115837973;7524.322810947041;7551.282628150317;7572.432067594842;7604.087509498895;7346.7061317546695;7437.51656142349;7442.4790264683115;7467.290607392289;7478.140013898471;7054.506184567031;7098.041764361745;7101.715931362688;7111.040009598638;7111.466640002124;4276.615104640598;4894.363732714866;5059.443461219189;5101.132807422673;5125;5118.206677964921;5123.257127716386;5177.171652535576;5187.118189907649;5275.947240527546 09:24:38 INFO - PROCESS | 1971 | |4;prototype.html;312.4656836809056;316.06287357983575;319.3580902386203;319.9120241933469;322.9208843833261;4473.552644735525;4509.864704058883;5488.1493368527845;5538.723063846806;5738.827835164947;4266.914661706772;4354.869353919387;4639.559241872025;5070.884405430799;5684.602077854552;3805.059419695961;4044.2518134145275;4091.263572556946;4199.202151591188;4266;4068.6401886905674;4236.851710190144;4293.56165684496;4307.67692423068;4338.869833904988;3183.7612179086545;3880.5343358796986;4278.165757677254;4284.850030248942;4298.161858437606;3418.9658103418897;4266.338717498793;4289.935650965238;4290.227759003378;4320.97839510802;2754.036087369425;3029.0458505570673;3606.963930360689;3711.4247291669835;3730.5336832895887;4526.524714904954;4555.840545580922;5510.752016159283;5512.145617429305;5552.666839989613;4131.3887583842325;4681.602063824579;4692.7653617319;4913.729744864031;4917.360743103373;5332.760025798849;5441.2587971849025;5888.852778680524;5938.524918006549;5938.565188272787;4104.733192342488;4110.34234522478;4111.9177616447805;4127.380892866064;4235.2588297048205;4950.975245123751;5817.331006934172;6189.257289125334;6276.843078923018;6297.0554416837385;3561.786292822439;3598.1004748812798;3983.48214732083;3995.980020099939;4015.8795236142964;3497.213127046394;4083;4115.938260926088;4126.607972242632;4132;3869.941950870739;4421.828215522889;4477.462704475419;4829.420469543677;4841.927371089366;5257.973710131425;5363.077122967992;5566.053770858964;5979.77092370124;5981.581289309706;1159.8318243854594;1465.728840164573;1470.7351677557292;1471;1475.7786332050277;728.0644371981978;904.6159376154494;913.5386629752065;923.1368670293298;965.2673451155193;4555.886102847389;5217.295665085241;5332.466753324637;5375.569954403638;5448.50166204297;5951.880962380815;5980;5993.9700301498215;6011.549133814981;6014.51883849291;5186.444066780026;5406.270153529302;5418;5629.746661400247;5634.7182640867795;2861.9427611447654;3099.6745341739243;3235.2073741933377;3254.7396208303753;3258.5600943872746;5379.973100134553;5649.548036157097;5663.631863928831;6055.364186760415;6406.807795766134;5127.974360128175;5751.942480575224;6338.778142764981;6344.238691356974;6370.77702280418;5887.734137160617;5938.287405511366;5970;6426.678666066771;6441.452476539453;5080.974595127001;5792.3917988612275;6129.662868542095;6171.074338849208;6236.844078898064;5213.973930130325;5691.918535478246;5725.685087320071;6022.337542870368;6075.483583895241;5324.254604355316;5870.354261031198;6164.876702466016;6287.71705273273;6423.389777971085;3460.4982277569106;3951.9407208891316;3965.9688480994573;4001;4012.6589239913765;4889.462159162418;5600.551955843604;5625.424881033317;6083.726232319645;6102.511799056154;5100.515451032146;5135.765941815323;5538.944610553843;5936.762529498945;6004.438845900185;5448.482394172547;5982.295045912068;5983.162357269899;5999.940000599938;6024.638521688713;4606.834787649799;5309.814156504503;5782.3639399666845;5877.471027607536;5885.588008839341;4439.934415740264;5523.116301391758;5929.288485381781;5949.464548190684;5949.553783466171;4838.129136755277;4868.80524779019;5756.2229099072765;5816.680082595498;5858.853528661817 09:24:38 INFO - PROCESS | 1971 | |5;yui.html;689.937905588497;724.9565026098431;755.2523002227796;770.9036370453691;804.9315808156307;11933.343666098372;14364.640883977905;15477.690446191084;15485.845141548582;15520.922395388021;14132.152070875754;14228.359723812428;14228.786568201485;14263.928680356583;15527.378904843792;846.3229416466833;868.5266529741306;869.952152631605;871.4901782457239;872.1714371347246;837.5979529825687;854.9914500855006;864.3733293362325;867.1458613265928;873.253368370044;896.0680891872445;903.4534106865318;903.5121034641319;905.4702998745709;907.0838453162321;864.8356812205724;891.9554022298859;895.0959530873831;898.4833720610642;899.3479727197795;660.3231687520282;663.7013343995221;666.8332916770808;667.7629441548278;668.588817877007;15152.31814568347;15252.618684532976;15269.694606107816;15276.465323713728;15334.76997845022;13894;14114.92942535291;14128.081674691111;14379.281035948265;14622.415103395851;9703.854442183372;11946.701332466759;11970.82043769344;12099.87900121005;12436.823555877685;3849.3648547989546;3867.9806600966817;3881.6506514413836;3886.5336159661024;4007;81436;89145;93569;115900;116893.83106168914;10753.78492430147;10937.234393592531;11010.339379637247;11014.284071535325;11023.503942322615;22257.109715611194;22279.665805012937;22280.77719222787;22291.888540557517;22301.665475017886;8054.798630034296;8124.837503249902;8182.795430114175;8192.30365418946;8323.500589964622;4046.615571520701;4528.977355113203;4542.795574199169;4640.466346370211;4812.109759694467;3455.274392377579;3516.3143187078786;3539.132912436418;3599.5500562429697;3602.873899413508;662.4766434516678;676.8680107379113;680.3536640191837;682.969266383014;693.1543516909362;581.2850194260998;630.5271046714964;635.9443324082001;642.7461152844601;695.8692125296393;9006.715663939574;9586.137247647745;9588;9602.807943841224;9654.565544550513;635.6758053392803;650.3756393861851;674.3324109132022;677.8813707601249;686.3856848121004;4476.306172543261;4692.601128904013;4747.83382581608;4949.628777841676;5033.219850923039;143687;155196;161054;166011;166185;77049.84425233626;79824;80085.19914800893;101636;105933;78352;98394.01605983848;100062.99937000537;103177.48411257895;103261;9804.068613481993;9823.950880245553;9982.650607229003;10015.14871235953;10042.297039207186;57537.712311438176;57682.423175767704;57715.711421442626;58175.12737308859;59636.403635963085;85639.71540426774;87713.56143219244;90347;94485.05514945037;96175;13011.414486347947;13226.140300880412;13226.47094116263;13251.469941202244;13893.444262229801;14990.47533336328;15259.771103433679;15285.388584456497;15734.606634834221;15751.976121552063;13987.580372588838;14021.929890350482;14353.353835758548;14385.352659130574;14537.636559086108;13505;13527.594172174851;13555.728885422039;13741.793873091712;13962.162270263816;11318.94340528292;13637.931810340884;13718.245496497788;14115.7221478505;14348.282585870873;9117.680881169128;11285.548578057114;11547.480363383836;11673.340975292638;11857.940710296738;11192.720181995515;11412;11542.19204655666;11645.76708465843;11752.412379381169 09:24:38 INFO - PROCESS | 1971 | __end_tp_report 09:24:38 INFO - PROCESS | 1971 | __start_cc_report 09:24:38 INFO - PROCESS | 1971 | _x_x_mozilla_cycle_collect,437 09:24:38 INFO - PROCESS | 1971 | __end_cc_report 09:24:38 INFO - PROCESS | 1971 | __startTimestamp1467303878648__endTimestamp 09:24:38 INFO - PROCESS | 1971 | 09:24:38 INFO - PROCESS | 1971 | ------- Summary: start ------- 09:24:38 INFO - PROCESS | 1971 | Number of tests: 6 09:24:38 INFO - PROCESS | 1971 | 09:24:38 INFO - PROCESS | 1971 | [#0] dojo.html Cycles:165 Average:5862.77 Median:6081.69 stddev:637.32 (10.5%) stddev-sans-first:610.33 09:24:38 INFO - PROCESS | 1971 | Values: 3442.3 3443.2 3450.0 3481.5 3483.0 4730.9 5960.6 5972.6 6033.2 6081.7 5788.7 5938.6 5991.0 5993.2 6059.7 5344.8 5373.5 5395.9 5472.8 5532.1 5511.6 5526.4 5545.5 5564.6 5616.9 5324.3 5406.1 5415.9 5451.3 5471.1 4483.7 5434.8 5451.8 5455.6 5471.1 5309.0 5375.0 5408.6 5424.8 5432.8 5677.3 5901.8 6011.2 6019.0 6073.0 6188.3 6219.9 6254.4 6260.3 6277.4 6178.1 6201.5 6325.5 6326.0 6342.8 5306.9 6019.0 6071.5 6077.0 6131.5 6393.2 6443.5 6448.3 6454.9 6456.9 5093.9 5757.0 5934.6 6105.2 6191.8 6263.9 6293.6 6306.1 6315.4 6330.1 6136.1 6149.7 6235.3 6247.7 6300.2 6153.0 6197.6 6261.7 6266.5 6302.1 5106.6 5133.5 5140.0 5145.6 5183.8 4558.5 4563.0 4587.1 4608.0 4617.1 5879.1 5934.0 5981.9 6010.1 6033.0 6307.0 6322.7 6333.7 6336.4 6337.8 6037.4 6057.1 6059.3 6068.0 6069.2 5519.2 5545.9 5560.8 5610.1 5626.8 6509.9 6527.5 6535.3 6552.1 6604.7 6293.2 6322.0 6327.5 6332.1 6332.8 6354.3 6402.5 6440.4 6498.2 6565.1 6212.2 6269.9 6276.1 6293.1 6309.5 6147.0 6304.8 6307.2 6313.4 6324.1 5315.6 6140.0 6166.1 6225.0 6275.3 6203.2 6216.7 6239.3 6297.1 6300.9 5123.7 5819.6 6048.6 6124.7 6226.6 5283.5 5994.9 6129.0 6207.4 6230.3 6201.7 6240.2 6245.3 6250.9 6272.0 09:24:38 INFO - PROCESS | 1971 | 09:24:38 INFO - PROCESS | 1971 | [#1] ext.html Cycles:180 Average:71692.02 Median:41327.29 stddev:156677.39 (379.1%) stddev-sans-first:157025.61 09:24:38 INFO - PROCESS | 1971 | Values: 450.0 482.4 501.2 520.5 531.1 32030.2 37862.8 40094.8 40106.6 40192.8 41135.0 41510.6 41674.4 41702.0 41824.0 9443.4 9479.7 9487.3 9599.0 9632.9 9583.6 9594.1 9597.1 9649.9 9685.1 9618.4 9637.1 9649.9 9676.6 9694.5 9526.0 9564.9 9596.8 9652.3 9680.9 9361.2 9496.1 9592.7 9600.6 9615.0 38979.0 39294.6 39296.4 39323.4 39345.2 3459.1 3567.6 3861.1 4082.4 4238.8 31257.0 31923.5 32148.0 32503.0 36379.8 3258.9 3367.8 3419.5 3429.1 3453.8 372900.0 485398.0 491658.0 493466.0 494543.0 52102.4 60145.0 61050.7 61959.0 62025.0 63159.1 63234.4 63326.1 63510.0 63908.0 15577.5 15820.2 15863.4 15993.8 16019.4 12077.3 12104.2 12200.0 12223.0 12409.0 17374.1 17684.2 17736.0 17832.9 17878.3 6343.7 7263.9 7291.5 7358.3 7472.8 697.5 760.8 895.2 971.1 983.8 27826.6 30352.2 30405.0 30450.2 30566.0 1078.7 1081.6 1091.4 1134.0 1144.0 15810.0 15882.1 15939.6 15955.5 16015.4 663523.0 663961.0 666305.0 670220.0 671416.0 58428.7 58580.4 58843.0 58925.4 59074.1 1347.7 1381.9 1397.5 1405.3 1410.5 29217.4 30093.0 30206.5 30413.5 30546.5 51264.0 51336.0 51388.7 51832.7 51990.7 601618.0 603727.0 603928.0 604270.0 604750.0 41893.6 42354.4 42995.1 43119.8 43123.0 47733.5 48048.0 48167.5 49168.0 49206.6 40022.4 40098.0 40177.4 40670.8 40929.8 39208.8 39793.4 40296.0 40570.8 41144.0 32102.9 38351.2 39366.8 39449.8 40752.0 32741.8 35009.5 35373.1 35438.9 35602.1 22008.6 25825.6 25896.4 26007.6 26244.6 09:24:38 INFO - PROCESS | 1971 | 09:24:38 INFO - PROCESS | 1971 | [#2] jquery.html Cycles:180 Average:35838.84 Median:25827.11 stddev:101797.11 (394.1%) stddev-sans-first:102047.87 09:24:38 INFO - PROCESS | 1971 | Values: 386.3 386.3 388.6 389.5 411.1 12342.0 20029.2 20219.0 21227.3 21247.3 20004.9 20405.3 20409.2 21411.4 21447.9 5806.1 5895.6 5990.7 5991.2 6013.1 5819.4 5932.7 5964.6 6013.0 6028.7 6158.9 6570.4 6603.1 6643.1 6648.5 5580.8 6023.8 6035.4 6048.6 6084.3 5913.1 5917.6 5991.8 6022.5 6025.7 21719.0 25185.9 25648.5 26005.7 26306.2 2158.3 2223.0 2319.6 2415.7 2838.5 10144.3 10212.0 10268.4 12769.0 14732.6 1875.2 1899.6 1904.6 1909.7 1942.9 126895.4 128522.7 129718.0 129741.4 129855.0 8958.6 9436.3 9978.7 10108.9 11531.9 11833.5 12401.6 12468.5 12470.8 12509.4 7861.1 8079.5 8088.8 8117.4 8179.7 7264.6 7453.2 7753.3 8343.5 8366.1 3913.1 3920.0 3938.8 3945.2 3952.5 1658.4 1972.1 1976.5 1991.4 1994.3 870.4 932.5 939.0 943.8 1013.0 20829.5 21496.8 21643.7 21776.8 21869.2 905.8 951.1 972.7 995.1 998.6 9875.4 10611.5 10759.7 11066.3 11417.8 596528.0 601272.0 601844.0 616896.0 617209.0 134374.0 137873.0 140334.3 140584.0 140793.6 1009.5 1011.4 1026.6 1028.4 1037.4 17501.5 19655.0 20055.4 20056.8 20089.7 54928.7 56523.2 56748.4 57424.7 57545.0 58219.4 80582.0 81878.8 82007.6 82104.6 6836.9 7286.1 7323.6 7934.8 8420.1 9712.5 12900.4 13118.3 13181.0 13184.7 11071.7 11138.6 11364.5 11473.5 11585.7 10433.8 10561.9 10917.5 11456.1 11497.1 9246.4 11296.2 11327.7 11490.0 11585.7 8188.6 8193.8 8244.1 8314.1 8381.0 8174.0 10456.4 11054.8 11203.3 11319.0 09:24:38 INFO - PROCESS | 1971 | 09:24:38 INFO - PROCESS | 1971 | [#3] mootools.html Cycles:180 Average:5713.25 Median:4931.14 stddev:3228.92 (65.5%) stddev-sans-first:3221.43 09:24:38 INFO - PROCESS | 1971 | Values: 1363.5 1515.3 1720.4 1846.9 1857.3 7950.6 8502.9 8540.9 8984.8 9007.1 8675.7 8724.7 8794.7 8806.3 8842.1 2348.6 2384.8 2385.6 2386.7 2389.4 2347.5 2364.6 2382.2 2388.0 2389.3 2359.7 2368.1 2380.9 2385.8 2406.8 2343.4 2346.3 2366.4 2370.4 2371.8 1961.9 2316.6 2316.7 2320.0 2320.4 8810.2 8870.6 8909.5 8915.5 8919.9 4268.9 5221.7 5335.1 5338.4 5345.8 3553.7 3681.9 3684.0 3703.1 3706.9 1081.7 1097.5 1106.7 1107.4 1123.9 11585.5 11782.9 11784.4 11798.4 11825.7 4609.6 4627.2 4839.2 4846.3 4847.2 9943.8 9965.1 9966.5 9971.4 9975.7 5376.3 5376.7 5388.6 5402.3 5405.3 4433.8 4759.2 4924.8 4937.5 4944.0 3302.3 3987.4 4037.0 4049.9 4091.9 983.7 1165.6 1176.9 1181.5 1259.6 736.6 828.2 864.5 904.3 927.8 5564.6 5791.3 5811.8 5853.5 5920.9 413.1 426.8 433.7 434.4 435.1 4022.4 4046.6 4068.7 4134.0 4140.6 8241.6 10749.6 10833.2 10846.0 10868.9 10635.6 10661.6 10734.7 10809.2 10850.2 8059.4 8071.3 8132.3 8140.9 8144.6 5778.9 5823.1 5851.2 5996.6 6055.4 9875.6 9976.0 10025.2 10026.2 10117.4 8744.3 10281.0 10361.3 10378.5 10445.6 6897.9 7529.7 7606.3 7934.9 8293.9 8290.9 8377.0 8469.8 8476.9 8490.7 7332.2 7524.3 7551.3 7572.4 7604.1 7346.7 7437.5 7442.5 7467.3 7478.1 7054.5 7098.0 7101.7 7111.0 7111.5 4276.6 4894.4 5059.4 5101.1 5125.0 5118.2 5123.3 5177.2 5187.1 5275.9 09:24:38 INFO - PROCESS | 1971 | 09:24:38 INFO - PROCESS | 1971 | [#4] prototype.html Cycles:180 Average:4685.31 Median:5215.63 stddev:1468.13 (28.1%) stddev-sans-first:1435.09 09:24:38 INFO - PROCESS | 1971 | Values: 312.5 316.1 319.4 319.9 322.9 4473.6 4509.9 5488.1 5538.7 5738.8 4266.9 4354.9 4639.6 5070.9 5684.6 3805.1 4044.3 4091.3 4199.2 4266.0 4068.6 4236.9 4293.6 4307.7 4338.9 3183.8 3880.5 4278.2 4284.9 4298.2 3419.0 4266.3 4289.9 4290.2 4321.0 2754.0 3029.0 3607.0 3711.4 3730.5 4526.5 4555.8 5510.8 5512.1 5552.7 4131.4 4681.6 4692.8 4913.7 4917.4 5332.8 5441.3 5888.9 5938.5 5938.6 4104.7 4110.3 4111.9 4127.4 4235.3 4951.0 5817.3 6189.3 6276.8 6297.1 3561.8 3598.1 3983.5 3996.0 4015.9 3497.2 4083.0 4115.9 4126.6 4132.0 3869.9 4421.8 4477.5 4829.4 4841.9 5258.0 5363.1 5566.1 5979.8 5981.6 1159.8 1465.7 1470.7 1471.0 1475.8 728.1 904.6 913.5 923.1 965.3 4555.9 5217.3 5332.5 5375.6 5448.5 5951.9 5980.0 5994.0 6011.5 6014.5 5186.4 5406.3 5418.0 5629.7 5634.7 2861.9 3099.7 3235.2 3254.7 3258.6 5380.0 5649.5 5663.6 6055.4 6406.8 5128.0 5751.9 6338.8 6344.2 6370.8 5887.7 5938.3 5970.0 6426.7 6441.5 5081.0 5792.4 6129.7 6171.1 6236.8 5214.0 5691.9 5725.7 6022.3 6075.5 5324.3 5870.4 6164.9 6287.7 6423.4 3460.5 3951.9 3966.0 4001.0 4012.7 4889.5 5600.6 5625.4 6083.7 6102.5 5100.5 5135.8 5538.9 5936.8 6004.4 5448.5 5982.3 5983.2 5999.9 6024.6 4606.8 5309.8 5782.4 5877.5 5885.6 4439.9 5523.1 5929.3 5949.5 5949.6 4838.1 4868.8 5756.2 5816.7 5858.9 09:24:38 INFO - PROCESS | 1971 | 09:24:38 INFO - PROCESS | 1971 | [#5] yui.html Cycles:180 Average:23324.80 Median:3946.77 stddev:36614.81 (927.7%) stddev-sans-first:36678.08 09:24:38 INFO - PROCESS | 1971 | Values: 689.9 725.0 755.3 770.9 804.9 11933.3 14364.6 15477.7 15485.8 15520.9 14132.2 14228.4 14228.8 14263.9 15527.4 846.3 868.5 870.0 871.5 872.2 837.6 855.0 864.4 867.1 873.3 896.1 903.5 903.5 905.5 907.1 864.8 892.0 895.1 898.5 899.3 660.3 663.7 666.8 667.8 668.6 15152.3 15252.6 15269.7 15276.5 15334.8 13894.0 14114.9 14128.1 14379.3 14622.4 9703.9 11946.7 11970.8 12099.9 12436.8 3849.4 3868.0 3881.7 3886.5 4007.0 81436.0 89145.0 93569.0 115900.0 116893.8 10753.8 10937.2 11010.3 11014.3 11023.5 22257.1 22279.7 22280.8 22291.9 22301.7 8054.8 8124.8 8182.8 8192.3 8323.5 4046.6 4529.0 4542.8 4640.5 4812.1 3455.3 3516.3 3539.1 3599.6 3602.9 662.5 676.9 680.4 683.0 693.2 581.3 630.5 635.9 642.7 695.9 9006.7 9586.1 9588.0 9602.8 9654.6 635.7 650.4 674.3 677.9 686.4 4476.3 4692.6 4747.8 4949.6 5033.2 143687.0 155196.0 161054.0 166011.0 166185.0 77049.8 79824.0 80085.2 101636.0 105933.0 78352.0 98394.0 100063.0 103177.5 103261.0 9804.1 9824.0 9982.7 10015.1 10042.3 57537.7 57682.4 57715.7 58175.1 59636.4 85639.7 87713.6 90347.0 94485.1 96175.0 13011.4 13226.1 13226.5 13251.5 13893.4 14990.5 15259.8 15285.4 15734.6 15752.0 13987.6 14021.9 14353.4 14385.4 14537.6 13505.0 13527.6 13555.7 13741.8 13962.2 11318.9 13637.9 13718.2 14115.7 14348.3 9117.7 11285.5 11547.5 11673.3 11857.9 11192.7 11412.0 11542.2 11645.8 11752.4 09:24:38 INFO - PROCESS | 1971 | -------- Summary: end -------- 09:24:38 INFO - PROCESS | 1971 | 09:24:39 INFO - TEST-INFO | 1971: exit 0 09:24:39 INFO - TEST-OK | dromaeo_css | took 1114377ms 09:24:39 INFO - TEST-START | kraken 09:24:39 INFO - operating with platform_type : mac_ 09:24:39 INFO - Initialising browser for kraken test... 09:24:39 INFO - TEST-INFO | started process 1976 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/tmpvd6Rfv/profile http://localhost:53262/getInfo.html) 09:24:42 INFO - PROCESS | 1976 | __metrics Screen width/height:1600/1200 09:24:42 INFO - PROCESS | 1976 | colorDepth:24 09:24:42 INFO - PROCESS | 1976 | Browser inner width/height: 1024/689 09:24:42 INFO - PROCESS | 1976 | __metrics 09:24:42 ERROR - PROCESS | 1976 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 09:24:42 INFO - TEST-INFO | 1976: exit 0 09:24:42 INFO - Browser initialized. 09:24:42 INFO - Running cycle 1/1 for kraken test... 09:24:42 INFO - TEST-INFO | started process 1978 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/tmpvd6Rfv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:24:54 INFO - PROCESS | 1978 | RSS: Main: 255717376 09:24:54 INFO - PROCESS | 1978 | 09:24:57 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:53262/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53262/tests/kraken/driver.html?testName=audio-beat-detection) 09:24:58 INFO - PROCESS | 1978 | RSS: Main: 268513280 09:24:58 INFO - PROCESS | 1978 | 09:25:01 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:53262/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53262/tests/kraken/driver.html?testName=audio-dft) 09:25:01 INFO - PROCESS | 1978 | RSS: Main: 272572416 09:25:01 INFO - PROCESS | 1978 | 09:25:05 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:53262/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53262/tests/kraken/driver.html?testName=audio-fft) 09:25:05 INFO - PROCESS | 1978 | RSS: Main: 273043456 09:25:05 INFO - PROCESS | 1978 | 09:25:07 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:53262/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53262/tests/kraken/driver.html?testName=audio-oscillator) 09:25:08 INFO - PROCESS | 1978 | RSS: Main: 274038784 09:25:08 INFO - PROCESS | 1978 | 09:25:10 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:53262/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53262/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:25:11 INFO - PROCESS | 1978 | RSS: Main: 274550784 09:25:11 INFO - PROCESS | 1978 | 09:25:13 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:53262/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53262/tests/kraken/driver.html?testName=imaging-darkroom) 09:25:14 INFO - PROCESS | 1978 | RSS: Main: 275427328 09:25:14 INFO - PROCESS | 1978 | 09:25:17 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:53262/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53262/tests/kraken/driver.html?testName=imaging-desaturate) 09:25:18 INFO - PROCESS | 1978 | RSS: Main: 275554304 09:25:18 INFO - PROCESS | 1978 | 09:25:20 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:53262/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53262/tests/kraken/driver.html?testName=json-parse-financial) 09:25:21 INFO - PROCESS | 1978 | RSS: Main: 275869696 09:25:21 INFO - PROCESS | 1978 | 09:25:23 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:53262/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53262/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:25:23 INFO - PROCESS | 1978 | RSS: Main: 275636224 09:25:23 INFO - PROCESS | 1978 | 09:25:25 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:53262/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53262/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:25:26 INFO - PROCESS | 1978 | RSS: Main: 275476480 09:25:26 INFO - PROCESS | 1978 | 09:25:28 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:53262/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53262/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:25:29 INFO - PROCESS | 1978 | RSS: Main: 275480576 09:25:29 INFO - PROCESS | 1978 | 09:25:31 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:53262/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:25:32 INFO - PROCESS | 1978 | RSS: Main: 275533824 09:25:32 INFO - PROCESS | 1978 | 09:25:35 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:53262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:25:36 INFO - PROCESS | 1978 | RSS: Main: 275464192 09:25:36 INFO - PROCESS | 1978 | 09:25:37 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:53262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53262/tests/kraken/driver.html?testName=ai-astar) 09:25:38 INFO - PROCESS | 1978 | RSS: Main: 276520960 09:25:38 INFO - PROCESS | 1978 | 09:25:38 INFO - PROCESS | 1978 | __start_tp_report 09:25:38 INFO - PROCESS | 1978 | _x_x_mozilla_page_load 09:25:38 INFO - PROCESS | 1978 | _x_x_mozilla_page_load_details 09:25:38 INFO - PROCESS | 1978 | |i|pagename|runs| 09:25:38 INFO - PROCESS | 1978 | |0;ai-astar;137;172;142;115;117;114;114;116;127;167 09:25:38 INFO - PROCESS | 1978 | |1;audio-beat-detection;148;106;133;154;109;128;128;108;175;144 09:25:38 INFO - PROCESS | 1978 | |2;audio-dft;171;273;265;239;199;201;195;202;199;194 09:25:38 INFO - PROCESS | 1978 | |3;audio-fft;72;83;78;149;59;57;57;64;133;61 09:25:38 INFO - PROCESS | 1978 | |4;audio-oscillator;71;73;121;72;73;83;116;70;72;122 09:25:38 INFO - PROCESS | 1978 | |5;imaging-gaussian-blur;87;89;88;95;89;85;88;90;127;85 09:25:38 INFO - PROCESS | 1978 | |6;imaging-darkroom;92;94;111;95;95;94;121;133;149;150 09:25:38 INFO - PROCESS | 1978 | |7;imaging-desaturate;90;96;89;89;92;89;91;90;91;90 09:25:38 INFO - PROCESS | 1978 | |8;json-parse-financial;56;55;54;56;57;58;59;57;57;56 09:25:38 INFO - PROCESS | 1978 | |9;json-stringify-tinderbox;68;79;68;74;78;77;77;69;74;71 09:25:38 INFO - PROCESS | 1978 | |10;stanford-crypto-aes;96;102;94;84;82;81;89;86;87;88 09:25:38 INFO - PROCESS | 1978 | |11;stanford-crypto-ccm;129;136;150;147;144;151;137;136;179;139 09:25:38 INFO - PROCESS | 1978 | |12;stanford-crypto-pbkdf2;170;168;169;169;186;227;215;168;166;171 09:25:38 INFO - PROCESS | 1978 | |13;stanford-crypto-sha256-iterative;68;67;66;65;70;67;66;69;67;67 09:25:38 INFO - PROCESS | 1978 | __end_tp_report 09:25:38 INFO - PROCESS | 1978 | __start_cc_report 09:25:38 INFO - PROCESS | 1978 | _x_x_mozilla_cycle_collect,1113 09:25:38 INFO - PROCESS | 1978 | __end_cc_report 09:25:38 INFO - PROCESS | 1978 | __startTimestamp1467303938114__endTimestamp 09:25:38 INFO - PROCESS | 1978 | 09:25:38 INFO - PROCESS | 1978 | ------- Summary: start ------- 09:25:38 INFO - PROCESS | 1978 | Number of tests: 14 09:25:38 INFO - PROCESS | 1978 | 09:25:38 INFO - PROCESS | 1978 | [#0] ai-astar Cycles:10 Average:132.10 Median:132.00 stddev:22.09 (16.7%) stddev-sans-first:23.36 09:25:38 INFO - PROCESS | 1978 | Values: 137.0 172.0 142.0 115.0 117.0 114.0 114.0 116.0 127.0 167.0 09:25:38 INFO - PROCESS | 1978 | 09:25:38 INFO - PROCESS | 1978 | [#1] audio-beat-detection Cycles:10 Average:133.30 Median:138.50 stddev:22.44 (16.2%) stddev-sans-first:23.16 09:25:38 INFO - PROCESS | 1978 | Values: 148.0 106.0 133.0 154.0 109.0 128.0 128.0 108.0 175.0 144.0 09:25:38 INFO - PROCESS | 1978 | 09:25:38 INFO - PROCESS | 1978 | [#2] audio-dft Cycles:10 Average:213.80 Median:201.50 stddev:33.47 (16.6%) stddev-sans-first:31.71 09:25:38 INFO - PROCESS | 1978 | Values: 171.0 273.0 265.0 239.0 199.0 201.0 195.0 202.0 199.0 194.0 09:25:38 INFO - PROCESS | 1978 | 09:25:38 INFO - PROCESS | 1978 | [#3] audio-fft Cycles:10 Average:81.30 Median:62.50 stddev:32.91 (52.7%) stddev-sans-first:34.73 09:25:38 INFO - PROCESS | 1978 | Values: 72.0 83.0 78.0 149.0 59.0 57.0 57.0 64.0 133.0 61.0 09:25:38 INFO - PROCESS | 1978 | 09:25:38 INFO - PROCESS | 1978 | [#4] audio-oscillator Cycles:10 Average:87.30 Median:72.00 stddev:22.67 (31.5%) stddev-sans-first:23.26 09:25:38 INFO - PROCESS | 1978 | Values: 71.0 73.0 121.0 72.0 73.0 83.0 116.0 70.0 72.0 122.0 09:25:38 INFO - PROCESS | 1978 | 09:25:38 INFO - PROCESS | 1978 | [#5] imaging-gaussian-blur Cycles:10 Average:92.30 Median:88.50 stddev:12.52 (14.1%) stddev-sans-first:13.13 09:25:38 INFO - PROCESS | 1978 | Values: 87.0 89.0 88.0 95.0 89.0 85.0 88.0 90.0 127.0 85.0 09:25:38 INFO - PROCESS | 1978 | 09:25:38 INFO - PROCESS | 1978 | [#6] imaging-darkroom Cycles:10 Average:113.40 Median:93.00 stddev:23.43 (25.2%) stddev-sans-first:23.54 09:25:38 INFO - PROCESS | 1978 | Values: 92.0 94.0 111.0 95.0 95.0 94.0 121.0 133.0 149.0 150.0 09:25:38 INFO - PROCESS | 1978 | 09:25:38 INFO - PROCESS | 1978 | [#7] imaging-desaturate Cycles:10 Average:90.70 Median:90.50 stddev:2.11 (2.3%) stddev-sans-first:2.22 09:25:38 INFO - PROCESS | 1978 | Values: 90.0 96.0 89.0 89.0 92.0 89.0 91.0 90.0 91.0 90.0 09:25:38 INFO - PROCESS | 1978 | 09:25:38 INFO - PROCESS | 1978 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:57.00 stddev:1.43 (2.5%) stddev-sans-first:1.51 09:25:38 INFO - PROCESS | 1978 | Values: 56.0 55.0 54.0 56.0 57.0 58.0 59.0 57.0 57.0 56.0 09:25:38 INFO - PROCESS | 1978 | 09:25:38 INFO - PROCESS | 1978 | [#9] json-stringify-tinderbox Cycles:10 Average:73.50 Median:75.50 stddev:4.25 (5.6%) stddev-sans-first:4.01 09:25:38 INFO - PROCESS | 1978 | Values: 68.0 79.0 68.0 74.0 78.0 77.0 77.0 69.0 74.0 71.0 09:25:38 INFO - PROCESS | 1978 | 09:25:38 INFO - PROCESS | 1978 | [#10] stanford-crypto-aes Cycles:10 Average:88.90 Median:87.50 stddev:6.62 (7.6%) stddev-sans-first:6.51 09:25:38 INFO - PROCESS | 1978 | Values: 96.0 102.0 94.0 84.0 82.0 81.0 89.0 86.0 87.0 88.0 09:25:38 INFO - PROCESS | 1978 | 09:25:38 INFO - PROCESS | 1978 | [#11] stanford-crypto-ccm Cycles:10 Average:144.80 Median:145.50 stddev:13.90 (9.6%) stddev-sans-first:13.52 09:25:38 INFO - PROCESS | 1978 | Values: 129.0 136.0 150.0 147.0 144.0 151.0 137.0 136.0 179.0 139.0 09:25:38 INFO - PROCESS | 1978 | 09:25:38 INFO - PROCESS | 1978 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.90 Median:170.50 stddev:22.03 (12.9%) stddev-sans-first:23.01 09:25:38 INFO - PROCESS | 1978 | Values: 170.0 168.0 169.0 169.0 186.0 227.0 215.0 168.0 166.0 171.0 09:25:38 INFO - PROCESS | 1978 | 09:25:38 INFO - PROCESS | 1978 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:1.48 (2.2%) stddev-sans-first:1.54 09:25:38 INFO - PROCESS | 1978 | Values: 68.0 67.0 66.0 65.0 70.0 67.0 66.0 69.0 67.0 67.0 09:25:38 INFO - PROCESS | 1978 | -------- Summary: end -------- 09:25:38 INFO - PROCESS | 1978 | 09:25:38 INFO - TEST-INFO | 1978: exit 0 09:25:38 INFO - TEST-OK | kraken | took 59583ms 09:25:38 INFO - SUITE-END | took 1173s 09:25:39 INFO - Completed test suite (00:19:34) 09:25:39 INFO - javascript benchmark 09:25:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7427.079359745353, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3442.3459542686887, 3443.22527431328, 3449.9827500862493, 3481.5299934508844, 3483.042163405063, 4730.9053818923685, 5960.64236145831, 5972.641641501513, 6033.1855199548045, 6081.692436126237, 5788.652680839153, 5938.613990090641, 5990.981533139366, 5993.1909192259145, 6059.727312270948, 5344.786208551663, 5373.543248823855, 5395.892082158354, 5472.808451704191, 5532.1425179097305, 5511.614187006911, 5526.41972592878, 5545.528630066429, 5564.554835613141, 5616.876624675061, 5324.307839980777, 5406.107992181285, 5415.864603384947, 5451.2640793493165, 5471.097268950618, 4483.6861419700635, 5434.83695489132, 5451.754671039773, 5455.5908306877145, 5471.124620060811, 5309.044372013036, 5375.0, 5408.594355423359, 5424.783008679648, 5432.7555260013, 5677.261955945701, 5901.763929442817, 6011.218541589609, 6018.969905150446, 6073.0, 6188.257409110891, 6219.87560248797, 6254.3745625437095, 6260.311365749764, 6277.372262773732, 6178.104174894615, 6201.503879689659, 6325.462335701471, 6326.0, 6342.778002769927, 5306.946930530646, 6019.036954087369, 6071.483923866433, 6076.969615151896, 6131.509479241695, 6393.1688880445245, 6443.48452123829, 6448.3229260927865, 6454.903176452357, 6456.935430645727, 5093.923591146136, 5756.992526307963, 5934.643921364732, 6105.15650299495, 6191.783287584913, 6263.937360626335, 6293.590916590499, 6306.085617585424, 6315.36846315374, 6330.113784070234, 6136.05958347471, 6149.723262453201, 6235.345288744707, 6247.687615619201, 6300.243970723543, 6152.969235153795, 6197.566170368121, 6261.7182226799905, 6266.49868010558, 6302.086197501337, 5106.591472682177, 5133.512316329943, 5140.023395554833, 5145.588352931756, 5183.844484665466, 4558.49856515783, 4562.977185114053, 4587.08258348325, 4608.009278005245, 4617.0996655651825, 5879.147523609053, 5933.970330148321, 5981.850453738692, 6010.068439391901, 6032.969835150884, 6307.022411526221, 6322.71547780351, 6333.68331583419, 6336.366363363627, 6337.841553961188, 6037.396260373927, 6057.091436284504, 6059.272887253558, 6068.029115341524, 6069.2110025696375, 5519.227308176858, 5545.861353466195, 5560.833175004756, 5610.102383618601, 5626.831195064155, 6509.934900650933, 6527.477801775942, 6535.313792051861, 6552.08270842092, 6604.735810567619, 6293.150424692791, 6321.96839015802, 6327.525435592441, 6332.050192471166, 6332.778352757631, 6354.332795056453, 6402.519811014099, 6440.420362167428, 6498.220213574212, 6565.146530950946, 6212.161358216764, 6269.937300626935, 6276.121343012073, 6293.087502312231, 6309.49524038085, 6146.985747351637, 6304.779332723333, 6307.180066591313, 6313.43179113882, 6324.146240257691, 5315.617939335723, 6139.952147135157, 6166.105914642262, 6225.035119556476, 6275.309715931336, 6203.193584833943, 6216.689165541615, 6239.344868788712, 6297.118403423616, 6300.936990630035, 5123.666961647481, 5819.621724587888, 6048.60684055535, 6124.724387402666, 6226.59527130735, 5283.524482796567, 5994.890945175157, 6129.02260737745, 6207.379262073757, 6230.314665386713, 6201.720922558406, 6240.157578726996, 6245.344238854855, 6250.937490625036, 6271.96864015677], "value": 5824.8518518605115, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [450.0391663797791, 482.3560546670195, 501.17556619361153, 520.4899198785192, 531.1262972410386, 32030.199245018885, 37862.81068594657, 40094.7995260024, 40106.59893401065, 40192.79903600481, 41135.0, 41510.58489415105, 41674.37488437676, 41702.0, 41824.0, 9443.38617989832, 9479.668211612596, 9487.335886487948, 9598.992105828893, 9632.903670963306, 9583.616655333813, 9594.136527712504, 9597.088276613711, 9649.855252171223, 9685.079917407835, 9618.42289462631, 9637.132658060773, 9649.903500965005, 9676.56455459506, 9694.515274236295, 9525.999770024117, 9564.90435095647, 9596.760080997961, 9652.324337296392, 9680.854787178198, 9361.20429763471, 9496.097870702271, 9592.712218633453, 9600.567974441097, 9614.95192524033, 38979.0, 39294.60705392938, 39296.41055384171, 39323.41014884779, 39345.21309573793, 3459.066052165901, 3567.6432356764376, 3861.131245469775, 4082.3672330788777, 4238.766867822269, 31257.0, 31923.52114718281, 32148.0, 32503.0, 36379.818100909324, 3258.853351599184, 3367.848446819899, 3419.4870769384543, 3429.1427143214196, 3453.8100404477746, 372900.0, 485398.0, 491658.0, 493466.0, 494543.0, 52102.43692689225, 60145.0, 61050.69474652598, 61959.0, 62025.0, 63159.10522684327, 63234.36765632377, 63326.0501092484, 63510.0, 63908.04137937935, 15577.454789082554, 15820.208989550476, 15863.444779432664, 15993.760093598372, 16019.439319623758, 12077.335746533849, 12104.15270931044, 12200.0, 12222.961048310815, 12409.0, 17374.13129343528, 17684.204210810545, 17736.0, 17832.91083544574, 17878.28486860537, 6343.651099189589, 7263.89104163438, 7291.489595728248, 7358.337749602561, 7472.775816725507, 697.5047716121509, 760.7945854619222, 895.1540793949655, 971.145392054987, 983.8425851863667, 27826.582601260998, 30352.241193970327, 30405.0, 30450.238744031132, 30566.0, 1078.6871807175987, 1081.5889961814617, 1091.3670071358592, 1133.9886601134049, 1144.0, 15810.0, 15882.126483043312, 15939.601509962344, 15955.521334359988, 16015.439459618858, 663523.0, 663961.0, 666305.0, 670220.0, 671416.0, 58428.707856460445, 58580.41419585835, 58843.0, 58925.41074589199, 59074.11388829171, 1347.6832944258092, 1381.9309034548432, 1397.4549925529052, 1405.3113974152795, 1410.541573988458, 29217.41565168727, 30093.0, 30206.54690179605, 30413.543796842623, 30546.541801873434, 51264.0, 51336.0, 51388.74305628448, 51832.740836295576, 51990.74004630104, 601618.0, 603727.0, 603928.0, 604270.0, 604750.0, 41893.58106418897, 42354.364684530374, 42995.140097198506, 43119.78440107779, 43123.0, 47733.52266477291, 48048.0, 48167.5183248163, 49168.0, 49206.55554111178, 40022.39966400564, 40097.99755006148, 40177.39733904052, 40670.79664601776, 40929.79535102305, 39208.80395598004, 39793.40309895412, 40296.0, 40570.758600044195, 41144.0, 32102.876399325913, 38351.23297534089, 39366.80316598398, 39449.80275098606, 40752.0, 32741.83629081839, 35009.474857876645, 35373.115672108404, 35438.93683189509, 35602.10994725049, 22008.559828803012, 25825.612615811155, 25896.354922743692, 26007.60988585135, 26244.60633090467], "value": 20313.05475372971, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.34321653189585, 386.34514497926017, 388.62864649168455, 389.4664309895444, 411.07303031663594, 12341.950934170607, 20029.1988320467, 20219.0, 21227.257046003393, 21247.25634602789, 20004.89997550014, 20405.28581499644, 20409.183632654713, 21411.430628324622, 21447.927603619795, 5806.129080637907, 5895.64626122434, 5990.700464976734, 5991.161237426763, 6013.098035294719, 5819.388964158766, 5932.673702946337, 5964.612300200473, 6012.96993515034, 6028.698565071729, 6158.907616385758, 6570.441512471421, 6603.141591593087, 6643.103181070566, 6648.4681225501845, 5580.832575022736, 6023.819285421422, 6035.396460353973, 6048.606840555394, 6084.30030546484, 5913.0539113742025, 5917.585768996172, 5991.820245392645, 6022.548308876808, 6025.668588227646, 21719.0, 25185.874070629714, 25648.48703025929, 26005.73994260052, 26306.21081367562, 2158.3417057797365, 2222.9888850555803, 2319.5592837361014, 2415.6859608250816, 2838.5174520331593, 10144.289899707024, 10212.029857163558, 10268.435236062014, 12769.0423218259, 14732.55802325932, 1875.1561797191182, 1899.6105798311312, 1904.5820307258077, 1909.7230901519201, 1942.931997380085, 126895.3655231718, 128522.714772852, 129718.0, 129741.35129324388, 129855.0, 8958.552072396355, 9436.292278079172, 9978.700638980843, 10108.898911010943, 11531.942340288246, 11833.526658933719, 12401.62795116148, 12468.501259949682, 12470.81293780594, 12509.374531273399, 7861.095973962953, 8079.515229086273, 8088.797780055545, 8117.350611951029, 8179.672813087529, 7264.600446975362, 7453.217412171753, 7753.340966017839, 8343.54110523927, 8366.07973122956, 3913.0804260998643, 3919.980400097981, 3938.7636741795586, 3945.1715139820385, 3952.466417033721, 1658.363202508018, 1972.0829814136496, 1976.4861136104716, 1991.3727175939823, 1994.262123014494, 870.3994243971639, 932.4638332958576, 938.9530523473799, 943.8112377524523, 1013.0, 20829.479263018547, 21496.78503214979, 21643.67534486984, 21776.782232177793, 21869.234576789735, 905.8143080668447, 951.134120820808, 972.6887396033343, 995.1193194023197, 998.5656239535825, 9875.407475551347, 10611.469426528643, 10759.677209683721, 11066.28069175501, 11417.828732569018, 596528.0, 601272.0, 601844.0, 616896.0, 617209.0, 134374.0, 137873.0, 140334.2983285077, 140584.0, 140793.5920640801, 1009.5255230041869, 1011.4032720694826, 1026.6047571685103, 1028.3521381529588, 1037.3775734559356, 17501.47495575135, 19655.0, 20055.398338049883, 20056.796592204515, 20089.698654519903, 54928.72535637296, 56523.15215271692, 56748.432515675966, 57424.71287643535, 57545.0, 58219.4178058231, 80582.0, 81878.77181842396, 82007.58996204981, 82104.58947705223, 6836.897446538405, 7286.052813134259, 7323.560586364835, 7934.761957141295, 8420.073791882765, 9712.514374281116, 12900.419481123185, 13118.278494682883, 13181.0, 13184.670383240496, 11071.667849964513, 11138.554457821596, 11364.488598012944, 11473.483693233658, 11585.6524304271, 10433.843492347773, 10561.947190264, 10917.508712107816, 11456.140789440991, 11497.137714671266, 9246.352755307063, 11296.209265351346, 11327.716807079889, 11490.023348015513, 11585.710357241136, 8188.631511582113, 8193.754187374388, 8244.134365891496, 8314.08545060055, 8381.036180839037, 8174.019117705913, 10456.424896630759, 11054.778904421706, 11203.271787333797, 11319.0], "value": 9585.086727572896, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1363.4682473835205, 1515.2878147270783, 1720.440856721565, 1846.8799528030668, 1857.3127942661217, 7950.64222110005, 8502.914970850297, 8540.871886921701, 8984.820303593933, 9007.144321289476, 8675.73972780816, 8724.694635687752, 8794.736157915273, 8806.251468625174, 8842.071582483843, 2348.600737874561, 2384.7615238476187, 2385.5586716457424, 2386.7493913139133, 2389.390705370128, 2347.4718188407555, 2364.598018336887, 2382.1781485387514, 2387.9761202387926, 2389.3190440724397, 2359.681443005198, 2368.135630494874, 2380.9166679166233, 2385.821063420242, 2406.795422389099, 2343.425860664131, 2346.272655476799, 2366.3965688749345, 2370.383700237942, 2371.7983971362455, 1961.892095934723, 2316.5945959457026, 2316.745158032615, 2319.9652005219937, 2320.431494283894, 8810.207081362643, 8870.556472176366, 8909.465432074096, 8915.509646969414, 8919.910800891972, 4268.935965960513, 5221.738913054332, 5335.093034184198, 5338.412774594792, 5345.812896548641, 3553.6979356754705, 3681.9263614727824, 3684.042149041242, 3703.148275896559, 3706.869404831525, 1081.729567608098, 1097.5225776787124, 1106.7122548137543, 1107.385401102388, 1123.9438028098562, 11585.478653460614, 11782.941085294604, 11784.351860647661, 11798.351090690008, 11825.704357390961, 4609.608183304456, 4627.167109920179, 4839.225723884161, 4846.345743324606, 4847.175980083394, 9943.80112397748, 9965.053319934595, 9966.451845148586, 9971.40171589707, 9975.650852220137, 5376.301080859464, 5376.677399356051, 5388.622796404293, 5402.270693456333, 5405.297311349499, 4433.778311084433, 4759.23852183649, 4924.8030078797165, 4937.481564435754, 4944.035912997003, 3302.3065156317443, 3987.3819557968563, 4037.031112532971, 4049.858254961121, 4091.8772436826944, 983.6606370802061, 1165.551262763842, 1176.87054424015, 1181.468339247342, 1259.6347059352868, 736.5727877830846, 828.1718281718282, 864.5158711121792, 904.3217586809892, 927.7541451515353, 5564.582656300794, 5791.333996590446, 5811.767529298781, 5853.5317174625925, 5920.940790592125, 413.136544621742, 426.8058033594707, 433.6769107015294, 434.39835827378676, 435.1058574629104, 4022.3966405039478, 4046.635802777705, 4068.6541643960595, 4134.0, 4140.648044916215, 8241.587920604066, 10749.570017199381, 10833.187510936712, 10846.023857852831, 10868.945655271831, 10635.574577016832, 10661.573537058432, 10734.73163170927, 10809.189310801721, 10850.240483166102, 8059.355251579859, 8071.313938315191, 8132.349412047022, 8140.918590814134, 8144.633491492897, 5778.942210578009, 5823.126531020381, 5851.1515830205235, 5996.610220335664, 6055.3944605540855, 9875.604975800887, 9976.0, 10025.197984161396, 10026.248031397528, 10117.392956422638, 8744.344174187088, 10281.0, 10361.326513776581, 10378.481075946323, 10445.634402795866, 6897.931020689729, 7529.661165247468, 7606.277403646644, 7934.880976785237, 8293.917060829315, 8290.87563686533, 8376.99476062852, 8469.78825529342, 8476.915230847859, 8490.745277641434, 7332.230115837973, 7524.322810947041, 7551.282628150317, 7572.432067594842, 7604.087509498895, 7346.7061317546695, 7437.51656142349, 7442.4790264683115, 7467.290607392289, 7478.140013898471, 7054.506184567031, 7098.041764361745, 7101.715931362688, 7111.040009598638, 7111.466640002124, 4276.615104640598, 4894.363732714866, 5059.443461219189, 5101.132807422673, 5125.0, 5118.206677964921, 5123.257127716386, 5177.171652535576, 5187.118189907649, 5275.947240527546], "value": 4495.40104799429, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.4656836809056, 316.06287357983575, 319.3580902386203, 319.9120241933469, 322.9208843833261, 4473.552644735525, 4509.864704058883, 5488.1493368527845, 5538.723063846806, 5738.827835164947, 4266.914661706772, 4354.869353919387, 4639.559241872025, 5070.884405430799, 5684.602077854552, 3805.059419695961, 4044.2518134145275, 4091.263572556946, 4199.202151591188, 4266.0, 4068.6401886905674, 4236.851710190144, 4293.56165684496, 4307.67692423068, 4338.869833904988, 3183.7612179086545, 3880.5343358796986, 4278.165757677254, 4284.850030248942, 4298.161858437606, 3418.9658103418897, 4266.338717498793, 4289.935650965238, 4290.227759003378, 4320.97839510802, 2754.036087369425, 3029.0458505570673, 3606.963930360689, 3711.4247291669835, 3730.5336832895887, 4526.524714904954, 4555.840545580922, 5510.752016159283, 5512.145617429305, 5552.666839989613, 4131.3887583842325, 4681.602063824579, 4692.7653617319, 4913.729744864031, 4917.360743103373, 5332.760025798849, 5441.2587971849025, 5888.852778680524, 5938.524918006549, 5938.565188272787, 4104.733192342488, 4110.34234522478, 4111.9177616447805, 4127.380892866064, 4235.2588297048205, 4950.975245123751, 5817.331006934172, 6189.257289125334, 6276.843078923018, 6297.0554416837385, 3561.786292822439, 3598.1004748812798, 3983.48214732083, 3995.980020099939, 4015.8795236142964, 3497.213127046394, 4083.0, 4115.938260926088, 4126.607972242632, 4132.0, 3869.941950870739, 4421.828215522889, 4477.462704475419, 4829.420469543677, 4841.927371089366, 5257.973710131425, 5363.077122967992, 5566.053770858964, 5979.77092370124, 5981.581289309706, 1159.8318243854594, 1465.728840164573, 1470.7351677557292, 1471.0, 1475.7786332050277, 728.0644371981978, 904.6159376154494, 913.5386629752065, 923.1368670293298, 965.2673451155193, 4555.886102847389, 5217.295665085241, 5332.466753324637, 5375.569954403638, 5448.50166204297, 5951.880962380815, 5980.0, 5993.9700301498215, 6011.549133814981, 6014.51883849291, 5186.444066780026, 5406.270153529302, 5418.0, 5629.746661400247, 5634.7182640867795, 2861.9427611447654, 3099.6745341739243, 3235.2073741933377, 3254.7396208303753, 3258.5600943872746, 5379.973100134553, 5649.548036157097, 5663.631863928831, 6055.364186760415, 6406.807795766134, 5127.974360128175, 5751.942480575224, 6338.778142764981, 6344.238691356974, 6370.77702280418, 5887.734137160617, 5938.287405511366, 5970.0, 6426.678666066771, 6441.452476539453, 5080.974595127001, 5792.3917988612275, 6129.662868542095, 6171.074338849208, 6236.844078898064, 5213.973930130325, 5691.918535478246, 5725.685087320071, 6022.337542870368, 6075.483583895241, 5324.254604355316, 5870.354261031198, 6164.876702466016, 6287.71705273273, 6423.389777971085, 3460.4982277569106, 3951.9407208891316, 3965.9688480994573, 4001.0, 4012.6589239913765, 4889.462159162418, 5600.551955843604, 5625.424881033317, 6083.726232319645, 6102.511799056154, 5100.515451032146, 5135.765941815323, 5538.944610553843, 5936.762529498945, 6004.438845900185, 5448.482394172547, 5982.295045912068, 5983.162357269899, 5999.940000599938, 6024.638521688713, 4606.834787649799, 5309.814156504503, 5782.3639399666845, 5877.471027607536, 5885.588008839341, 4439.934415740264, 5523.116301391758, 5929.288485381781, 5949.464548190684, 5949.553783466171, 4838.129136755277, 4868.80524779019, 5756.2229099072765, 5816.680082595498, 5858.853528661817], "value": 4223.897127671582, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [689.937905588497, 724.9565026098431, 755.2523002227796, 770.9036370453691, 804.9315808156307, 11933.343666098372, 14364.640883977905, 15477.690446191084, 15485.845141548582, 15520.922395388021, 14132.152070875754, 14228.359723812428, 14228.786568201485, 14263.928680356583, 15527.378904843792, 846.3229416466833, 868.5266529741306, 869.952152631605, 871.4901782457239, 872.1714371347246, 837.5979529825687, 854.9914500855006, 864.3733293362325, 867.1458613265928, 873.253368370044, 896.0680891872445, 903.4534106865318, 903.5121034641319, 905.4702998745709, 907.0838453162321, 864.8356812205724, 891.9554022298859, 895.0959530873831, 898.4833720610642, 899.3479727197795, 660.3231687520282, 663.7013343995221, 666.8332916770808, 667.7629441548278, 668.588817877007, 15152.31814568347, 15252.618684532976, 15269.694606107816, 15276.465323713728, 15334.76997845022, 13894.0, 14114.92942535291, 14128.081674691111, 14379.281035948265, 14622.415103395851, 9703.854442183372, 11946.701332466759, 11970.82043769344, 12099.87900121005, 12436.823555877685, 3849.3648547989546, 3867.9806600966817, 3881.6506514413836, 3886.5336159661024, 4007.0, 81436.0, 89145.0, 93569.0, 115900.0, 116893.83106168914, 10753.78492430147, 10937.234393592531, 11010.339379637247, 11014.284071535325, 11023.503942322615, 22257.109715611194, 22279.665805012937, 22280.77719222787, 22291.888540557517, 22301.665475017886, 8054.798630034296, 8124.837503249902, 8182.795430114175, 8192.30365418946, 8323.500589964622, 4046.615571520701, 4528.977355113203, 4542.795574199169, 4640.466346370211, 4812.109759694467, 3455.274392377579, 3516.3143187078786, 3539.132912436418, 3599.5500562429697, 3602.873899413508, 662.4766434516678, 676.8680107379113, 680.3536640191837, 682.969266383014, 693.1543516909362, 581.2850194260998, 630.5271046714964, 635.9443324082001, 642.7461152844601, 695.8692125296393, 9006.715663939574, 9586.137247647745, 9588.0, 9602.807943841224, 9654.565544550513, 635.6758053392803, 650.3756393861851, 674.3324109132022, 677.8813707601249, 686.3856848121004, 4476.306172543261, 4692.601128904013, 4747.83382581608, 4949.628777841676, 5033.219850923039, 143687.0, 155196.0, 161054.0, 166011.0, 166185.0, 77049.84425233626, 79824.0, 80085.19914800893, 101636.0, 105933.0, 78352.0, 98394.01605983848, 100062.99937000537, 103177.48411257895, 103261.0, 9804.068613481993, 9823.950880245553, 9982.650607229003, 10015.14871235953, 10042.297039207186, 57537.712311438176, 57682.423175767704, 57715.711421442626, 58175.12737308859, 59636.403635963085, 85639.71540426774, 87713.56143219244, 90347.0, 94485.05514945037, 96175.0, 13011.414486347947, 13226.140300880412, 13226.47094116263, 13251.469941202244, 13893.444262229801, 14990.47533336328, 15259.771103433679, 15285.388584456497, 15734.606634834221, 15751.976121552063, 13987.580372588838, 14021.929890350482, 14353.353835758548, 14385.352659130574, 14537.636559086108, 13505.0, 13527.594172174851, 13555.728885422039, 13741.793873091712, 13962.162270263816, 11318.94340528292, 13637.931810340884, 13718.245496497788, 14115.7221478505, 14348.282585870873, 9117.680881169128, 11285.548578057114, 11547.480363383836, 11673.340975292638, 11857.940710296738, 11192.720181995515, 11412.0, 11542.19204655666, 11645.76708465843, 11752.412379381169], "value": 7793.36288805112, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1556.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 172.0, 142.0, 115.0, 117.0, 114.0, 114.0, 116.0, 127.0, 167.0], "value": 132.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 106.0, 133.0, 154.0, 109.0, 128.0, 128.0, 108.0, 175.0, 144.0], "value": 133.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 273.0, 265.0, 239.0, 199.0, 201.0, 195.0, 202.0, 199.0, 194.0], "value": 213.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 83.0, 78.0, 149.0, 59.0, 57.0, 57.0, 64.0, 133.0, 61.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 73.0, 121.0, 72.0, 73.0, 83.0, 116.0, 70.0, 72.0, 122.0], "value": 87.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 89.0, 88.0, 95.0, 89.0, 85.0, 88.0, 90.0, 127.0, 85.0], "value": 92.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 111.0, 95.0, 95.0, 94.0, 121.0, 133.0, 149.0, 150.0], "value": 113.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 96.0, 89.0, 89.0, 92.0, 89.0, 91.0, 90.0, 91.0, 90.0], "value": 90.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 54.0, 56.0, 57.0, 58.0, 59.0, 57.0, 57.0, 56.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 79.0, 68.0, 74.0, 78.0, 77.0, 77.0, 69.0, 74.0, 71.0], "value": 73.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 102.0, 94.0, 84.0, 82.0, 81.0, 89.0, 86.0, 87.0, 88.0], "value": 88.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 136.0, 150.0, 147.0, 144.0, 151.0, 137.0, 136.0, 179.0, 139.0], "value": 144.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 168.0, 169.0, 169.0, 186.0, 227.0, 215.0, 168.0, 166.0, 171.0], "value": 180.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 66.0, 65.0, 70.0, 67.0, 66.0, 69.0, 67.0, 67.0], "value": 67.2, "unit": "score"}]}]} 09:25:39 INFO - Return code: 0 09:25:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:25:39 ERROR - # TBPL SUCCESS # 09:25:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:25:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:25:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:25:39 INFO - 2016-06-30 09:25:39.432 screenresolution[1983:21135] starting screenresolution argv=screenresolution get 09:25:39 INFO - 2016-06-30 09:25:39.434 screenresolution[1983:21135] Display 0: 1600x1200x32@60 09:25:39 INFO - 2016-06-30 09:25:39.440 screenresolution[1984:21138] starting screenresolution argv=screenresolution list 09:25:39 INFO - Available Modes on Display 0 09:25:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:25:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:25:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:25:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:25:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:25:39 INFO - Intel Iris: 09:25:39 INFO - Chipset Model: Intel Iris 09:25:39 INFO - Type: GPU 09:25:39 INFO - Bus: Built-In 09:25:39 INFO - VRAM (Dynamic, Max): 1536 MB 09:25:39 INFO - Vendor: Intel (0x8086) 09:25:39 INFO - Device ID: 0x0a2e 09:25:39 INFO - Revision ID: 0x0009 09:25:39 INFO - Displays: 09:25:39 INFO - Display: 09:25:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:25:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:25:39 INFO - Display Serial Number: 1600x1200 60 09:25:39 INFO - Main Display: Yes 09:25:39 INFO - Mirror: Off 09:25:39 INFO - Online: Yes 09:25:39 INFO - Rotation: Supported 09:25:39 INFO - Return code: 0 09:25:39 INFO - Running post-action listener: _resource_record_post_action 09:25:39 INFO - ##### 09:25:39 INFO - ##### Finished run-tests step (success) 09:25:39 INFO - ##### 09:25:39 INFO - Running post-run listener: _resource_record_post_run 09:25:39 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 622592; Write bytes: 706307072; Read time: 4; Write time: 1957 09:25:39 INFO - TinderboxPrint: CPU usage
54.2% 09:25:39 INFO - TinderboxPrint: I/O read bytes / time
622,592 / 4 09:25:39 INFO - TinderboxPrint: I/O write bytes / time
706,307,072 / 1,957 09:25:39 INFO - TinderboxPrint: CPU idle
2,216.1 (45.8%) 09:25:39 INFO - TinderboxPrint: CPU system
977.7 (20.2%) 09:25:39 INFO - TinderboxPrint: CPU user
1,643.9 (34.0%) 09:25:39 INFO - TinderboxPrint: Swap in / out
406,994,944 / 0 09:25:39 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 396067328; Write bytes: 390555136; Read time: 29391; Write time: 785 09:25:39 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 622592; Write bytes: 295853568; Read time: 4; Write time: 1124 09:25:40 INFO - Running post-run listener: _upload_blobber_files 09:25:40 INFO - Blob upload gear active. 09:25:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:25:40 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 09:25:40 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:25:40 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:25:40 INFO - (blobuploader) - INFO - Open directory for files ... 09:25:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:25:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:25:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:25:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:25:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:25:42 INFO - (blobuploader) - INFO - Done attempting. 09:25:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:25:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:25:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:25:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:25:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:25:43 INFO - (blobuploader) - INFO - Done attempting. 09:25:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:25:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:25:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:25:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:25:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:25:45 INFO - (blobuploader) - INFO - Done attempting. 09:25:45 INFO - (blobuploader) - INFO - Iteration through files over. 09:25:45 INFO - Return code: 0 09:25:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:25:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:25:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/857e7ba01ac9f8171962273ca8c4a4d4124d56fbf9347df5278e6dfe2e8da18f2aecf7928e59e288179840ca05ae7afe257c642b55fc37185fbdd04a560ff4ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0514a410cb0a3a69022489f3a404354df8ad1e18b83ed98969e5fe28ee6d213ba445abbf0eb3d3dff96ed486596fc208639702dd93fb626ebf4556daf40ffd66", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/245c453de964b5a923f4dece9df36f8cfbda4511906ea64847a99040eea8675b884042c68bcee54be7d4677f2cf7bacb575d2faa8f4ac74adf243074fef26c8b"} 09:25:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:25:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:25:45 INFO - Contents: 09:25:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/857e7ba01ac9f8171962273ca8c4a4d4124d56fbf9347df5278e6dfe2e8da18f2aecf7928e59e288179840ca05ae7afe257c642b55fc37185fbdd04a560ff4ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0514a410cb0a3a69022489f3a404354df8ad1e18b83ed98969e5fe28ee6d213ba445abbf0eb3d3dff96ed486596fc208639702dd93fb626ebf4556daf40ffd66", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/245c453de964b5a923f4dece9df36f8cfbda4511906ea64847a99040eea8675b884042c68bcee54be7d4677f2cf7bacb575d2faa8f4ac74adf243074fef26c8b"} 09:25:45 INFO - Running post-run listener: copy_logs_to_upload_dir 09:25:45 INFO - Copying logs to upload dir... 09:25:45 INFO - mkdir: /builds/slave/test/build/upload/logs 09:25:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1292.384958 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 32 secs) (at 2016-06-30 09:25:45.447171) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 09:25:45.451142) ========= 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.WlLrpSmvN3/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.WZ66v7PCtB/Listeners TMPDIR=/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/857e7ba01ac9f8171962273ca8c4a4d4124d56fbf9347df5278e6dfe2e8da18f2aecf7928e59e288179840ca05ae7afe257c642b55fc37185fbdd04a560ff4ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0514a410cb0a3a69022489f3a404354df8ad1e18b83ed98969e5fe28ee6d213ba445abbf0eb3d3dff96ed486596fc208639702dd93fb626ebf4556daf40ffd66", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/245c453de964b5a923f4dece9df36f8cfbda4511906ea64847a99040eea8675b884042c68bcee54be7d4677f2cf7bacb575d2faa8f4ac74adf243074fef26c8b"} build_url:https://queue.taskcluster.net/v1/task/RQf05H5fQ2Cnh5Wm_ubArw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011194 build_url: 'https://queue.taskcluster.net/v1/task/RQf05H5fQ2Cnh5Wm_ubArw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/857e7ba01ac9f8171962273ca8c4a4d4124d56fbf9347df5278e6dfe2e8da18f2aecf7928e59e288179840ca05ae7afe257c642b55fc37185fbdd04a560ff4ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0514a410cb0a3a69022489f3a404354df8ad1e18b83ed98969e5fe28ee6d213ba445abbf0eb3d3dff96ed486596fc208639702dd93fb626ebf4556daf40ffd66", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/245c453de964b5a923f4dece9df36f8cfbda4511906ea64847a99040eea8675b884042c68bcee54be7d4677f2cf7bacb575d2faa8f4ac74adf243074fef26c8b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 09:25:45.484135) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 09:25:45.484467) ========= 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.WlLrpSmvN3/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.WZ66v7PCtB/Listeners TMPDIR=/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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.005240 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 09:25:45.532632) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 09:25:45.532971) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 09:25:45.533308) ========= ========= Total master_lag: 0.17 =========