builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0200 starttime: 1461676075.53 results: success (0) buildid: 20160426041155 builduid: b276353ccef4403fbd9a0f0b50b16148 revision: 7353d8e2cef652857f730e3b9ce39425e388e832 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 06:07:55.533225) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 06:07:55.533678) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 06:07:55.533974) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 06:07:55.867366) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 06:07:55.867818) ========= 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.m5XGvcNFjW/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.F4tYyMI6qr/Listeners TMPDIR=/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/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-04-26 06:07:55-- 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% 170M=0s 2016-04-26 06:07:56 (170 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.452861 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 06:07:56.363575) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 06:07:56.363915) ========= 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.m5XGvcNFjW/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.F4tYyMI6qr/Listeners TMPDIR=/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/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.025663 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 06:07:56.433230) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-04-26 06:07:56.433627) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7353d8e2cef652857f730e3b9ce39425e388e832 --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 7353d8e2cef652857f730e3b9ce39425e388e832 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.m5XGvcNFjW/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.F4tYyMI6qr/Listeners TMPDIR=/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/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-04-26 06:07:56,844 truncating revision to first 12 chars 2016-04-26 06:07:56,844 Setting DEBUG logging. 2016-04-26 06:07:56,844 attempt 1/10 2016-04-26 06:07:56,844 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7353d8e2cef6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-26 06:07:58,451 unpacking tar archive at: fx-team-7353d8e2cef6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.842276 ========= master_lag: 1.61 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-04-26 06:07:59.881527) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 06:07:59.881868) ========= script_repo_revision: 7353d8e2cef652857f730e3b9ce39425e388e832 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 06:07:59.882330) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 06:07:59.882611) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 06:08:00.480956) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-04-26 06:08:00.481397) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.m5XGvcNFjW/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.F4tYyMI6qr/Listeners TMPDIR=/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 06:08:00 INFO - MultiFileLogger online at 20160426 06:08:00 in /builds/slave/test 06:08:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 06:08:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:08:00 INFO - {'append_to_log': False, 06:08:00 INFO - 'base_work_dir': '/builds/slave/test', 06:08:00 INFO - 'blob_upload_branch': 'Fx-Team', 06:08:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:08:00 INFO - 'branch': 'Fx-Team', 06:08:00 INFO - 'buildbot_json_path': 'buildprops.json', 06:08:00 INFO - 'config_files': ('talos/mac_config.py',), 06:08:00 INFO - 'default_actions': ('clobber', 06:08:00 INFO - 'read-buildbot-config', 06:08:00 INFO - 'download-and-extract', 06:08:00 INFO - 'populate-webroot', 06:08:00 INFO - 'create-virtualenv', 06:08:00 INFO - 'install', 06:08:00 INFO - 'run-tests'), 06:08:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:08:00 INFO - 'download_minidump_stackwalk': True, 06:08:00 INFO - 'download_symbols': 'ondemand', 06:08:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:08:00 INFO - 'tooltool.py': '/tools/tooltool.py', 06:08:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:08:00 INFO - '/tools/misc-python/virtualenv.py')}, 06:08:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:08:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:08:00 INFO - 'installer_path': 'installer.exe', 06:08:00 INFO - 'log_level': 'info', 06:08:00 INFO - 'log_name': 'talos', 06:08:00 INFO - 'log_to_console': True, 06:08:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:08:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:08:00 INFO - 'opt_config_files': (), 06:08:00 INFO - 'pip_index': False, 06:08:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:08:00 INFO - 'cmd': ('bash', 06:08:00 INFO - '-c', 06:08:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:08:00 INFO - 'enabled': True, 06:08:00 INFO - 'halt_on_failure': False, 06:08:00 INFO - 'name': 'check_screen_resolution'},), 06:08:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:08:00 INFO - 'cmd': ('bash', 06:08:00 INFO - '-c', 06:08:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:08:00 INFO - 'enabled': True, 06:08:00 INFO - 'halt_on_failure': False, 06:08:00 INFO - 'name': 'check_screen_resolution'},), 06:08:00 INFO - 'run_cmd_checks_enabled': True, 06:08:00 INFO - 'sps_profile': False, 06:08:00 INFO - 'sps_profile_interval': 0, 06:08:00 INFO - 'suite': 'dromaeojs', 06:08:00 INFO - 'system_bits': '32', 06:08:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:08:00 INFO - 'title': 't-yosemite-r7-0200', 06:08:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:08:00 INFO - 'use_talos_json': True, 06:08:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:08:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:08:00 INFO - 'work_dir': 'build'} 06:08:00 INFO - ##### 06:08:00 INFO - ##### Running clobber step. 06:08:00 INFO - ##### 06:08:00 INFO - Running pre-action listener: _resource_record_pre_action 06:08:00 INFO - Running main action method: clobber 06:08:00 INFO - rmtree: /builds/slave/test/build 06:08:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:08:02 INFO - Running post-action listener: _resource_record_post_action 06:08:02 INFO - ##### 06:08:02 INFO - ##### Running read-buildbot-config step. 06:08:02 INFO - ##### 06:08:02 INFO - Running pre-action listener: _resource_record_pre_action 06:08:02 INFO - Running main action method: read_buildbot_config 06:08:02 INFO - Using buildbot properties: 06:08:02 INFO - { 06:08:02 INFO - "project": "", 06:08:02 INFO - "product": "firefox", 06:08:02 INFO - "script_repo_revision": "production", 06:08:02 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 06:08:02 INFO - "repository": "", 06:08:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 06:08:02 INFO - "buildid": "20160426041155", 06:08:02 INFO - "pgo_build": "False", 06:08:02 INFO - "basedir": "/builds/slave/test", 06:08:02 INFO - "buildnumber": 773, 06:08:02 INFO - "slavename": "t-yosemite-r7-0200", 06:08:02 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 06:08:02 INFO - "platform": "yosemite_r7", 06:08:02 INFO - "scheduler": "tests-fx-team-macosx64-talos", 06:08:02 INFO - "branch": "fx-team", 06:08:02 INFO - "repo_path": "integration/fx-team", 06:08:02 INFO - "revision": "7353d8e2cef652857f730e3b9ce39425e388e832", 06:08:02 INFO - "stage_platform": "macosx64", 06:08:02 INFO - "builduid": "b276353ccef4403fbd9a0f0b50b16148", 06:08:02 INFO - "slavebuilddir": "test" 06:08:02 INFO - } 06:08:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/Eu8_xST7TPa5AhsFpX-CjQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 06:08:02 INFO - Running post-action listener: _resource_record_post_action 06:08:02 INFO - ##### 06:08:02 INFO - ##### Running download-and-extract step. 06:08:02 INFO - ##### 06:08:02 INFO - Running pre-action listener: _resource_record_pre_action 06:08:02 INFO - Running main action method: download_and_extract 06:08:02 INFO - mkdir: /builds/slave/test/build/tests 06:08: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')]} 06:08:02 INFO - https://queue.taskcluster.net/v1/task/Eu8_xST7TPa5AhsFpX-CjQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 06:08:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Eu8_xST7TPa5AhsFpX-CjQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 06:08:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Eu8_xST7TPa5AhsFpX-CjQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 06:08:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Eu8_xST7TPa5AhsFpX-CjQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 06:08:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Eu8_xST7TPa5AhsFpX-CjQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 06:08:04 INFO - Downloaded 1199 bytes. 06:08:04 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 06:08:04 INFO - Using the following test package requirements: 06:08:04 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 06:08:04 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:08:04 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 06:08:04 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:08:04 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 06:08:04 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:08:04 INFO - u'jsshell-mac.zip'], 06:08:04 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:08:04 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 06:08:04 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 06:08:04 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:08:04 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 06:08:04 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:08:04 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 06:08:04 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:08:04 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 06:08:04 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:08:04 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 06:08:04 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:08: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')]} 06:08:04 INFO - https://queue.taskcluster.net/v1/task/Eu8_xST7TPa5AhsFpX-CjQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:08:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Eu8_xST7TPa5AhsFpX-CjQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 06:08:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Eu8_xST7TPa5AhsFpX-CjQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 06:08:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Eu8_xST7TPa5AhsFpX-CjQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 06:08:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Eu8_xST7TPa5AhsFpX-CjQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:08:07 INFO - Downloaded 18113253 bytes. 06:08:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:08:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:08:10 INFO - Return code: 0 06:08:10 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 06:08: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')]} 06:08:10 INFO - https://queue.taskcluster.net/v1/task/Eu8_xST7TPa5AhsFpX-CjQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:08:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Eu8_xST7TPa5AhsFpX-CjQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 06:08:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Eu8_xST7TPa5AhsFpX-CjQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 06:08:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Eu8_xST7TPa5AhsFpX-CjQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 06:08:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Eu8_xST7TPa5AhsFpX-CjQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:08:11 INFO - Downloaded 18113253 bytes. 06:08:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:08:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:08:14 INFO - Return code: 0 06:08: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')]} 06:08:14 INFO - https://queue.taskcluster.net/v1/task/Eu8_xST7TPa5AhsFpX-CjQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:08:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Eu8_xST7TPa5AhsFpX-CjQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 06:08:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Eu8_xST7TPa5AhsFpX-CjQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 06:08:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Eu8_xST7TPa5AhsFpX-CjQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 06:08:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Eu8_xST7TPa5AhsFpX-CjQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:08:15 INFO - Downloaded 10840145 bytes. 06:08:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:08:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 06:08:16 INFO - Return code: 0 06:08:16 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')]} 06:08:16 INFO - https://queue.taskcluster.net/v1/task/Eu8_xST7TPa5AhsFpX-CjQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 06:08:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Eu8_xST7TPa5AhsFpX-CjQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 06:08:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Eu8_xST7TPa5AhsFpX-CjQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 06:08:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Eu8_xST7TPa5AhsFpX-CjQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 06:08:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Eu8_xST7TPa5AhsFpX-CjQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 06:08:19 INFO - Downloaded 110096947 bytes. 06:08:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Eu8_xST7TPa5AhsFpX-CjQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 06:08:19 INFO - mkdir: /builds/slave/test/properties 06:08:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:08:19 INFO - Writing to file /builds/slave/test/properties/build_url 06:08:19 INFO - Contents: 06:08:19 INFO - build_url:https://queue.taskcluster.net/v1/task/Eu8_xST7TPa5AhsFpX-CjQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 06:08:20 INFO - Running post-action listener: _resource_record_post_action 06:08:20 INFO - Running post-action listener: set_extra_try_arguments 06:08:20 INFO - ##### 06:08:20 INFO - ##### Running populate-webroot step. 06:08:20 INFO - ##### 06:08:20 INFO - Running pre-action listener: _resource_record_pre_action 06:08:20 INFO - Running main action method: populate_webroot 06:08:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:08:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:08:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:08:20 INFO - '--tppagecycles', 06:08:20 INFO - '7'], 06:08:20 INFO - 'tests': ['tsvgm']}}, 06:08:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:08:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:08:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:08:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:08:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:08:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:08:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:08:20 INFO - 'talos_options': ['--disable-e10s'], 06:08:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:08:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:08:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:08:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:08:20 INFO - 'talos_options': ['--disable-e10s'], 06:08:20 INFO - 'tests': ['damp', 'tps']}, 06:08:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:08:20 INFO - 'tests': ['damp', 'tps']}, 06:08:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:08:20 INFO - 'tests': ['dromaeo_dom']}, 06:08:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:08:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:08:20 INFO - 'tests': ['a11yr', 06:08:20 INFO - 'ts_paint', 06:08:20 INFO - 'tpaint', 06:08:20 INFO - 'sessionrestore', 06:08:20 INFO - 'sessionrestore_no_auto_restore', 06:08:20 INFO - 'tabpaint']}, 06:08:20 INFO - 'other-e10s': {'tests': ['a11yr', 06:08:20 INFO - 'ts_paint', 06:08:20 INFO - 'tpaint', 06:08:20 INFO - 'sessionrestore', 06:08:20 INFO - 'sessionrestore_no_auto_restore', 06:08:20 INFO - 'tabpaint']}, 06:08:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:08:20 INFO - 'ts_paint', 06:08:20 INFO - 'tpaint', 06:08:20 INFO - 'sessionrestore', 06:08:20 INFO - 'sessionrestore_no_auto_restore', 06:08:20 INFO - 'tabpaint']}, 06:08:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:08:20 INFO - 'ts_paint', 06:08:20 INFO - 'tpaint', 06:08:20 INFO - 'sessionrestore', 06:08:20 INFO - 'sessionrestore_no_auto_restore', 06:08:20 INFO - 'tabpaint']}, 06:08:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:08:20 INFO - 'tests': ['a11yr', 06:08:20 INFO - 'ts_paint', 06:08:20 INFO - 'tpaint', 06:08:20 INFO - 'sessionrestore', 06:08:20 INFO - 'sessionrestore_no_auto_restore', 06:08:20 INFO - 'tabpaint']}, 06:08:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:08:20 INFO - 'tests': ['a11yr', 06:08:20 INFO - 'ts_paint', 06:08:20 INFO - 'tpaint', 06:08:20 INFO - 'sessionrestore', 06:08:20 INFO - 'sessionrestore_no_auto_restore', 06:08:20 INFO - 'tabpaint']}, 06:08:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:08:20 INFO - 'tests': ['tsvgx', 06:08:20 INFO - 'tsvgr_opacity', 06:08:20 INFO - 'tart', 06:08:20 INFO - 'tscrollx', 06:08:20 INFO - 'cart']}, 06:08:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:08:20 INFO - 'tsvgr_opacity', 06:08:20 INFO - 'tart', 06:08:20 INFO - 'tscrollx', 06:08:20 INFO - 'cart']}, 06:08:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:08:20 INFO - 'talos_options': ['--disable-e10s'], 06:08:20 INFO - 'tests': ['tp5o']}, 06:08:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:08:20 INFO - 'tests': ['tp5o']}, 06:08:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:08:20 INFO - 'talos_options': ['--disable-e10s', 06:08:20 INFO - '--xperf_path', 06:08:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:08:20 INFO - 'tests': ['tp5n']}, 06:08:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:08:20 INFO - 'talos_options': ['--xperf_path', 06:08:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:08:20 INFO - 'tests': ['tp5n']}}, 06:08:20 INFO - 'talos.zip': {'path': '', 06:08:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:08:20 INFO - Running post-action listener: _resource_record_post_action 06:08:20 INFO - ##### 06:08:20 INFO - ##### Running create-virtualenv step. 06:08:20 INFO - ##### 06:08:20 INFO - Running pre-action listener: _resource_record_pre_action 06:08:20 INFO - Running main action method: create_virtualenv 06:08:20 INFO - Creating virtualenv /builds/slave/test/build/venv 06:08:20 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:08:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:08:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:08:21 INFO - Using real prefix '/tools/python27' 06:08:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:08:21 INFO - Installing distribute.............................................................................................................................................................................................done. 06:08:24 INFO - Installing pip.................done. 06:08:24 INFO - Return code: 0 06:08:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:08: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')]} 06:08:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08: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')]} 06:08:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:24 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 0x109b4ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b5e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84e3c63e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099ede00>, '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 0x109816db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099e8b20>, '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.m5XGvcNFjW/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.F4tYyMI6qr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:08:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:08:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:08:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m5XGvcNFjW/Render', 06:08:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:08:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:08:24 INFO - 'HOME': '/Users/cltbld', 06:08:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:08:24 INFO - 'LOGNAME': 'cltbld', 06:08:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:24 INFO - 'MOZ_NO_REMOTE': '1', 06:08:24 INFO - 'NO_EM_RESTART': '1', 06:08:24 INFO - 'PAGER': '/bin/cat', 06:08:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:08:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:24 INFO - 'PWD': '/builds/slave/test', 06:08:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:08:24 INFO - 'SHELL': '/bin/bash', 06:08:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F4tYyMI6qr/Listeners', 06:08:24 INFO - 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/', 06:08:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:08:24 INFO - 'USER': 'cltbld', 06:08:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:08:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:08:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:24 INFO - 'XPC_FLAGS': '0x0', 06:08:24 INFO - 'XPC_SERVICE_NAME': '0', 06:08:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:08:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:24 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:08:24 INFO - Cleaning up... 06:08:24 INFO - Return code: 0 06:08:24 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:08: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')]} 06:08:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08: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')]} 06:08:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:24 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109b4ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b5e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84e3c63e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099ede00>, '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 0x109816db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099e8b20>, '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.m5XGvcNFjW/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.F4tYyMI6qr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:08:24 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>=0.7.1'] in /builds/slave/test/build 06:08:24 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>=0.7.1 06:08:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m5XGvcNFjW/Render', 06:08:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:08:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:08:24 INFO - 'HOME': '/Users/cltbld', 06:08:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:08:24 INFO - 'LOGNAME': 'cltbld', 06:08:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:24 INFO - 'MOZ_NO_REMOTE': '1', 06:08:24 INFO - 'NO_EM_RESTART': '1', 06:08:24 INFO - 'PAGER': '/bin/cat', 06:08:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:08:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:24 INFO - 'PWD': '/builds/slave/test', 06:08:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:08:24 INFO - 'SHELL': '/bin/bash', 06:08:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F4tYyMI6qr/Listeners', 06:08:24 INFO - 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/', 06:08:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:08:24 INFO - 'USER': 'cltbld', 06:08:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:08:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:08:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:24 INFO - 'XPC_FLAGS': '0x0', 06:08:24 INFO - 'XPC_SERVICE_NAME': '0', 06:08:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:08:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:25 INFO - Downloading/unpacking psutil>=0.7.1 06:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:08:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:08:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:08:28 INFO - Installing collected packages: psutil 06:08:28 INFO - Running setup.py install for psutil 06:08:28 INFO - building 'psutil._psutil_osx' extension 06:08:28 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 06:08:29 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 06:08:29 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 06:08:29 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 06:08:29 INFO - building 'psutil._psutil_posix' extension 06:08:29 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 06:08:29 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:08:29 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:08:29 INFO - ^ 06:08:29 INFO - 1 warning generated. 06:08:29 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 06:08:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:08:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:08:29 INFO - Successfully installed psutil 06:08:29 INFO - Cleaning up... 06:08:29 INFO - Return code: 0 06:08:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:08: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')]} 06:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08: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')]} 06:08:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08: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', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109b4ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b5e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84e3c63e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099ede00>, '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 0x109816db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099e8b20>, '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.m5XGvcNFjW/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.F4tYyMI6qr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:08: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 06:08: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 mozsystemmonitor==0.0.0 06:08:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m5XGvcNFjW/Render', 06:08:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:08:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:08:29 INFO - 'HOME': '/Users/cltbld', 06:08:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:08:29 INFO - 'LOGNAME': 'cltbld', 06:08:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:29 INFO - 'MOZ_NO_REMOTE': '1', 06:08:29 INFO - 'NO_EM_RESTART': '1', 06:08:29 INFO - 'PAGER': '/bin/cat', 06:08:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:08:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:29 INFO - 'PWD': '/builds/slave/test', 06:08:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:08:29 INFO - 'SHELL': '/bin/bash', 06:08:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F4tYyMI6qr/Listeners', 06:08:29 INFO - 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/', 06:08:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:08:29 INFO - 'USER': 'cltbld', 06:08:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:08:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:08:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:29 INFO - 'XPC_FLAGS': '0x0', 06:08:29 INFO - 'XPC_SERVICE_NAME': '0', 06:08:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:08:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:08:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:08:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:08:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:08:32 INFO - Installing collected packages: mozsystemmonitor 06:08:32 INFO - Running setup.py install for mozsystemmonitor 06:08:32 INFO - Successfully installed mozsystemmonitor 06:08:32 INFO - Cleaning up... 06:08:32 INFO - Return code: 0 06:08:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:08:32 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')]} 06:08:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:32 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')]} 06:08:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:32 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 0x109b4ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b5e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84e3c63e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099ede00>, '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 0x109816db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099e8b20>, '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.m5XGvcNFjW/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.F4tYyMI6qr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:08:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:08:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:08:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m5XGvcNFjW/Render', 06:08:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:08:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:08:32 INFO - 'HOME': '/Users/cltbld', 06:08:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:08:32 INFO - 'LOGNAME': 'cltbld', 06:08:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:32 INFO - 'MOZ_NO_REMOTE': '1', 06:08:32 INFO - 'NO_EM_RESTART': '1', 06:08:32 INFO - 'PAGER': '/bin/cat', 06:08:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:08:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:32 INFO - 'PWD': '/builds/slave/test', 06:08:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:08:32 INFO - 'SHELL': '/bin/bash', 06:08:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F4tYyMI6qr/Listeners', 06:08:32 INFO - 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/', 06:08:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:08:32 INFO - 'USER': 'cltbld', 06:08:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:08:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:08:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:32 INFO - 'XPC_FLAGS': '0x0', 06:08:32 INFO - 'XPC_SERVICE_NAME': '0', 06:08:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:08:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:32 INFO - Downloading/unpacking blobuploader==1.2.4 06:08:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:35 INFO - Downloading blobuploader-1.2.4.tar.gz 06:08:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:08:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:08:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:08:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:36 INFO - Downloading docopt-0.6.1.tar.gz 06:08:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:08:36 INFO - Installing collected packages: blobuploader, requests, docopt 06:08:36 INFO - Running setup.py install for blobuploader 06:08:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:08:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:08:36 INFO - Running setup.py install for requests 06:08:37 INFO - Running setup.py install for docopt 06:08:37 INFO - Successfully installed blobuploader requests docopt 06:08:37 INFO - Cleaning up... 06:08:37 INFO - Return code: 0 06:08:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:08:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:08:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:37 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 0x109b4ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b5e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84e3c63e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099ede00>, '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 0x109816db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099e8b20>, '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.m5XGvcNFjW/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.F4tYyMI6qr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:08:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:08:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:08:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m5XGvcNFjW/Render', 06:08:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:08:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:08:37 INFO - 'HOME': '/Users/cltbld', 06:08:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:08:37 INFO - 'LOGNAME': 'cltbld', 06:08:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:37 INFO - 'MOZ_NO_REMOTE': '1', 06:08:37 INFO - 'NO_EM_RESTART': '1', 06:08:37 INFO - 'PAGER': '/bin/cat', 06:08:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:08:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:37 INFO - 'PWD': '/builds/slave/test', 06:08:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:08:37 INFO - 'SHELL': '/bin/bash', 06:08:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F4tYyMI6qr/Listeners', 06:08:37 INFO - 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/', 06:08:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:08:37 INFO - 'USER': 'cltbld', 06:08:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:08:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:08:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:37 INFO - 'XPC_FLAGS': '0x0', 06:08:37 INFO - 'XPC_SERVICE_NAME': '0', 06:08:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:08:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:08:37 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-L9hY2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:08:37 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-0a55F7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:08:37 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-aplZhQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:08:38 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-hc7FeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:08:38 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-8M5OYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:08:38 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-V4PDvM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:08:38 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-pkRdWC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:08:38 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-G2L3J8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:08:38 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-wEjeAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:08:38 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-_HjElr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:08:38 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-YFPiQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:08:38 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-Rms0gl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:08:39 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-oHyQMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:08:39 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-TkBXGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:08:39 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-iX4fEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:08:39 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-4NqpVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:08:39 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-6BwozN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:08:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:08:39 INFO - Running setup.py install for manifestparser 06:08:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:08:39 INFO - Running setup.py install for mozcrash 06:08:39 INFO - Running setup.py install for mozdebug 06:08:39 INFO - Running setup.py install for mozdevice 06:08:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:08:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:08:40 INFO - Running setup.py install for mozfile 06:08:40 INFO - Running setup.py install for mozhttpd 06:08:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:08:40 INFO - Running setup.py install for mozinfo 06:08:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:08:40 INFO - Running setup.py install for mozInstall 06:08:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:08:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:08:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:08:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:08:40 INFO - Running setup.py install for mozleak 06:08:40 INFO - Running setup.py install for mozlog 06:08:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:08:41 INFO - Running setup.py install for moznetwork 06:08:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:08:41 INFO - Running setup.py install for mozprocess 06:08:41 INFO - Running setup.py install for mozprofile 06:08:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:08:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:08:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:08:41 INFO - Running setup.py install for mozrunner 06:08:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:08:41 INFO - Running setup.py install for mozscreenshot 06:08:41 INFO - Running setup.py install for moztest 06:08:41 INFO - Running setup.py install for mozversion 06:08:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:08:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:08:42 INFO - Cleaning up... 06:08:42 INFO - Return code: 0 06:08:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:08:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:08:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:08:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:42 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 0x109b4ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b5e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84e3c63e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099ede00>, '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 0x109816db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099e8b20>, '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.m5XGvcNFjW/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.F4tYyMI6qr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:08:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:08:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:08:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m5XGvcNFjW/Render', 06:08:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:08:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:08:42 INFO - 'HOME': '/Users/cltbld', 06:08:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:08:42 INFO - 'LOGNAME': 'cltbld', 06:08:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:42 INFO - 'MOZ_NO_REMOTE': '1', 06:08:42 INFO - 'NO_EM_RESTART': '1', 06:08:42 INFO - 'PAGER': '/bin/cat', 06:08:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:08:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:42 INFO - 'PWD': '/builds/slave/test', 06:08:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:08:42 INFO - 'SHELL': '/bin/bash', 06:08:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F4tYyMI6qr/Listeners', 06:08:42 INFO - 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/', 06:08:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:08:42 INFO - 'USER': 'cltbld', 06:08:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:08:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:08:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:42 INFO - 'XPC_FLAGS': '0x0', 06:08:42 INFO - 'XPC_SERVICE_NAME': '0', 06:08:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:08:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:08:42 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-UnORv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:08:42 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:08:42 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-g27GrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:08:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:08:42 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-K2n6AD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:08:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:08:42 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-1amaeX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:08:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:08:42 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-IHsvXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:08:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:08:42 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-0XSGOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:08:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:08:42 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-G7xpp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:08:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:08:43 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-36nbRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:08:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:08:43 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-Mq29HT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:08:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:08:43 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-KRbaW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:08:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:08:43 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-hXJF6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:08:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:08:43 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-9UpBAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:08:43 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)) 06:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:08:43 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-bTE5p0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:08:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:08:43 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-YN2On_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:08:43 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)) 06:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:08:43 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-5Qs6ao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:08:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:08:43 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-UPoXwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:08:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:08:44 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-DCBTst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:08:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:08:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:08:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:08:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:08:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:08:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:08:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:46 INFO - Downloading blessings-1.6.tar.gz 06:08:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:08:46 INFO - Installing collected packages: blessings 06:08:46 INFO - Running setup.py install for blessings 06:08:46 INFO - Successfully installed blessings 06:08:46 INFO - Cleaning up... 06:08:46 INFO - Return code: 0 06:08:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:08:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:08:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:08:47 INFO - Reading from file tmpfile_stdout 06:08:47 INFO - Current package versions: 06:08:47 INFO - blessings == 1.6 06:08:47 INFO - blobuploader == 1.2.4 06:08:47 INFO - docopt == 0.6.1 06:08:47 INFO - manifestparser == 1.1 06:08:47 INFO - mozInstall == 1.12 06:08:47 INFO - mozcrash == 0.17 06:08:47 INFO - mozdebug == 0.1 06:08:47 INFO - mozdevice == 0.48 06:08:47 INFO - mozfile == 1.2 06:08:47 INFO - mozhttpd == 0.7 06:08:47 INFO - mozinfo == 0.9 06:08:47 INFO - mozleak == 0.1 06:08:47 INFO - mozlog == 3.1 06:08:47 INFO - moznetwork == 0.27 06:08:47 INFO - mozprocess == 0.22 06:08:47 INFO - mozprofile == 0.28 06:08:47 INFO - mozrunner == 6.11 06:08:47 INFO - mozscreenshot == 0.1 06:08:47 INFO - mozsystemmonitor == 0.0 06:08:47 INFO - moztest == 0.7 06:08:47 INFO - mozversion == 1.4 06:08:47 INFO - psutil == 3.1.1 06:08:47 INFO - requests == 1.2.3 06:08:47 INFO - wsgiref == 0.1.2 06:08:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:08:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:08:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:47 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 0x109b4ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b5e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84e3c63e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099ede00>, '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 0x109816db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099e8b20>, '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.m5XGvcNFjW/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.F4tYyMI6qr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:08:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:08:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:08:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m5XGvcNFjW/Render', 06:08:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:08:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:08:47 INFO - 'HOME': '/Users/cltbld', 06:08:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:08:47 INFO - 'LOGNAME': 'cltbld', 06:08:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:47 INFO - 'MOZ_NO_REMOTE': '1', 06:08:47 INFO - 'NO_EM_RESTART': '1', 06:08:47 INFO - 'PAGER': '/bin/cat', 06:08:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:08:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:47 INFO - 'PWD': '/builds/slave/test', 06:08:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:08:47 INFO - 'SHELL': '/bin/bash', 06:08:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F4tYyMI6qr/Listeners', 06:08:47 INFO - 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/', 06:08:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:08:47 INFO - 'USER': 'cltbld', 06:08:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:08:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:08:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:47 INFO - 'XPC_FLAGS': '0x0', 06:08:47 INFO - 'XPC_SERVICE_NAME': '0', 06:08:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:08:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:08:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:08:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:08:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:08:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:08:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:08:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:08:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:08:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:08:47 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:08:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:08:47 INFO - Cleaning up... 06:08:47 INFO - Return code: 0 06:08:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:08:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:08:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:47 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 0x109b4ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b5e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84e3c63e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099ede00>, '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 0x109816db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099e8b20>, '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.m5XGvcNFjW/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.F4tYyMI6qr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:08:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:08:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:08:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m5XGvcNFjW/Render', 06:08:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:08:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:08:47 INFO - 'HOME': '/Users/cltbld', 06:08:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:08:47 INFO - 'LOGNAME': 'cltbld', 06:08:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:47 INFO - 'MOZ_NO_REMOTE': '1', 06:08:47 INFO - 'NO_EM_RESTART': '1', 06:08:47 INFO - 'PAGER': '/bin/cat', 06:08:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:08:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:47 INFO - 'PWD': '/builds/slave/test', 06:08:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:08:47 INFO - 'SHELL': '/bin/bash', 06:08:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F4tYyMI6qr/Listeners', 06:08:47 INFO - 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/', 06:08:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:08:47 INFO - 'USER': 'cltbld', 06:08:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:08:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:08:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:47 INFO - 'XPC_FLAGS': '0x0', 06:08:47 INFO - 'XPC_SERVICE_NAME': '0', 06:08:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:08:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:47 INFO - Downloading/unpacking jsonschema 06:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:08:50 INFO - Downloading/unpacking functools32 (from jsonschema) 06:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:50 INFO - Downloading functools32-3.2.3-2.tar.gz 06:08:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:08:50 INFO - warning: no files found matching '*.txt' 06:08:50 INFO - no previously-included directories found matching 'build' 06:08:50 INFO - no previously-included directories found matching 'dist' 06:08:50 INFO - no previously-included directories found matching '.git*' 06:08:50 INFO - Installing collected packages: jsonschema, functools32 06:08:50 INFO - Running setup.py install for functools32 06:08:50 INFO - warning: no files found matching '*.txt' 06:08:50 INFO - no previously-included directories found matching 'build' 06:08:50 INFO - no previously-included directories found matching 'dist' 06:08:50 INFO - no previously-included directories found matching '.git*' 06:08:50 INFO - Successfully installed jsonschema functools32 06:08:50 INFO - Cleaning up... 06:08:50 INFO - Return code: 0 06:08:50 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:08:50 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')]} 06:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:50 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')]} 06:08:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:50 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109b4ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b5e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84e3c63e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099ede00>, '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 0x109816db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099e8b20>, '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.m5XGvcNFjW/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.F4tYyMI6qr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:08:50 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', 'flake8'] in /builds/slave/test/build 06:08:50 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 flake8 06:08:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m5XGvcNFjW/Render', 06:08:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:08:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:08:50 INFO - 'HOME': '/Users/cltbld', 06:08:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:08:50 INFO - 'LOGNAME': 'cltbld', 06:08:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:50 INFO - 'MOZ_NO_REMOTE': '1', 06:08:50 INFO - 'NO_EM_RESTART': '1', 06:08:50 INFO - 'PAGER': '/bin/cat', 06:08:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:08:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:50 INFO - 'PWD': '/builds/slave/test', 06:08:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:08:50 INFO - 'SHELL': '/bin/bash', 06:08:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F4tYyMI6qr/Listeners', 06:08:50 INFO - 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/', 06:08:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:08:50 INFO - 'USER': 'cltbld', 06:08:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:08:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:08:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:50 INFO - 'XPC_FLAGS': '0x0', 06:08:50 INFO - 'XPC_SERVICE_NAME': '0', 06:08:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:08:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:51 INFO - Downloading/unpacking flake8 06:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:08:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:08:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:08:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:08:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:08:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:08:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:08:54 INFO - no previously-included directories found matching 'docs/_build' 06:08:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:08:54 INFO - Running setup.py install for pep8 06:08:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:08:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:08:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:08:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:08:54 INFO - no previously-included directories found matching 'docs/_build' 06:08:55 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:08:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:08:55 INFO - Cleaning up... 06:08:55 INFO - Return code: 0 06:08:55 INFO - Running post-action listener: _resource_record_post_action 06:08:55 INFO - Running post-action listener: _start_resource_monitoring 06:08:55 INFO - Starting resource monitoring. 06:08:55 INFO - ##### 06:08:55 INFO - ##### Running install step. 06:08:55 INFO - ##### 06:08:55 INFO - Running pre-action listener: _resource_record_pre_action 06:08:55 INFO - Running main action method: install 06:08:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:08:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:08:55 INFO - Reading from file tmpfile_stdout 06:08:55 INFO - Detecting whether we're running mozinstall >=1.0... 06:08:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:08:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:08:55 INFO - Reading from file tmpfile_stdout 06:08:55 INFO - Output received: 06:08:55 INFO - Usage: mozinstall [options] installer 06:08:55 INFO - Options: 06:08:55 INFO - -h, --help show this help message and exit 06:08:55 INFO - -d DEST, --destination=DEST 06:08:55 INFO - Directory to install application into. [default: 06:08:55 INFO - "/builds/slave/test"] 06:08:55 INFO - --app=APP Application being installed. [default: firefox] 06:08:55 INFO - mkdir: /builds/slave/test/build/application 06:08:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:08:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 06:09:28 INFO - Reading from file tmpfile_stdout 06:09:28 INFO - Output received: 06:09:28 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:09:28 INFO - Running post-action listener: _resource_record_post_action 06:09:28 INFO - ##### 06:09:28 INFO - ##### Running run-tests step. 06:09:28 INFO - ##### 06:09:28 INFO - Running pre-action listener: _resource_record_pre_action 06:09:28 INFO - Running main action method: run_tests 06:09:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:09:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:09:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:09:28 INFO - 2016-04-26 06:09:28.709 screenresolution[1641:7932] starting screenresolution argv=screenresolution get 06:09:28 INFO - 2016-04-26 06:09:28.712 screenresolution[1641:7932] Display 0: 1600x1200x32@60 06:09:28 INFO - 2016-04-26 06:09:28.717 screenresolution[1642:7934] starting screenresolution argv=screenresolution list 06:09:28 INFO - Available Modes on Display 0 06:09:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:09:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:09:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:09:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:09:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:09:28 INFO - Intel Iris: 06:09:28 INFO - Chipset Model: Intel Iris 06:09:28 INFO - Type: GPU 06:09:28 INFO - Bus: Built-In 06:09:28 INFO - VRAM (Dynamic, Max): 1536 MB 06:09:28 INFO - Vendor: Intel (0x8086) 06:09:28 INFO - Device ID: 0x0a2e 06:09:28 INFO - Revision ID: 0x0009 06:09:28 INFO - Displays: 06:09:28 INFO - Display: 06:09:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:09:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:09:28 INFO - Display Serial Number: 1600x1200 60 06:09:28 INFO - Main Display: Yes 06:09:28 INFO - Mirror: Off 06:09:28 INFO - Online: Yes 06:09:28 INFO - Rotation: Supported 06:09:28 INFO - Return code: 0 06:09:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:09:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:09:28 INFO - Python 2.7.3 06:09:28 INFO - Return code: 0 06:09:28 INFO - grabbing minidump binary from tooltool 06:09:28 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')]} 06:09:28 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099ede00>, '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 0x109816db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099e8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:09:28 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:09:28 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 06:09:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:09:29 INFO - Return code: 0 06:09:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:09:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:09:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:09:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:09:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:09:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:09:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:09:30 INFO - Return code: 0 06:09:30 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', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Eu8_xST7TPa5AhsFpX-CjQ/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0200', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:09:30 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 --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Eu8_xST7TPa5AhsFpX-CjQ/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0200 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:09:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m5XGvcNFjW/Render', 06:09:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:09:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:09:30 INFO - 'HOME': '/Users/cltbld', 06:09:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:09:30 INFO - 'LOGNAME': 'cltbld', 06:09:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:09:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:09:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:09:30 INFO - 'MOZ_NO_REMOTE': '1', 06:09:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:09:30 INFO - 'NO_EM_RESTART': '1', 06:09:30 INFO - 'PAGER': '/bin/cat', 06:09:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:09:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:09:30 INFO - 'PWD': '/builds/slave/test', 06:09:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:09:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:09:30 INFO - 'SHELL': '/bin/bash', 06:09:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F4tYyMI6qr/Listeners', 06:09:30 INFO - 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/', 06:09:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:09:30 INFO - 'USER': 'cltbld', 06:09:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:09:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:09:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:09:30 INFO - 'XPC_FLAGS': '0x0', 06:09:30 INFO - 'XPC_SERVICE_NAME': '0', 06:09:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:09:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Eu8_xST7TPa5AhsFpX-CjQ/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0200', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:09:30 INFO - mozversion application_buildid: 20160426041155 06:09:30 INFO - mozversion application_changeset: 7353d8e2cef652857f730e3b9ce39425e388e832 06:09:30 INFO - mozversion application_display_name: Nightly 06:09:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:09:30 INFO - mozversion application_name: Firefox 06:09:30 INFO - mozversion application_remotingname: firefox 06:09:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:09:30 INFO - mozversion application_vendor: Mozilla 06:09:30 INFO - mozversion application_version: 49.0a1 06:09:30 INFO - mozversion platform_buildid: 20160426041155 06:09:30 INFO - mozversion platform_changeset: 7353d8e2cef652857f730e3b9ce39425e388e832 06:09:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:09:30 INFO - mozversion platform_version: 49.0a1 06:09:30 INFO - using testdate: 1461676170 06:09:30 INFO - actual date: 1461676170 06:09:30 INFO - starting webserver on 'localhost:49270' 06:09:30 INFO - SUITE-START | Running 2 tests 06:09:30 INFO - TEST-START | dromaeo_css 06:09:30 INFO - operating with platform_type : mac_ 06:09:30 INFO - Initialising browser for dromaeo_css test... 06:09:30 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/tmpUsMgPJ/profile http://localhost:49270/getInfo.html) 06:09:32 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 06:09:32 INFO - PROCESS | 1660 | colorDepth:24 06:09:32 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 06:09:32 INFO - PROCESS | 1660 | __metrics 06:09:32 INFO - PROCESS | 1660 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:09:32 ERROR - PROCESS | 1660 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:09:33 INFO - TEST-INFO | 1660: exit 0 06:09:33 INFO - Browser initialized. 06:09:33 INFO - Running cycle 1/1 for dromaeo_css test... 06:09:33 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/tmpUsMgPJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:09:45 INFO - PROCESS | 1662 | RSS: Main: 239349760 06:09:45 INFO - PROCESS | 1662 | 06:10:36 INFO - PROCESS | 1662 | 1461676236905 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:12:47 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 06:12:48 INFO - PROCESS | 1662 | RSS: Main: 371777536 06:12:48 INFO - PROCESS | 1662 | 06:15:51 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 06:15:52 INFO - PROCESS | 1662 | RSS: Main: 375603200 06:15:52 INFO - PROCESS | 1662 | 06:18:54 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 06:18:54 INFO - PROCESS | 1662 | RSS: Main: 375218176 06:18:54 INFO - PROCESS | 1662 | 06:21:57 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 06:21:57 INFO - PROCESS | 1662 | RSS: Main: 376877056 06:21:57 INFO - PROCESS | 1662 | 06:25:00 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 06:25:01 INFO - PROCESS | 1662 | RSS: Main: 348319744 06:25:01 INFO - PROCESS | 1662 | 06:28:04 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 06:28:04 INFO - PROCESS | 1662 | RSS: Main: 381423616 06:28:04 INFO - PROCESS | 1662 | 06:28:04 INFO - PROCESS | 1662 | __start_tp_report 06:28:04 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 06:28:04 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 06:28:04 INFO - PROCESS | 1662 | |i|pagename|runs| 06:28:04 INFO - PROCESS | 1662 | |0;dojo.html;3414.7438942079343;3460.429029210182;3468.167639766456;3492.8602855885765;3527.2945410917805;5692.174634677979;5730.197772311874;5733.684647344395;5749.712514374285;5751.90713764385;5748.166515855199;5754.712264386774;5786.132080187964;5911.46796788289;5912.615679980799;5027.271045698371;5065.974670126644;5091.363579552556;5102.948970510303;5160.92258616121;5188.558972487343;5192.896142077157;5200.6879587224885;5255.343082114736;5278.340207474066;5061.746912654371;5116.897662046776;5154.278401023859;5173.974130129344;5175.146100893348;4593.012502312019;4927.7536123193695;5124.948750512484;5190.455002224788;5193.610479214074;5087.745612719349;5140.228965655144;5150.587952963754;5152.330197074394;5201.141811601081;5481.506664400184;5640.182173584807;5656.858578535528;5669.376368599451;5675.318961724578;6146.0473626587955;6181.567290289681;6227.377262273736;6257.43683068526;6264.498840092781;6196.473299769525;6245.6252624842655;6267.185265915447;6275.623462592259;6285.120083188357;5598.804041858515;5737.254156959569;5738.368779434259;5745.965726169288;5749.108888122348;6203.4416902479;6251.3123556408755;6272.8118156455375;6289.371062893674;6299.023651334051;5108.157154069537;6052.962177676085;6084.574079814459;6200;6210.844728881814;6202.100695399142;6217.626942383471;6255.0617407388345;6258.468030217391;6296.779612713533;6058.182145410401;6259.092431597484;6266.373362663697;6274;6276.6547839868335;6121.727351053096;6160.691965401712;6215.595986260879;6265;6416.35836416364;4938.975305123451;4944.703317800943;4950.331705219821;4957.752112394366;4961.8511444656715;4329.653627709776;4397.362382454527;4403.9559604404185;4436.245838207513;4444.888877778081;5562.276904002454;5590.049691552445;5605;5606.355269144019;5608.270924779834;6177.660228687376;6208.565400422018;6226.782062627786;6229.813105606839;6238.500919926395;5560.944390556124;5645.633033852869;5649.265595472644;5657.264555607827;5709.400512946164;5310.389305229948;5355.518003379637;5369.7583608737705;5371.892562148813;5381.596380271495;6225.719842607094;6250.843728906813;6261.373862613793;6266.624002559861;6314.305426403183;6226.59527130735;6269;6276.215473065867;6277.843053923689;6280.874382512416;6276.811695649138;6313.40022697843;6326.367363263636;6342.52431067681;6350.714217860115;6084.33072362031;6112.442689633789;6175.4750846176785;6205.441510263918;6231.844203894758;6261.530385221217;6266.811995640138;6267.498600111889;6270.623762574261;6289.465395441439;5933.3769954154195;6095.05526643371;6103;6115.7247923844425;6142.32434432221;5791.884162316815;5856.033754430471;5917.881642367214;5924.31870334917;5929.495992840657;5859.384764599656;5865.970670146622;5895.20414744004;5943.108533719977;5974.910376344272;6082.482988945812;6127.938720612915;6133.02189081539;6137.048757442425;6147.84630384244;5763.6541807491685;5898.144769008384;5952.5237980960555;5954.940450595439;5956.315023772148 06:28:04 INFO - PROCESS | 1662 | |1;ext.html;526.581367812589;535.7187476574798;566.3769853161522;583.5710752596843;617.80539130174;28313.150605481842;31374.843125784366;40946.18107637849;41468;41556.79221603888;45040.549594504046;45690.543094569046;45786.771066144705;45888.54111458884;45977.540224597746;9626.518674066303;9879.06148915852;9882.555285012191;9883.802323953516;9887.752806179831;9652.613895444174;9827.164691001273;9830.361026533288;9830.950845245763;9844.212463002943;9794.657186998456;9859.161971232454;9871.259655525828;9871.358361706467;9885.209183265357;9677.322587418883;9738;9803.558839852223;9808.90191098087;9816.558254878548;9637.18083962857;9741.805163896683;9745.463999480025;9749.756256093584;9766.193254247915;41290.587094129274;41839;41844.79077604593;41933;42010.78994605008;2917.092886904015;3229.241128334863;3250.512423136525;3433;4029.6574791142493;27225.45549089007;28064.438711225663;28598.857005715046;28637.85681071602;30558.69441305603;2679.42392385638;2735.7948153888537;2769.75072243497;2829.8868045278164;2880.5823155642315;371112;483250.167498324;489542;489787;490125;65895.34104658988;66698;66758.66620666963;66969;67106.32893671098;62472.687636562434;63904.68047659732;63981;64009;64071;17032.2335494903;17176.914115429343;17297;17306.913465432594;17336.3065477382;12993.675158121123;13031.08782385243;13058.804117938238;13060.542880999119;13067.150635208682;19661.311854085037;19952.401427957186;19966;19967.400977970683;20358.28745993913;6987.406070483964;7371.483996120327;8030.036395632562;8138.43030987837;8184.754457366289;866.4887716247318;915.6337465014047;1025.2157099818644;1082.1342925659442;1171.9472623731951;27656.446871062468;28925.987590434233;29158;29871.43912323077;30229.244268893453;976.5605477534996;1030.9742256443499;1059.7297689089232;1079.1600321451906;1093.9671809845718;15497.767533487007;15557.066576005476;15623.843761562239;15642.568789162102;15935;667742;673345;682115;683166;683702;56751.013714519795;57759.4224057754;61990.69004654948;62807.743845122845;62866.68566657137;1316.7037416581384;1350.8784209421199;1433.304847149111;1476.7489526780257;1491.209658880795;23621;24257;28757.568636470052;29519.704802951695;29546.704532954394;49539;49561.25658115059;49884.50346489611;50020.74989625029;50041.24938126004;380019;382026;382385;382640;383677;20427.79572204259;23592.17427390033;23627.173048943205;23674.28977130689;26548.469030619664;36807.711730089315;37078;41666.16667666569;43719.34420983624;44725.329120062575;26315.868420657775;29801.956931507295;36116.45825312675;36343.63656363403;36968.63031369652;27749.86125069362;35725.821370892976;35747.82126089353;36457.453138202414;36547.26905461929;36353.09117271983;37086;37121.58709683862;37349.62650373462;37603.24793504169;31682.207944801565;32169.678303216668;32201.677983219866;32382.35235295328;32511.674883250864;23687.526249475257;23881.761182387952;24011;24087;24369.63445548283 06:28:04 INFO - PROCESS | 1662 | |2;jquery.html;387.6995328620319;388.54346143281634;391.3210579644318;394.6522625234823;401.34981330245006;14171.626467833048;19484.902575487136;19904;20195.192192312326;20231.898840505793;15804.525864224062;17326.48020559382;19989.400317990447;20466.69299960498;20739.585208295826;5769.3076830780265;5969.403059694039;6001.48987336077;6005;6007;5163.586913046966;5597.776088956457;5975.581709280352;6051.909221361683;6129.570930034899;6063.9090413643835;6091.2690477142805;6100.664463454508;6102.877942441149;6109.786157484489;6038.57729958903;6120.785772497941;6131.846703832395;6137.232845894263;6148.1392605035335;4358.65130789536;5209.947900520984;5234.057869583474;5245.79016839326;5252.527272545489;24569.38576535583;25484.617730734055;25640.358991025372;25711.74288257112;26982.73017269822;1947.2308438166986;2227.52108296717;2430.927072187837;2588;2821.6049753034386;9393.880335217324;10320.432376219305;13401.329933503286;14521.709565808625;15106.244687765568;1719.17479609788;1748.3094177799826;1796.6316905034566;1832.1205821205897;1838.4025191812714;109232.4538377303;114403;116034;122210.77789222082;123661;11398.601048963246;11611.477483513263;11647.242929209575;11653.766924661459;11823.290602563873;14883.553493395215;14954;14969.700605988037;14982.250887455584;14984.325705343286;7498;7520.849583008309;8661.177188167114;8710.433821801562;8761.43050701715;6855.417289530346;8569.785755356166;8615.138486151334;8683.261922736512;8685.305175585938;4285.5071666758095;4366.126774645084;4549.520511321338;4607.539246075433;4638.631603676923;1412.9576112716634;1955.8435325173953;1958.6278607064612;1999.6500612392774;2002.0690378973848;876.9605367758467;887.9911200888038;901.535709109809;946.5172761891347;990.3166814897697;17019.40432084871;18756.96836673996;20056.69914951277;20310.390688279374;20791.376258712262;931.101487064972;966.5360626898987;976.9804603908024;978.3933960944261;985.7530224266309;9692.386836414114;10773.676789696321;10987.890121098686;11020.063294619888;11041.227114101936;545890;546152;550323;551218;557736;118041.40979295221;118798.81201188051;118882;120182.79817201891;120236.39881800536;978.9363691360039;1026.4764969865273;1028.6296933104077;1060.2631171336002;1086.9673909782719;17656.20547075359;17932;18046.909765451615;18087.36694215696;18688.34590789316;36578;36657.63342366542;46715.766421167675;47408.051838963715;47764.52235477601;45280;63811;64180.67909660422;64611.67694161499;64792.02811957919;8033.277005069572;8041.557714325768;8128.75613731589;8153.633086511002;8407.033191183093;11858.644240672793;11994.820077699016;12771;12904.612861614167;13242.337883105998;9553.426794392359;10906.945465272624;11328.830067548828;11601.825972610586;11615.361155136548;8457.40798144124;9930.816798515081;10366.274360794974;11161.162912781412;11280.943595281971;11390;11552.884471155518;11621.24461909973;11699;11747.706307342385;7637.274458926393;8086;8219.95890020546;8269.917300826915;8493.702720404755;9643.903560964582;10965.945170274097;11231.38227397501;11326.32042077478;11341.489632966372 06:28:04 INFO - PROCESS | 1662 | |3;mootools.html;1380.8342998840128;1610.8067031956164;1618.6438983423645;1863.832255097041;1969.7242386065952;7389.187189409161;7709.3061624453785;8523.87214191787;8714.520701361422;8744.650213991448;8361;8582.785430364243;8593.484390936532;8605.225529702326;8624.310055195585;2416.830821842472;2459.1270099114827;2460.3972026853444;2460.6063029915217;2463.322586288767;2381.38084098134;2434.087217293515;2438.5732496813075;2438.634204869266;2443.6701045358827;2417.5890098683176;2438.4635380216414;2448.4123810285582;2451.1788550835404;2451.460678650694;2385.1651921827397;2410.5660981023407;2412.541617092764;2413.1312727418117;2442.38940264932;2375.560521303564;2417.129833260025;2421.140495124223;2423.3820375804057;2424.151546958568;8553.486790792573;8568.742937711879;8621.396502244845;8629.482231066093;8637.827243455158;5258.81594144207;5452.345718513764;5470.343558772933;5480.780768769245;5501.779928802843;3475.079104037432;3593.1017245688577;3611.5485564304463;3636;3677.3013127505687;910.9863352049724;1005.3666190300137;1046.6598355534481;1047.0733400940146;1055.4617145255897;11446.542138314457;11551.480183391683;11560.421978901022;11569.190156689036;11577.6526704199;4057.208844275397;4533.54664533544;4578.404807375086;4667.486576476585;4674.158651442705;8189.590520473953;8791.340649451316;8991.595378207996;9210.03294654065;9214.63141474347;5207.297014903015;5232.607554433433;5270.894582108336;5276.023935571855;5284;4202.285611446062;4341.826326946887;4363.890902727458;4498.3927169832305;4888.437829649564;3768.7550309229814;3833.195029043932;3862.1117143057254;3868.516435445569;3908.1206728485863;1188.4057971014493;1195.5875223048035;1198.1193822540426;1205.69254840017;1214.5991822698488;888.1429420609143;903.3947255338938;912.452528482905;915.4232833314969;936.1410955032464;5652.378238393773;5957.851053723692;5977.880442391215;6046.848828779316;6129.264488261348;697.4385619576188;912.7535565397305;929.4748467116058;969.3311614985637;971.9222462203148;3763.096856754359;3832.827522761482;3864.14988702485;3946.861859834892;3955.248502784462;10175.592976281014;10385.428801415994;10428.791424171473;10466.52900619474;10604.628837990633;10492.520321955652;10629.89370106289;10658.840117398246;10754.677359679223;10879.945600272107;7352.448566357544;7953.602319883983;8043.83912321762;8290.29532489733;8421.15788421153;5696.487316141567;5783.103618938903;5828.737706803289;5879.676617786063;5972.641641501524;8639.568021598769;10124.24068194903;10184.083432491112;10200.948995254976;10237.078662920372;8089.2315230053055;9920.751981200528;10169.491525423551;10257.435841028517;10268.743281418025;6421.967890160519;6640.169978752656;6882.7591034315565;7014.649267536704;7088.929110708827;8319.084900661044;8327;8424.368172387218;8433.36749743784;8433.789155271168;7178.461615378972;7416.592087435243;7437.628118593941;7460.440466964891;7486.925130748623;7223.783286501413;7288.635568221462;7317.524360916524;7396.297351751575;7475.0656167979005;7032.648367581703;7082.291770822876;7133.750318739027;7136.536125151849;7138.214796372498;4758.928616070692;4836.903261934812;4999.500049995117;5019.472955339636;5112.258722485144;4931.457539670561;4984.800607975641;4994.575461085703;5050.797968081236;5051.267566202953 06:28:04 INFO - PROCESS | 1662 | |4;prototype.html;287.9064304101167;320.3800645750473;326.08858241215813;326.3847647185056;331.2084118955698;4257.7658228797445;4652.953470465294;5189.532942035216;5222.582193424517;5247.396549396815;4003.819828107735;4842.733649649268;5163.432022477534;5186.7147306898105;5209.817656382027;2972.613560237166;3522.9295414091766;3851.7111216658723;3932.5674175840636;4016.297147999103;3952.6245006724316;3983.3427484465174;4003.4595329630565;4007.3988901664693;4048.554658987509;3955.6550772737264;3970.6573121858096;3978.4231286463446;3990.7805070721097;3993.941605474537;3152.858121384543;3354.815485148316;3590.8204589770407;3767.472553842464;3792.8482860685676;3480.6519348065244;3510.7893526388243;3511.9824400878088;3521.4505617528207;3522.4011917974008;4093.385992101179;4997.325361076245;4999.625028122905;5009.549140577329;5019;3908.4918960534947;4216.208111552578;4363.814415476688;4604.309353596954;4649.163580385729;4465.82136714531;4554.0891821635805;5362.4637536246455;5431.099115309649;5463.235147079412;3642.562892452923;3736.4395340698843;3861.1891502784447;3871.4386413970096;3871.9612803872164;4716.764161791931;4835.226363781778;4914.11545921734;5408.242846001563;5701.77192912283;3606.693431058337;3917.2176659619804;3941.6452519273403;3945.467361906106;3958.5447673517915;3982.561918188997;4008.7594744315434;4012.1574469361763;4014.2573623879675;4016.6184212499766;4551.52209018055;4566.589006989387;4568.1548913451115;4570.65720070996;4592.540745925381;4820.68665536739;5299.019681358961;5434.483724046209;5501.642393244426;5541.806036788774;1413.1168019987508;1455.3523681961638;1472.9705405891823;1473.3001824133664;1481.4814814814729;922.9953850230706;962.7929995051097;999.2655398282257;1003.6838395905412;1003.7992401519725;5223.503767142115;5357.919631205535;5402.837914862561;5411.64824286428;5438.510534051954;5481.2874326338115;5623.10030395143;5669.55426366274;5683.323419591231;5979.970100149471;4874.829380971649;4898.338724272249;5122.414309983027;5123.436421993578;5151.6908985461;2836.3901761121047;2878.208492664534;3143.0885043337635;3252.772305938609;3260.136063943057;5962.612430192024;6173.135760993465;6449.161608990895;6481.611103333815;6492.253390860112;4573.519780423074;5821.621594596338;5838.766449341979;5841.707914604338;5844.94155058444;4556.944319555598;5234.7644356004075;5956;5970.76116955317;6134.631922084689;4865.6107511398295;5393.325834270716;5642.899634571219;5712.257406537124;5746.138079287973;5407.945450637245;5630.380658127685;5636.267285252891;5659.603827732184;5723.227364305765;5550.250716153268;5614.203454894395;5950.727100094844;5986.2517185351835;6007.8197654070445;2991.865366058576;3139.8273094979995;3843.673287770571;3851.942220866745;3909.5113110861143;4682.508336624742;5100.948990510047;5256.790938084338;5669.4047125051275;5669.922714684197;4551.522090180616;4768;5344.893102137858;5502.779888804403;5523.861903452285;5140.820071297636;5454.209139674805;5490.258815060076;5495.395506494203;5508.669479831223;4635.966708963224;5302.920456193083;5346.331708536433;5348.5988550858065;5351.1973204019705;4353.194658988097;4869.6121605342305;4871.805127794849;5600.047991841316;5647.548196144381;5482.753276102665;5504.22940788298;5510.972445137749;5522.5858060644805;5544.7227638618715 06:28:04 INFO - PROCESS | 1662 | |5;yui.html;665.9533832631712;700.7792545348218;723.5297056913007;747.5888261456199;752.4732687119018;14623.415063397451;15066.924665376686;15113.848861511382;15115.697686046286;15135.772963405558;13851.961102917296;13911.165330080203;13922.651933701662;13925.582232533015;13942.790858137136;692.4149094015548;712.4264966701803;877.1184959116111;885.4244740918423;918.0635751533432;883.7437143228456;917.5274733512247;920.6961702638147;921.2814005076018;925.5742358515091;921.7142685767434;974.1670871404953;974.7465658928659;975.2685485885586;976.2190247801766;744.57559191261;926.4626516620344;936.3211671538148;967;968.7384406210319;717.6555253478307;717.7846646006229;718.270954980695;719.9172095209066;720.531654424623;11680.766384672259;11704.414779261004;11723.179377443583;11723.706907327385;11754.647360579196;11990;12112.757744845141;12170.57402990891;12524.311162886037;12566.246025238515;9898.901010989943;10065.647702330456;10069.69790906274;10142.797144057078;10751.778695457517;3105.3634005028916;3153.595667545987;3176.888808891678;3188.9681103188905;3236.449803533405;62232;79633.60183199105;80086.59956700237;81312.59343703302;82031.58984205041;9006.549672516348;9360.578773955189;9461.053894610484;9657.275704322205;9745.269104817167;20282.188712451632;20322.288719894732;20595.58808823815;20620.381388558366;20638.58722825535;6295.685215739195;7324.487285889936;7407.444441666897;7440.813979650444;7520.360769334558;4140.399642051885;4149.757300867349;4271.530131685512;4288.056627541998;4344.761038142932;3470.9479357809655;3542.6103128655827;3549.8580056797437;3550.4851796489365;3556.590992035897;649.0685865782617;665.9400653941168;669.3707914560298;670.7719375412286;674.9021391898148;523.426847601883;531.5455285730644;549.5850632772232;559.2394343692575;578.6094386289238;7664.386849052063;7723.266289702469;7790.5325680459355;7919.841603167904;7941.444098913021;487.55875932281344;507.5406756885025;531.1342511705894;573.9827805165768;588.2705445247948;3201.4877619580757;3480.164760457472;3688.428293614494;3708.1100535871196;3720.6093360197333;87459;88155.55922220348;90254.64618030735;90312;93555;65743.0277091688;65752.01371979424;76517;78877;81640;70081.59836803337;70599.94100088502;70622.64688676626;71201;71635.28364716285;7336.30305121034;7388.113426388868;7406.1192650523135;7433.591152486665;7482.326590606872;43563.56436435595;43944;44643.55356446524;44703.55296446994;47100;65195.69608607896;66227.34431639248;66468.33531664622;66491;66702.6664866692;9367.531623418938;9423.069239681936;9608.95195524018;9743.61025558998;9857.704268871945;10202.21955549387;10362.222833287382;10426.27016108865;10499.055085042382;10891.400972946247;9844;9882.950585247316;9933.950330248303;10087.495625218857;10157.746056348651;9487.620495180116;9790.706278811647;9883.159931405911;9909.752256193653;10660;9624.536756450725;9708.805823883624;9761.267904907303;9766.75583110428;10338.9661033896;8275.710350137957;8342.332613391036;8409.663613455394;8507.659693612186;8627.482351058956;8217.30152937007;8248.092709802037;8350.498970061815;8707.3034157266;9508 06:28:04 INFO - PROCESS | 1662 | __end_tp_report 06:28:04 INFO - PROCESS | 1662 | __start_cc_report 06:28:04 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,1323 06:28:04 INFO - PROCESS | 1662 | __end_cc_report 06:28:04 INFO - PROCESS | 1662 | __startTimestamp1461677284768__endTimestamp 06:28:04 INFO - PROCESS | 1662 | 06:28:04 INFO - PROCESS | 1662 | ------- Summary: start ------- 06:28:04 INFO - PROCESS | 1662 | Number of tests: 6 06:28:04 INFO - PROCESS | 1662 | 06:28:04 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5717.91 Median:5912.62 stddev:639.93 (10.8%) stddev-sans-first:615.86 06:28:04 INFO - PROCESS | 1662 | Values: 3414.7 3460.4 3468.2 3492.9 3527.3 5692.2 5730.2 5733.7 5749.7 5751.9 5748.2 5754.7 5786.1 5911.5 5912.6 5027.3 5066.0 5091.4 5102.9 5160.9 5188.6 5192.9 5200.7 5255.3 5278.3 5061.7 5116.9 5154.3 5174.0 5175.1 4593.0 4927.8 5124.9 5190.5 5193.6 5087.7 5140.2 5150.6 5152.3 5201.1 5481.5 5640.2 5656.9 5669.4 5675.3 6146.0 6181.6 6227.4 6257.4 6264.5 6196.5 6245.6 6267.2 6275.6 6285.1 5598.8 5737.3 5738.4 5746.0 5749.1 6203.4 6251.3 6272.8 6289.4 6299.0 5108.2 6053.0 6084.6 6200.0 6210.8 6202.1 6217.6 6255.1 6258.5 6296.8 6058.2 6259.1 6266.4 6274.0 6276.7 6121.7 6160.7 6215.6 6265.0 6416.4 4939.0 4944.7 4950.3 4957.8 4961.9 4329.7 4397.4 4404.0 4436.2 4444.9 5562.3 5590.0 5605.0 5606.4 5608.3 6177.7 6208.6 6226.8 6229.8 6238.5 5560.9 5645.6 5649.3 5657.3 5709.4 5310.4 5355.5 5369.8 5371.9 5381.6 6225.7 6250.8 6261.4 6266.6 6314.3 6226.6 6269.0 6276.2 6277.8 6280.9 6276.8 6313.4 6326.4 6342.5 6350.7 6084.3 6112.4 6175.5 6205.4 6231.8 6261.5 6266.8 6267.5 6270.6 6289.5 5933.4 6095.1 6103.0 6115.7 6142.3 5791.9 5856.0 5917.9 5924.3 5929.5 5859.4 5866.0 5895.2 5943.1 5974.9 6082.5 6127.9 6133.0 6137.0 6147.8 5763.7 5898.1 5952.5 5954.9 5956.3 06:28:04 INFO - PROCESS | 1662 | 06:28:04 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:64797.51 Median:208811.12 stddev:140262.99 (67.2%) stddev-sans-first:140573.45 06:28:04 INFO - PROCESS | 1662 | Values: 526.6 535.7 566.4 583.6 617.8 28313.2 31374.8 40946.2 41468.0 41556.8 45040.5 45690.5 45786.8 45888.5 45977.5 9626.5 9879.1 9882.6 9883.8 9887.8 9652.6 9827.2 9830.4 9831.0 9844.2 9794.7 9859.2 9871.3 9871.4 9885.2 9677.3 9738.0 9803.6 9808.9 9816.6 9637.2 9741.8 9745.5 9749.8 9766.2 41290.6 41839.0 41844.8 41933.0 42010.8 2917.1 3229.2 3250.5 3433.0 4029.7 27225.5 28064.4 28598.9 28637.9 30558.7 2679.4 2735.8 2769.8 2829.9 2880.6 371112.0 483250.2 489542.0 489787.0 490125.0 65895.3 66698.0 66758.7 66969.0 67106.3 62472.7 63904.7 63981.0 64009.0 64071.0 17032.2 17176.9 17297.0 17306.9 17336.3 12993.7 13031.1 13058.8 13060.5 13067.2 19661.3 19952.4 19966.0 19967.4 20358.3 6987.4 7371.5 8030.0 8138.4 8184.8 866.5 915.6 1025.2 1082.1 1171.9 27656.4 28926.0 29158.0 29871.4 30229.2 976.6 1031.0 1059.7 1079.2 1094.0 15497.8 15557.1 15623.8 15642.6 15935.0 667742.0 673345.0 682115.0 683166.0 683702.0 56751.0 57759.4 61990.7 62807.7 62866.7 1316.7 1350.9 1433.3 1476.7 1491.2 23621.0 24257.0 28757.6 29519.7 29546.7 49539.0 49561.3 49884.5 50020.7 50041.2 380019.0 382026.0 382385.0 382640.0 383677.0 20427.8 23592.2 23627.2 23674.3 26548.5 36807.7 37078.0 41666.2 43719.3 44725.3 26315.9 29802.0 36116.5 36343.6 36968.6 27749.9 35725.8 35747.8 36457.5 36547.3 36353.1 37086.0 37121.6 37349.6 37603.2 31682.2 32169.7 32201.7 32382.4 32511.7 23687.5 23881.8 24011.0 24087.0 24369.6 06:28:04 INFO - PROCESS | 1662 | 06:28:04 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:32577.07 Median:14785.37 stddev:91845.90 (621.2%) stddev-sans-first:92071.75 06:28:04 INFO - PROCESS | 1662 | Values: 387.7 388.5 391.3 394.7 401.3 14171.6 19484.9 19904.0 20195.2 20231.9 15804.5 17326.5 19989.4 20466.7 20739.6 5769.3 5969.4 6001.5 6005.0 6007.0 5163.6 5597.8 5975.6 6051.9 6129.6 6063.9 6091.3 6100.7 6102.9 6109.8 6038.6 6120.8 6131.8 6137.2 6148.1 4358.7 5209.9 5234.1 5245.8 5252.5 24569.4 25484.6 25640.4 25711.7 26982.7 1947.2 2227.5 2430.9 2588.0 2821.6 9393.9 10320.4 13401.3 14521.7 15106.2 1719.2 1748.3 1796.6 1832.1 1838.4 109232.5 114403.0 116034.0 122210.8 123661.0 11398.6 11611.5 11647.2 11653.8 11823.3 14883.6 14954.0 14969.7 14982.3 14984.3 7498.0 7520.8 8661.2 8710.4 8761.4 6855.4 8569.8 8615.1 8683.3 8685.3 4285.5 4366.1 4549.5 4607.5 4638.6 1413.0 1955.8 1958.6 1999.7 2002.1 877.0 888.0 901.5 946.5 990.3 17019.4 18757.0 20056.7 20310.4 20791.4 931.1 966.5 977.0 978.4 985.8 9692.4 10773.7 10987.9 11020.1 11041.2 545890.0 546152.0 550323.0 551218.0 557736.0 118041.4 118798.8 118882.0 120182.8 120236.4 978.9 1026.5 1028.6 1060.3 1087.0 17656.2 17932.0 18046.9 18087.4 18688.3 36578.0 36657.6 46715.8 47408.1 47764.5 45280.0 63811.0 64180.7 64611.7 64792.0 8033.3 8041.6 8128.8 8153.6 8407.0 11858.6 11994.8 12771.0 12904.6 13242.3 9553.4 10906.9 11328.8 11601.8 11615.4 8457.4 9930.8 10366.3 11161.2 11280.9 11390.0 11552.9 11621.2 11699.0 11747.7 7637.3 8086.0 8220.0 8269.9 8493.7 9643.9 10965.9 11231.4 11326.3 11341.5 06:28:04 INFO - PROCESS | 1662 | 06:28:04 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:5614.23 Median:4997.04 stddev:3101.80 (62.1%) stddev-sans-first:3094.19 06:28:04 INFO - PROCESS | 1662 | Values: 1380.8 1610.8 1618.6 1863.8 1969.7 7389.2 7709.3 8523.9 8714.5 8744.7 8361.0 8582.8 8593.5 8605.2 8624.3 2416.8 2459.1 2460.4 2460.6 2463.3 2381.4 2434.1 2438.6 2438.6 2443.7 2417.6 2438.5 2448.4 2451.2 2451.5 2385.2 2410.6 2412.5 2413.1 2442.4 2375.6 2417.1 2421.1 2423.4 2424.2 8553.5 8568.7 8621.4 8629.5 8637.8 5258.8 5452.3 5470.3 5480.8 5501.8 3475.1 3593.1 3611.5 3636.0 3677.3 911.0 1005.4 1046.7 1047.1 1055.5 11446.5 11551.5 11560.4 11569.2 11577.7 4057.2 4533.5 4578.4 4667.5 4674.2 8189.6 8791.3 8991.6 9210.0 9214.6 5207.3 5232.6 5270.9 5276.0 5284.0 4202.3 4341.8 4363.9 4498.4 4888.4 3768.8 3833.2 3862.1 3868.5 3908.1 1188.4 1195.6 1198.1 1205.7 1214.6 888.1 903.4 912.5 915.4 936.1 5652.4 5957.9 5977.9 6046.8 6129.3 697.4 912.8 929.5 969.3 971.9 3763.1 3832.8 3864.1 3946.9 3955.2 10175.6 10385.4 10428.8 10466.5 10604.6 10492.5 10629.9 10658.8 10754.7 10879.9 7352.4 7953.6 8043.8 8290.3 8421.2 5696.5 5783.1 5828.7 5879.7 5972.6 8639.6 10124.2 10184.1 10200.9 10237.1 8089.2 9920.8 10169.5 10257.4 10268.7 6422.0 6640.2 6882.8 7014.6 7088.9 8319.1 8327.0 8424.4 8433.4 8433.8 7178.5 7416.6 7437.6 7460.4 7486.9 7223.8 7288.6 7317.5 7396.3 7475.1 7032.6 7082.3 7133.8 7136.5 7138.2 4758.9 4836.9 4999.5 5019.5 5112.3 4931.5 4984.8 4994.6 5050.8 5051.3 06:28:04 INFO - PROCESS | 1662 | 06:28:04 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:4467.52 Median:4870.71 stddev:1364.94 (28.0%) stddev-sans-first:1332.23 06:28:04 INFO - PROCESS | 1662 | Values: 287.9 320.4 326.1 326.4 331.2 4257.8 4653.0 5189.5 5222.6 5247.4 4003.8 4842.7 5163.4 5186.7 5209.8 2972.6 3522.9 3851.7 3932.6 4016.3 3952.6 3983.3 4003.5 4007.4 4048.6 3955.7 3970.7 3978.4 3990.8 3993.9 3152.9 3354.8 3590.8 3767.5 3792.8 3480.7 3510.8 3512.0 3521.5 3522.4 4093.4 4997.3 4999.6 5009.5 5019.0 3908.5 4216.2 4363.8 4604.3 4649.2 4465.8 4554.1 5362.5 5431.1 5463.2 3642.6 3736.4 3861.2 3871.4 3872.0 4716.8 4835.2 4914.1 5408.2 5701.8 3606.7 3917.2 3941.6 3945.5 3958.5 3982.6 4008.8 4012.2 4014.3 4016.6 4551.5 4566.6 4568.2 4570.7 4592.5 4820.7 5299.0 5434.5 5501.6 5541.8 1413.1 1455.4 1473.0 1473.3 1481.5 923.0 962.8 999.3 1003.7 1003.8 5223.5 5357.9 5402.8 5411.6 5438.5 5481.3 5623.1 5669.6 5683.3 5980.0 4874.8 4898.3 5122.4 5123.4 5151.7 2836.4 2878.2 3143.1 3252.8 3260.1 5962.6 6173.1 6449.2 6481.6 6492.3 4573.5 5821.6 5838.8 5841.7 5844.9 4556.9 5234.8 5956.0 5970.8 6134.6 4865.6 5393.3 5642.9 5712.3 5746.1 5407.9 5630.4 5636.3 5659.6 5723.2 5550.3 5614.2 5950.7 5986.3 6007.8 2991.9 3139.8 3843.7 3851.9 3909.5 4682.5 5100.9 5256.8 5669.4 5669.9 4551.5 4768.0 5344.9 5502.8 5523.9 5140.8 5454.2 5490.3 5495.4 5508.7 4636.0 5302.9 5346.3 5348.6 5351.2 4353.2 4869.6 4871.8 5600.0 5647.5 5482.8 5504.2 5511.0 5522.6 5544.7 06:28:04 INFO - PROCESS | 1662 | 06:28:04 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:17393.89 Median:70340.77 stddev:24943.30 (35.5%) stddev-sans-first:24981.65 06:28:04 INFO - PROCESS | 1662 | Values: 666.0 700.8 723.5 747.6 752.5 14623.4 15066.9 15113.8 15115.7 15135.8 13852.0 13911.2 13922.7 13925.6 13942.8 692.4 712.4 877.1 885.4 918.1 883.7 917.5 920.7 921.3 925.6 921.7 974.2 974.7 975.3 976.2 744.6 926.5 936.3 967.0 968.7 717.7 717.8 718.3 719.9 720.5 11680.8 11704.4 11723.2 11723.7 11754.6 11990.0 12112.8 12170.6 12524.3 12566.2 9898.9 10065.6 10069.7 10142.8 10751.8 3105.4 3153.6 3176.9 3189.0 3236.4 62232.0 79633.6 80086.6 81312.6 82031.6 9006.5 9360.6 9461.1 9657.3 9745.3 20282.2 20322.3 20595.6 20620.4 20638.6 6295.7 7324.5 7407.4 7440.8 7520.4 4140.4 4149.8 4271.5 4288.1 4344.8 3470.9 3542.6 3549.9 3550.5 3556.6 649.1 665.9 669.4 670.8 674.9 523.4 531.5 549.6 559.2 578.6 7664.4 7723.3 7790.5 7919.8 7941.4 487.6 507.5 531.1 574.0 588.3 3201.5 3480.2 3688.4 3708.1 3720.6 87459.0 88155.6 90254.6 90312.0 93555.0 65743.0 65752.0 76517.0 78877.0 81640.0 70081.6 70599.9 70622.6 71201.0 71635.3 7336.3 7388.1 7406.1 7433.6 7482.3 43563.6 43944.0 44643.6 44703.6 47100.0 65195.7 66227.3 66468.3 66491.0 66702.7 9367.5 9423.1 9609.0 9743.6 9857.7 10202.2 10362.2 10426.3 10499.1 10891.4 9844.0 9883.0 9934.0 10087.5 10157.7 9487.6 9790.7 9883.2 9909.8 10660.0 9624.5 9708.8 9761.3 9766.8 10339.0 8275.7 8342.3 8409.7 8507.7 8627.5 8217.3 8248.1 8350.5 8707.3 9508.0 06:28:04 INFO - PROCESS | 1662 | -------- Summary: end -------- 06:28:04 INFO - PROCESS | 1662 | 06:28:05 INFO - TEST-INFO | 1662: exit 0 06:28:05 INFO - TEST-OK | dromaeo_css | took 1115008ms 06:28:05 INFO - TEST-START | kraken 06:28:05 INFO - operating with platform_type : mac_ 06:28:05 INFO - Initialising browser for kraken test... 06:28:05 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/tmpzi5uRa/profile http://localhost:49270/getInfo.html) 06:28:07 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 06:28:07 INFO - PROCESS | 1669 | colorDepth:24 06:28:07 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 06:28:07 INFO - PROCESS | 1669 | __metrics 06:28:07 INFO - PROCESS | 1669 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:28:07 ERROR - PROCESS | 1669 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:28:08 INFO - TEST-INFO | 1669: exit 0 06:28:08 INFO - Browser initialized. 06:28:08 INFO - Running cycle 1/1 for kraken test... 06:28:08 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/tmpzi5uRa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:28:20 INFO - PROCESS | 1671 | RSS: Main: 239943680 06:28:20 INFO - PROCESS | 1671 | 06:28:22 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 06:28:23 INFO - PROCESS | 1671 | RSS: Main: 287780864 06:28:23 INFO - PROCESS | 1671 | 06:28:26 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 06:28:27 INFO - PROCESS | 1671 | RSS: Main: 300744704 06:28:27 INFO - PROCESS | 1671 | 06:28:30 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 06:28:31 INFO - PROCESS | 1671 | RSS: Main: 389156864 06:28:31 INFO - PROCESS | 1671 | 06:28:33 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 06:28:33 INFO - PROCESS | 1671 | RSS: Main: 287797248 06:28:33 INFO - PROCESS | 1671 | 06:28:36 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:28:36 INFO - PROCESS | 1671 | RSS: Main: 293408768 06:28:36 INFO - PROCESS | 1671 | 06:28:39 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 06:28:40 INFO - PROCESS | 1671 | RSS: Main: 331034624 06:28:40 INFO - PROCESS | 1671 | 06:28:42 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 06:28:43 INFO - PROCESS | 1671 | RSS: Main: 331767808 06:28:43 INFO - PROCESS | 1671 | 06:28:46 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 06:28:47 INFO - PROCESS | 1671 | RSS: Main: 329019392 06:28:47 INFO - PROCESS | 1671 | 06:28:48 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:28:49 INFO - PROCESS | 1671 | RSS: Main: 322560000 06:28:49 INFO - PROCESS | 1671 | 06:28:51 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:28:51 INFO - PROCESS | 1671 | RSS: Main: 329515008 06:28:51 INFO - PROCESS | 1671 | 06:28:53 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:28:54 INFO - PROCESS | 1671 | RSS: Main: 331354112 06:28:54 INFO - PROCESS | 1671 | 06:28:57 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:28:58 INFO - PROCESS | 1671 | RSS: Main: 335958016 06:28:58 INFO - PROCESS | 1671 | 06:29:00 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:29:01 INFO - PROCESS | 1671 | RSS: Main: 333660160 06:29:01 INFO - PROCESS | 1671 | 06:29:03 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 06:29:03 INFO - PROCESS | 1671 | RSS: Main: 397660160 06:29:03 INFO - PROCESS | 1671 | 06:29:03 INFO - PROCESS | 1671 | __start_tp_report 06:29:03 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 06:29:03 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 06:29:03 INFO - PROCESS | 1671 | |i|pagename|runs| 06:29:03 INFO - PROCESS | 1671 | |0;ai-astar;113;110;108;113;114;113;112;113;102;113 06:29:03 INFO - PROCESS | 1671 | |1;audio-beat-detection;160;128;183;210;119;141;168;148;213;120 06:29:03 INFO - PROCESS | 1671 | |2;audio-dft;184;183;186;185;186;185;185;181;193;257 06:29:03 INFO - PROCESS | 1671 | |3;audio-fft;75;74;85;89;58;56;60;81;85;48 06:29:03 INFO - PROCESS | 1671 | |4;audio-oscillator;96;102;140;78;81;77;133;117;121;155 06:29:03 INFO - PROCESS | 1671 | |5;imaging-gaussian-blur;88;85;89;85;86;85;88;86;89;84 06:29:03 INFO - PROCESS | 1671 | |6;imaging-darkroom;93;93;92;93;93;93;93;94;93;93 06:29:03 INFO - PROCESS | 1671 | |7;imaging-desaturate;86;86;83;85;83;100;135;130;87;85 06:29:03 INFO - PROCESS | 1671 | |8;json-parse-financial;62;58;59;59;58;58;60;80;58;58 06:29:03 INFO - PROCESS | 1671 | |9;json-stringify-tinderbox;64;72;63;76;71;68;67;69;67;72 06:29:03 INFO - PROCESS | 1671 | |10;stanford-crypto-aes;84;83;82;82;81;81;83;81;84;83 06:29:03 INFO - PROCESS | 1671 | |11;stanford-crypto-ccm;140;128;148;154;145;137;136;134;175;134 06:29:03 INFO - PROCESS | 1671 | |12;stanford-crypto-pbkdf2;169;168;170;173;167;230;167;180;179;168 06:29:03 INFO - PROCESS | 1671 | |13;stanford-crypto-sha256-iterative;68;69;70;71;68;67;85;93;100;98 06:29:03 INFO - PROCESS | 1671 | __end_tp_report 06:29:03 INFO - PROCESS | 1671 | __start_cc_report 06:29:03 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,1999 06:29:03 INFO - PROCESS | 1671 | __end_cc_report 06:29:03 INFO - PROCESS | 1671 | __startTimestamp1461677343637__endTimestamp 06:29:03 INFO - PROCESS | 1671 | 06:29:03 INFO - PROCESS | 1671 | ------- Summary: start ------- 06:29:03 INFO - PROCESS | 1671 | Number of tests: 14 06:29:03 INFO - PROCESS | 1671 | 06:29:03 INFO - PROCESS | 1671 | [#0] ai-astar Cycles:10 Average:111.10 Median:113.00 stddev:3.67 (3.2%) stddev-sans-first:3.82 06:29:03 INFO - PROCESS | 1671 | Values: 113.0 110.0 108.0 113.0 114.0 113.0 112.0 113.0 102.0 113.0 06:29:03 INFO - PROCESS | 1671 | 06:29:03 INFO - PROCESS | 1671 | [#1] audio-beat-detection Cycles:10 Average:159.00 Median:164.00 stddev:34.48 (21.0%) stddev-sans-first:36.57 06:29:03 INFO - PROCESS | 1671 | Values: 160.0 128.0 183.0 210.0 119.0 141.0 168.0 148.0 213.0 120.0 06:29:03 INFO - PROCESS | 1671 | 06:29:03 INFO - PROCESS | 1671 | [#2] audio-dft Cycles:10 Average:192.50 Median:185.50 stddev:22.87 (12.3%) stddev-sans-first:24.05 06:29:03 INFO - PROCESS | 1671 | Values: 184.0 183.0 186.0 185.0 186.0 185.0 185.0 181.0 193.0 257.0 06:29:03 INFO - PROCESS | 1671 | 06:29:03 INFO - PROCESS | 1671 | [#3] audio-fft Cycles:10 Average:71.10 Median:78.00 stddev:14.47 (18.6%) stddev-sans-first:15.28 06:29:03 INFO - PROCESS | 1671 | Values: 75.0 74.0 85.0 89.0 58.0 56.0 60.0 81.0 85.0 48.0 06:29:03 INFO - PROCESS | 1671 | 06:29:03 INFO - PROCESS | 1671 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:116.00 stddev:27.56 (23.8%) stddev-sans-first:28.77 06:29:03 INFO - PROCESS | 1671 | Values: 96.0 102.0 140.0 78.0 81.0 77.0 133.0 117.0 121.0 155.0 06:29:03 INFO - PROCESS | 1671 | 06:29:03 INFO - PROCESS | 1671 | [#5] imaging-gaussian-blur Cycles:10 Average:86.50 Median:87.00 stddev:1.84 (2.1%) stddev-sans-first:1.87 06:29:03 INFO - PROCESS | 1671 | Values: 88.0 85.0 89.0 85.0 86.0 85.0 88.0 86.0 89.0 84.0 06:29:03 INFO - PROCESS | 1671 | 06:29:03 INFO - PROCESS | 1671 | [#6] imaging-darkroom Cycles:10 Average:93.00 Median:93.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 06:29:03 INFO - PROCESS | 1671 | Values: 93.0 93.0 92.0 93.0 93.0 93.0 93.0 94.0 93.0 93.0 06:29:03 INFO - PROCESS | 1671 | 06:29:03 INFO - PROCESS | 1671 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:85.00 stddev:19.87 (23.4%) stddev-sans-first:20.75 06:29:03 INFO - PROCESS | 1671 | Values: 86.0 86.0 83.0 85.0 83.0 100.0 135.0 130.0 87.0 85.0 06:29:03 INFO - PROCESS | 1671 | 06:29:03 INFO - PROCESS | 1671 | [#8] json-parse-financial Cycles:10 Average:61.00 Median:59.00 stddev:6.80 (11.5%) stddev-sans-first:7.20 06:29:03 INFO - PROCESS | 1671 | Values: 62.0 58.0 59.0 59.0 58.0 58.0 60.0 80.0 58.0 58.0 06:29:03 INFO - PROCESS | 1671 | 06:29:03 INFO - PROCESS | 1671 | [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:70.00 stddev:3.96 (5.7%) stddev-sans-first:3.78 06:29:03 INFO - PROCESS | 1671 | Values: 64.0 72.0 63.0 76.0 71.0 68.0 67.0 69.0 67.0 72.0 06:29:03 INFO - PROCESS | 1671 | 06:29:03 INFO - PROCESS | 1671 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:83.00 stddev:1.17 (1.4%) stddev-sans-first:1.09 06:29:03 INFO - PROCESS | 1671 | Values: 84.0 83.0 82.0 82.0 81.0 81.0 83.0 81.0 84.0 83.0 06:29:03 INFO - PROCESS | 1671 | 06:29:03 INFO - PROCESS | 1671 | [#11] stanford-crypto-ccm Cycles:10 Average:143.10 Median:142.50 stddev:13.56 (9.5%) stddev-sans-first:14.34 06:29:03 INFO - PROCESS | 1671 | Values: 140.0 128.0 148.0 154.0 145.0 137.0 136.0 134.0 175.0 134.0 06:29:03 INFO - PROCESS | 1671 | 06:29:03 INFO - PROCESS | 1671 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.10 Median:171.50 stddev:19.19 (11.2%) stddev-sans-first:20.12 06:29:03 INFO - PROCESS | 1671 | Values: 169.0 168.0 170.0 173.0 167.0 230.0 167.0 180.0 179.0 168.0 06:29:03 INFO - PROCESS | 1671 | 06:29:03 INFO - PROCESS | 1671 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.90 Median:70.50 stddev:13.60 (19.3%) stddev-sans-first:13.84 06:29:03 INFO - PROCESS | 1671 | Values: 68.0 69.0 70.0 71.0 68.0 67.0 85.0 93.0 100.0 98.0 06:29:03 INFO - PROCESS | 1671 | -------- Summary: end -------- 06:29:03 INFO - PROCESS | 1671 | 06:29:04 INFO - TEST-INFO | 1671: exit 0 06:29:04 INFO - TEST-OK | kraken | took 59064ms 06:29:04 INFO - SUITE-END | took 1174s 06:29:04 INFO - Completed test suite (00:19:34) 06:29:04 INFO - javascript benchmark 06:29:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3414.7438942079343, 3460.429029210182, 3468.167639766456, 3492.8602855885765, 3527.2945410917805, 5692.174634677979, 5730.197772311874, 5733.684647344395, 5749.712514374285, 5751.90713764385, 5748.166515855199, 5754.712264386774, 5786.132080187964, 5911.46796788289, 5912.615679980799, 5027.271045698371, 5065.974670126644, 5091.363579552556, 5102.948970510303, 5160.92258616121, 5188.558972487343, 5192.896142077157, 5200.6879587224885, 5255.343082114736, 5278.340207474066, 5061.746912654371, 5116.897662046776, 5154.278401023859, 5173.974130129344, 5175.146100893348, 4593.012502312019, 4927.7536123193695, 5124.948750512484, 5190.455002224788, 5193.610479214074, 5087.745612719349, 5140.228965655144, 5150.587952963754, 5152.330197074394, 5201.141811601081, 5481.506664400184, 5640.182173584807, 5656.858578535528, 5669.376368599451, 5675.318961724578, 6146.0473626587955, 6181.567290289681, 6227.377262273736, 6257.43683068526, 6264.498840092781, 6196.473299769525, 6245.6252624842655, 6267.185265915447, 6275.623462592259, 6285.120083188357, 5598.804041858515, 5737.254156959569, 5738.368779434259, 5745.965726169288, 5749.108888122348, 6203.4416902479, 6251.3123556408755, 6272.8118156455375, 6289.371062893674, 6299.023651334051, 5108.157154069537, 6052.962177676085, 6084.574079814459, 6200.0, 6210.844728881814, 6202.100695399142, 6217.626942383471, 6255.0617407388345, 6258.468030217391, 6296.779612713533, 6058.182145410401, 6259.092431597484, 6266.373362663697, 6274.0, 6276.6547839868335, 6121.727351053096, 6160.691965401712, 6215.595986260879, 6265.0, 6416.35836416364, 4938.975305123451, 4944.703317800943, 4950.331705219821, 4957.752112394366, 4961.8511444656715, 4329.653627709776, 4397.362382454527, 4403.9559604404185, 4436.245838207513, 4444.888877778081, 5562.276904002454, 5590.049691552445, 5605.0, 5606.355269144019, 5608.270924779834, 6177.660228687376, 6208.565400422018, 6226.782062627786, 6229.813105606839, 6238.500919926395, 5560.944390556124, 5645.633033852869, 5649.265595472644, 5657.264555607827, 5709.400512946164, 5310.389305229948, 5355.518003379637, 5369.7583608737705, 5371.892562148813, 5381.596380271495, 6225.719842607094, 6250.843728906813, 6261.373862613793, 6266.624002559861, 6314.305426403183, 6226.59527130735, 6269.0, 6276.215473065867, 6277.843053923689, 6280.874382512416, 6276.811695649138, 6313.40022697843, 6326.367363263636, 6342.52431067681, 6350.714217860115, 6084.33072362031, 6112.442689633789, 6175.4750846176785, 6205.441510263918, 6231.844203894758, 6261.530385221217, 6266.811995640138, 6267.498600111889, 6270.623762574261, 6289.465395441439, 5933.3769954154195, 6095.05526643371, 6103.0, 6115.7247923844425, 6142.32434432221, 5791.884162316815, 5856.033754430471, 5917.881642367214, 5924.31870334917, 5929.495992840657, 5859.384764599656, 5865.970670146622, 5895.20414744004, 5943.108533719977, 5974.910376344272, 6082.482988945812, 6127.938720612915, 6133.02189081539, 6137.048757442425, 6147.84630384244, 5763.6541807491685, 5898.144769008384, 5952.5237980960555, 5954.940450595439, 5956.315023772148], "value": 5677.407867604438, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [526.581367812589, 535.7187476574798, 566.3769853161522, 583.5710752596843, 617.80539130174, 28313.150605481842, 31374.843125784366, 40946.18107637849, 41468.0, 41556.79221603888, 45040.549594504046, 45690.543094569046, 45786.771066144705, 45888.54111458884, 45977.540224597746, 9626.518674066303, 9879.06148915852, 9882.555285012191, 9883.802323953516, 9887.752806179831, 9652.613895444174, 9827.164691001273, 9830.361026533288, 9830.950845245763, 9844.212463002943, 9794.657186998456, 9859.161971232454, 9871.259655525828, 9871.358361706467, 9885.209183265357, 9677.322587418883, 9738.0, 9803.558839852223, 9808.90191098087, 9816.558254878548, 9637.18083962857, 9741.805163896683, 9745.463999480025, 9749.756256093584, 9766.193254247915, 41290.587094129274, 41839.0, 41844.79077604593, 41933.0, 42010.78994605008, 2917.092886904015, 3229.241128334863, 3250.512423136525, 3433.0, 4029.6574791142493, 27225.45549089007, 28064.438711225663, 28598.857005715046, 28637.85681071602, 30558.69441305603, 2679.42392385638, 2735.7948153888537, 2769.75072243497, 2829.8868045278164, 2880.5823155642315, 371112.0, 483250.167498324, 489542.0, 489787.0, 490125.0, 65895.34104658988, 66698.0, 66758.66620666963, 66969.0, 67106.32893671098, 62472.687636562434, 63904.68047659732, 63981.0, 64009.0, 64071.0, 17032.2335494903, 17176.914115429343, 17297.0, 17306.913465432594, 17336.3065477382, 12993.675158121123, 13031.08782385243, 13058.804117938238, 13060.542880999119, 13067.150635208682, 19661.311854085037, 19952.401427957186, 19966.0, 19967.400977970683, 20358.28745993913, 6987.406070483964, 7371.483996120327, 8030.036395632562, 8138.43030987837, 8184.754457366289, 866.4887716247318, 915.6337465014047, 1025.2157099818644, 1082.1342925659442, 1171.9472623731951, 27656.446871062468, 28925.987590434233, 29158.0, 29871.43912323077, 30229.244268893453, 976.5605477534996, 1030.9742256443499, 1059.7297689089232, 1079.1600321451906, 1093.9671809845718, 15497.767533487007, 15557.066576005476, 15623.843761562239, 15642.568789162102, 15935.0, 667742.0, 673345.0, 682115.0, 683166.0, 683702.0, 56751.013714519795, 57759.4224057754, 61990.69004654948, 62807.743845122845, 62866.68566657137, 1316.7037416581384, 1350.8784209421199, 1433.304847149111, 1476.7489526780257, 1491.209658880795, 23621.0, 24257.0, 28757.568636470052, 29519.704802951695, 29546.704532954394, 49539.0, 49561.25658115059, 49884.50346489611, 50020.74989625029, 50041.24938126004, 380019.0, 382026.0, 382385.0, 382640.0, 383677.0, 20427.79572204259, 23592.17427390033, 23627.173048943205, 23674.28977130689, 26548.469030619664, 36807.711730089315, 37078.0, 41666.16667666569, 43719.34420983624, 44725.329120062575, 26315.868420657775, 29801.956931507295, 36116.45825312675, 36343.63656363403, 36968.63031369652, 27749.86125069362, 35725.821370892976, 35747.82126089353, 36457.453138202414, 36547.26905461929, 36353.09117271983, 37086.0, 37121.58709683862, 37349.62650373462, 37603.24793504169, 31682.207944801565, 32169.678303216668, 32201.677983219866, 32382.35235295328, 32511.674883250864, 23687.526249475257, 23881.761182387952, 24011.0, 24087.0, 24369.63445548283], "value": 19547.88688155093, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.6995328620319, 388.54346143281634, 391.3210579644318, 394.6522625234823, 401.34981330245006, 14171.626467833048, 19484.902575487136, 19904.0, 20195.192192312326, 20231.898840505793, 15804.525864224062, 17326.48020559382, 19989.400317990447, 20466.69299960498, 20739.585208295826, 5769.3076830780265, 5969.403059694039, 6001.48987336077, 6005.0, 6007.0, 5163.586913046966, 5597.776088956457, 5975.581709280352, 6051.909221361683, 6129.570930034899, 6063.9090413643835, 6091.2690477142805, 6100.664463454508, 6102.877942441149, 6109.786157484489, 6038.57729958903, 6120.785772497941, 6131.846703832395, 6137.232845894263, 6148.1392605035335, 4358.65130789536, 5209.947900520984, 5234.057869583474, 5245.79016839326, 5252.527272545489, 24569.38576535583, 25484.617730734055, 25640.358991025372, 25711.74288257112, 26982.73017269822, 1947.2308438166986, 2227.52108296717, 2430.927072187837, 2588.0, 2821.6049753034386, 9393.880335217324, 10320.432376219305, 13401.329933503286, 14521.709565808625, 15106.244687765568, 1719.17479609788, 1748.3094177799826, 1796.6316905034566, 1832.1205821205897, 1838.4025191812714, 109232.4538377303, 114403.0, 116034.0, 122210.77789222082, 123661.0, 11398.601048963246, 11611.477483513263, 11647.242929209575, 11653.766924661459, 11823.290602563873, 14883.553493395215, 14954.0, 14969.700605988037, 14982.250887455584, 14984.325705343286, 7498.0, 7520.849583008309, 8661.177188167114, 8710.433821801562, 8761.43050701715, 6855.417289530346, 8569.785755356166, 8615.138486151334, 8683.261922736512, 8685.305175585938, 4285.5071666758095, 4366.126774645084, 4549.520511321338, 4607.539246075433, 4638.631603676923, 1412.9576112716634, 1955.8435325173953, 1958.6278607064612, 1999.6500612392774, 2002.0690378973848, 876.9605367758467, 887.9911200888038, 901.535709109809, 946.5172761891347, 990.3166814897697, 17019.40432084871, 18756.96836673996, 20056.69914951277, 20310.390688279374, 20791.376258712262, 931.101487064972, 966.5360626898987, 976.9804603908024, 978.3933960944261, 985.7530224266309, 9692.386836414114, 10773.676789696321, 10987.890121098686, 11020.063294619888, 11041.227114101936, 545890.0, 546152.0, 550323.0, 551218.0, 557736.0, 118041.40979295221, 118798.81201188051, 118882.0, 120182.79817201891, 120236.39881800536, 978.9363691360039, 1026.4764969865273, 1028.6296933104077, 1060.2631171336002, 1086.9673909782719, 17656.20547075359, 17932.0, 18046.909765451615, 18087.36694215696, 18688.34590789316, 36578.0, 36657.63342366542, 46715.766421167675, 47408.051838963715, 47764.52235477601, 45280.0, 63811.0, 64180.67909660422, 64611.67694161499, 64792.02811957919, 8033.277005069572, 8041.557714325768, 8128.75613731589, 8153.633086511002, 8407.033191183093, 11858.644240672793, 11994.820077699016, 12771.0, 12904.612861614167, 13242.337883105998, 9553.426794392359, 10906.945465272624, 11328.830067548828, 11601.825972610586, 11615.361155136548, 8457.40798144124, 9930.816798515081, 10366.274360794974, 11161.162912781412, 11280.943595281971, 11390.0, 11552.884471155518, 11621.24461909973, 11699.0, 11747.706307342385, 7637.274458926393, 8086.0, 8219.95890020546, 8269.917300826915, 8493.702720404755, 9643.903560964582, 10965.945170274097, 11231.38227397501, 11326.32042077478, 11341.489632966372], "value": 9387.588844213484, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1380.8342998840128, 1610.8067031956164, 1618.6438983423645, 1863.832255097041, 1969.7242386065952, 7389.187189409161, 7709.3061624453785, 8523.87214191787, 8714.520701361422, 8744.650213991448, 8361.0, 8582.785430364243, 8593.484390936532, 8605.225529702326, 8624.310055195585, 2416.830821842472, 2459.1270099114827, 2460.3972026853444, 2460.6063029915217, 2463.322586288767, 2381.38084098134, 2434.087217293515, 2438.5732496813075, 2438.634204869266, 2443.6701045358827, 2417.5890098683176, 2438.4635380216414, 2448.4123810285582, 2451.1788550835404, 2451.460678650694, 2385.1651921827397, 2410.5660981023407, 2412.541617092764, 2413.1312727418117, 2442.38940264932, 2375.560521303564, 2417.129833260025, 2421.140495124223, 2423.3820375804057, 2424.151546958568, 8553.486790792573, 8568.742937711879, 8621.396502244845, 8629.482231066093, 8637.827243455158, 5258.81594144207, 5452.345718513764, 5470.343558772933, 5480.780768769245, 5501.779928802843, 3475.079104037432, 3593.1017245688577, 3611.5485564304463, 3636.0, 3677.3013127505687, 910.9863352049724, 1005.3666190300137, 1046.6598355534481, 1047.0733400940146, 1055.4617145255897, 11446.542138314457, 11551.480183391683, 11560.421978901022, 11569.190156689036, 11577.6526704199, 4057.208844275397, 4533.54664533544, 4578.404807375086, 4667.486576476585, 4674.158651442705, 8189.590520473953, 8791.340649451316, 8991.595378207996, 9210.03294654065, 9214.63141474347, 5207.297014903015, 5232.607554433433, 5270.894582108336, 5276.023935571855, 5284.0, 4202.285611446062, 4341.826326946887, 4363.890902727458, 4498.3927169832305, 4888.437829649564, 3768.7550309229814, 3833.195029043932, 3862.1117143057254, 3868.516435445569, 3908.1206728485863, 1188.4057971014493, 1195.5875223048035, 1198.1193822540426, 1205.69254840017, 1214.5991822698488, 888.1429420609143, 903.3947255338938, 912.452528482905, 915.4232833314969, 936.1410955032464, 5652.378238393773, 5957.851053723692, 5977.880442391215, 6046.848828779316, 6129.264488261348, 697.4385619576188, 912.7535565397305, 929.4748467116058, 969.3311614985637, 971.9222462203148, 3763.096856754359, 3832.827522761482, 3864.14988702485, 3946.861859834892, 3955.248502784462, 10175.592976281014, 10385.428801415994, 10428.791424171473, 10466.52900619474, 10604.628837990633, 10492.520321955652, 10629.89370106289, 10658.840117398246, 10754.677359679223, 10879.945600272107, 7352.448566357544, 7953.602319883983, 8043.83912321762, 8290.29532489733, 8421.15788421153, 5696.487316141567, 5783.103618938903, 5828.737706803289, 5879.676617786063, 5972.641641501524, 8639.568021598769, 10124.24068194903, 10184.083432491112, 10200.948995254976, 10237.078662920372, 8089.2315230053055, 9920.751981200528, 10169.491525423551, 10257.435841028517, 10268.743281418025, 6421.967890160519, 6640.169978752656, 6882.7591034315565, 7014.649267536704, 7088.929110708827, 8319.084900661044, 8327.0, 8424.368172387218, 8433.36749743784, 8433.789155271168, 7178.461615378972, 7416.592087435243, 7437.628118593941, 7460.440466964891, 7486.925130748623, 7223.783286501413, 7288.635568221462, 7317.524360916524, 7396.297351751575, 7475.0656167979005, 7032.648367581703, 7082.291770822876, 7133.750318739027, 7136.536125151849, 7138.214796372498, 4758.928616070692, 4836.903261934812, 4999.500049995117, 5019.472955339636, 5112.258722485144, 4931.457539670561, 4984.800607975641, 4994.575461085703, 5050.797968081236, 5051.267566202953], "value": 4536.755303396685, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.9064304101167, 320.3800645750473, 326.08858241215813, 326.3847647185056, 331.2084118955698, 4257.7658228797445, 4652.953470465294, 5189.532942035216, 5222.582193424517, 5247.396549396815, 4003.819828107735, 4842.733649649268, 5163.432022477534, 5186.7147306898105, 5209.817656382027, 2972.613560237166, 3522.9295414091766, 3851.7111216658723, 3932.5674175840636, 4016.297147999103, 3952.6245006724316, 3983.3427484465174, 4003.4595329630565, 4007.3988901664693, 4048.554658987509, 3955.6550772737264, 3970.6573121858096, 3978.4231286463446, 3990.7805070721097, 3993.941605474537, 3152.858121384543, 3354.815485148316, 3590.8204589770407, 3767.472553842464, 3792.8482860685676, 3480.6519348065244, 3510.7893526388243, 3511.9824400878088, 3521.4505617528207, 3522.4011917974008, 4093.385992101179, 4997.325361076245, 4999.625028122905, 5009.549140577329, 5019.0, 3908.4918960534947, 4216.208111552578, 4363.814415476688, 4604.309353596954, 4649.163580385729, 4465.82136714531, 4554.0891821635805, 5362.4637536246455, 5431.099115309649, 5463.235147079412, 3642.562892452923, 3736.4395340698843, 3861.1891502784447, 3871.4386413970096, 3871.9612803872164, 4716.764161791931, 4835.226363781778, 4914.11545921734, 5408.242846001563, 5701.77192912283, 3606.693431058337, 3917.2176659619804, 3941.6452519273403, 3945.467361906106, 3958.5447673517915, 3982.561918188997, 4008.7594744315434, 4012.1574469361763, 4014.2573623879675, 4016.6184212499766, 4551.52209018055, 4566.589006989387, 4568.1548913451115, 4570.65720070996, 4592.540745925381, 4820.68665536739, 5299.019681358961, 5434.483724046209, 5501.642393244426, 5541.806036788774, 1413.1168019987508, 1455.3523681961638, 1472.9705405891823, 1473.3001824133664, 1481.4814814814729, 922.9953850230706, 962.7929995051097, 999.2655398282257, 1003.6838395905412, 1003.7992401519725, 5223.503767142115, 5357.919631205535, 5402.837914862561, 5411.64824286428, 5438.510534051954, 5481.2874326338115, 5623.10030395143, 5669.55426366274, 5683.323419591231, 5979.970100149471, 4874.829380971649, 4898.338724272249, 5122.414309983027, 5123.436421993578, 5151.6908985461, 2836.3901761121047, 2878.208492664534, 3143.0885043337635, 3252.772305938609, 3260.136063943057, 5962.612430192024, 6173.135760993465, 6449.161608990895, 6481.611103333815, 6492.253390860112, 4573.519780423074, 5821.621594596338, 5838.766449341979, 5841.707914604338, 5844.94155058444, 4556.944319555598, 5234.7644356004075, 5956.0, 5970.76116955317, 6134.631922084689, 4865.6107511398295, 5393.325834270716, 5642.899634571219, 5712.257406537124, 5746.138079287973, 5407.945450637245, 5630.380658127685, 5636.267285252891, 5659.603827732184, 5723.227364305765, 5550.250716153268, 5614.203454894395, 5950.727100094844, 5986.2517185351835, 6007.8197654070445, 2991.865366058576, 3139.8273094979995, 3843.673287770571, 3851.942220866745, 3909.5113110861143, 4682.508336624742, 5100.948990510047, 5256.790938084338, 5669.4047125051275, 5669.922714684197, 4551.522090180616, 4768.0, 5344.893102137858, 5502.779888804403, 5523.861903452285, 5140.820071297636, 5454.209139674805, 5490.258815060076, 5495.395506494203, 5508.669479831223, 4635.966708963224, 5302.920456193083, 5346.331708536433, 5348.5988550858065, 5351.1973204019705, 4353.194658988097, 4869.6121605342305, 4871.805127794849, 5600.047991841316, 5647.548196144381, 5482.753276102665, 5504.22940788298, 5510.972445137749, 5522.5858060644805, 5544.7227638618715], "value": 4054.598473366265, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [665.9533832631712, 700.7792545348218, 723.5297056913007, 747.5888261456199, 752.4732687119018, 14623.415063397451, 15066.924665376686, 15113.848861511382, 15115.697686046286, 15135.772963405558, 13851.961102917296, 13911.165330080203, 13922.651933701662, 13925.582232533015, 13942.790858137136, 692.4149094015548, 712.4264966701803, 877.1184959116111, 885.4244740918423, 918.0635751533432, 883.7437143228456, 917.5274733512247, 920.6961702638147, 921.2814005076018, 925.5742358515091, 921.7142685767434, 974.1670871404953, 974.7465658928659, 975.2685485885586, 976.2190247801766, 744.57559191261, 926.4626516620344, 936.3211671538148, 967.0, 968.7384406210319, 717.6555253478307, 717.7846646006229, 718.270954980695, 719.9172095209066, 720.531654424623, 11680.766384672259, 11704.414779261004, 11723.179377443583, 11723.706907327385, 11754.647360579196, 11990.0, 12112.757744845141, 12170.57402990891, 12524.311162886037, 12566.246025238515, 9898.901010989943, 10065.647702330456, 10069.69790906274, 10142.797144057078, 10751.778695457517, 3105.3634005028916, 3153.595667545987, 3176.888808891678, 3188.9681103188905, 3236.449803533405, 62232.0, 79633.60183199105, 80086.59956700237, 81312.59343703302, 82031.58984205041, 9006.549672516348, 9360.578773955189, 9461.053894610484, 9657.275704322205, 9745.269104817167, 20282.188712451632, 20322.288719894732, 20595.58808823815, 20620.381388558366, 20638.58722825535, 6295.685215739195, 7324.487285889936, 7407.444441666897, 7440.813979650444, 7520.360769334558, 4140.399642051885, 4149.757300867349, 4271.530131685512, 4288.056627541998, 4344.761038142932, 3470.9479357809655, 3542.6103128655827, 3549.8580056797437, 3550.4851796489365, 3556.590992035897, 649.0685865782617, 665.9400653941168, 669.3707914560298, 670.7719375412286, 674.9021391898148, 523.426847601883, 531.5455285730644, 549.5850632772232, 559.2394343692575, 578.6094386289238, 7664.386849052063, 7723.266289702469, 7790.5325680459355, 7919.841603167904, 7941.444098913021, 487.55875932281344, 507.5406756885025, 531.1342511705894, 573.9827805165768, 588.2705445247948, 3201.4877619580757, 3480.164760457472, 3688.428293614494, 3708.1100535871196, 3720.6093360197333, 87459.0, 88155.55922220348, 90254.64618030735, 90312.0, 93555.0, 65743.0277091688, 65752.01371979424, 76517.0, 78877.0, 81640.0, 70081.59836803337, 70599.94100088502, 70622.64688676626, 71201.0, 71635.28364716285, 7336.30305121034, 7388.113426388868, 7406.1192650523135, 7433.591152486665, 7482.326590606872, 43563.56436435595, 43944.0, 44643.55356446524, 44703.55296446994, 47100.0, 65195.69608607896, 66227.34431639248, 66468.33531664622, 66491.0, 66702.6664866692, 9367.531623418938, 9423.069239681936, 9608.95195524018, 9743.61025558998, 9857.704268871945, 10202.21955549387, 10362.222833287382, 10426.27016108865, 10499.055085042382, 10891.400972946247, 9844.0, 9882.950585247316, 9933.950330248303, 10087.495625218857, 10157.746056348651, 9487.620495180116, 9790.706278811647, 9883.159931405911, 9909.752256193653, 10660.0, 9624.536756450725, 9708.805823883624, 9761.267904907303, 9766.75583110428, 10338.9661033896, 8275.710350137957, 8342.332613391036, 8409.663613455394, 8507.659693612186, 8627.482351058956, 8217.30152937007, 8248.092709802037, 8350.498970061815, 8707.3034157266, 9508.0], "value": 6527.111086570853, "unit": "score"}], "name": "dromaeo_css", "value": 7072.028634347633, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 110.0, 108.0, 113.0, 114.0, 113.0, 112.0, 113.0, 102.0, 113.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 128.0, 183.0, 210.0, 119.0, 141.0, 168.0, 148.0, 213.0, 120.0], "value": 159.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 183.0, 186.0, 185.0, 186.0, 185.0, 185.0, 181.0, 193.0, 257.0], "value": 192.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 85.0, 89.0, 58.0, 56.0, 60.0, 81.0, 85.0, 48.0], "value": 71.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 102.0, 140.0, 78.0, 81.0, 77.0, 133.0, 117.0, 121.0, 155.0], "value": 110.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 89.0, 85.0, 86.0, 85.0, 88.0, 86.0, 89.0, 84.0], "value": 86.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 92.0, 93.0, 93.0, 93.0, 93.0, 94.0, 93.0, 93.0], "value": 93.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 83.0, 85.0, 83.0, 100.0, 135.0, 130.0, 87.0, 85.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 58.0, 59.0, 59.0, 58.0, 58.0, 60.0, 80.0, 58.0, 58.0], "value": 61.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 72.0, 63.0, 76.0, 71.0, 68.0, 67.0, 69.0, 67.0, 72.0], "value": 68.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 82.0, 82.0, 81.0, 81.0, 83.0, 81.0, 84.0, 83.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 128.0, 148.0, 154.0, 145.0, 137.0, 136.0, 134.0, 175.0, 134.0], "value": 143.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 168.0, 170.0, 173.0, 167.0, 230.0, 167.0, 180.0, 179.0, 168.0], "value": 177.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 70.0, 71.0, 68.0, 67.0, 85.0, 93.0, 100.0, 98.0], "value": 78.9, "unit": "score"}], "name": "kraken", "value": 1530.6000000000001, "alertThreshold": 2.0}]} 06:29:04 INFO - Return code: 0 06:29:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:29:04 ERROR - # TBPL SUCCESS # 06:29:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:29:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:29:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:29:04 INFO - 2016-04-26 06:29:04.914 screenresolution[1675:10065] starting screenresolution argv=screenresolution get 06:29:04 INFO - 2016-04-26 06:29:04.916 screenresolution[1675:10065] Display 0: 1600x1200x32@60 06:29:04 INFO - 2016-04-26 06:29:04.922 screenresolution[1676:10068] starting screenresolution argv=screenresolution list 06:29:04 INFO - Available Modes on Display 0 06:29:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:29:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:29:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:29:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:29:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:29:05 INFO - Intel Iris: 06:29:05 INFO - Chipset Model: Intel Iris 06:29:05 INFO - Type: GPU 06:29:05 INFO - Bus: Built-In 06:29:05 INFO - VRAM (Dynamic, Max): 1536 MB 06:29:05 INFO - Vendor: Intel (0x8086) 06:29:05 INFO - Device ID: 0x0a2e 06:29:05 INFO - Revision ID: 0x0009 06:29:05 INFO - Displays: 06:29:05 INFO - Display: 06:29:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:29:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:29:05 INFO - Display Serial Number: 1600x1200 60 06:29:05 INFO - Main Display: Yes 06:29:05 INFO - Mirror: Off 06:29:05 INFO - Online: Yes 06:29:05 INFO - Rotation: Supported 06:29:05 INFO - Return code: 0 06:29:05 INFO - Running post-action listener: _resource_record_post_action 06:29:05 INFO - Running post-run listener: _resource_record_post_run 06:29:06 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 31993344; Write bytes: 694579200; Read time: 368; Write time: 1929 06:29:06 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 384723456; Write bytes: 379926016; Read time: 28366; Write time: 767 06:29:06 INFO - run-tests - Wall time: 1176s; CPU: 53.0%; Read bytes: 30203392; Write bytes: 294808064; Read time: 348; Write time: 1098 06:29:06 INFO - Running post-run listener: _upload_blobber_files 06:29:06 INFO - Blob upload gear active. 06:29:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:29:06 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:29:06 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'] 06:29:06 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 06:29:06 INFO - (blobuploader) - INFO - Open directory for files ... 06:29:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:29:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:29:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:29:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:29:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:29:07 INFO - (blobuploader) - INFO - Done attempting. 06:29:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:29:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:29:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:29:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:29:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:29:08 INFO - (blobuploader) - INFO - Done attempting. 06:29:08 INFO - (blobuploader) - INFO - Iteration through files over. 06:29:08 INFO - Return code: 0 06:29:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:29:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:29:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/83f04edd6c107b8311c0f860d841f3d61fcba8e4a0fa530845c0d7c332dce78bd50dd717e135052739091a786188152f27ce09c927766cc26d17ca72443ea89d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9bd0f36dd2d00045e6b557bad45bf57a30d9a9fcf902286d439daf9ace70cc9008e86c3829c419183d388e1fe50acd64f5d4539a5f297fc3278da41b06e4cbe0"} 06:29:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:29:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:29:08 INFO - Contents: 06:29:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/83f04edd6c107b8311c0f860d841f3d61fcba8e4a0fa530845c0d7c332dce78bd50dd717e135052739091a786188152f27ce09c927766cc26d17ca72443ea89d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9bd0f36dd2d00045e6b557bad45bf57a30d9a9fcf902286d439daf9ace70cc9008e86c3829c419183d388e1fe50acd64f5d4539a5f297fc3278da41b06e4cbe0"} 06:29:08 INFO - Running post-run listener: copy_logs_to_upload_dir 06:29:08 INFO - Copying logs to upload dir... 06:29:08 INFO - mkdir: /builds/slave/test/build/upload/logs 06:29:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.214469 ========= master_lag: 2.47 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-04-26 06:29:11.165489) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-04-26 06:29:11.172541) ========= 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.m5XGvcNFjW/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.F4tYyMI6qr/Listeners TMPDIR=/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/83f04edd6c107b8311c0f860d841f3d61fcba8e4a0fa530845c0d7c332dce78bd50dd717e135052739091a786188152f27ce09c927766cc26d17ca72443ea89d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9bd0f36dd2d00045e6b557bad45bf57a30d9a9fcf902286d439daf9ace70cc9008e86c3829c419183d388e1fe50acd64f5d4539a5f297fc3278da41b06e4cbe0"} build_url:https://queue.taskcluster.net/v1/task/Eu8_xST7TPa5AhsFpX-CjQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011382 build_url: 'https://queue.taskcluster.net/v1/task/Eu8_xST7TPa5AhsFpX-CjQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/83f04edd6c107b8311c0f860d841f3d61fcba8e4a0fa530845c0d7c332dce78bd50dd717e135052739091a786188152f27ce09c927766cc26d17ca72443ea89d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9bd0f36dd2d00045e6b557bad45bf57a30d9a9fcf902286d439daf9ace70cc9008e86c3829c419183d388e1fe50acd64f5d4539a5f297fc3278da41b06e4cbe0"}' ========= master_lag: 1.45 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-04-26 06:29:12.629762) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 06:29:12.630091) ========= 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.m5XGvcNFjW/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.F4tYyMI6qr/Listeners TMPDIR=/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/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.005211 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 06:29:12.681870) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 06:29:12.682203) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 06:29:12.686615) ========= ========= Total master_lag: 5.65 =========