builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0025 starttime: 1467032268.8 results: success (0) buildid: 20160624143557 builduid: 67b95f07284347e7aea2678b4c3b20e6 revision: 229741b7de0485ca56b91e0e657fe5d37dbbc98f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:48.806407) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:48.809851) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:48.810137) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:48.852019) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:48.852270) ========= 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.l07cEfk3CL/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.t31DGEV9O6/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-06-27 05:57:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.9M=0.001s 2016-06-27 05:57:49 (14.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.617195 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:49.491346) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:49.491618) ========= 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.l07cEfk3CL/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.t31DGEV9O6/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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.027111 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:49.541019) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:49.541359) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 229741b7de0485ca56b91e0e657fe5d37dbbc98f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 229741b7de0485ca56b91e0e657fe5d37dbbc98f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.l07cEfk3CL/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.t31DGEV9O6/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-06-27 05:57:49,622 truncating revision to first 12 chars 2016-06-27 05:57:49,622 Setting DEBUG logging. 2016-06-27 05:57:49,622 attempt 1/10 2016-06-27 05:57:49,622 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/229741b7de04?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 05:57:50,277 unpacking tar archive at: mozilla-beta-229741b7de04/testing/mozharness/ program finished with exit code 0 elapsedTime=0.917723 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:50.483553) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:50.483868) ========= script_repo_revision: 229741b7de0485ca56b91e0e657fe5d37dbbc98f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:50.484239) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:50.484501) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:50.502535) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-06-27 05:57:50.502939) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.l07cEfk3CL/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.t31DGEV9O6/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 05:57:50 INFO - MultiFileLogger online at 20160627 05:57:50 in /builds/slave/test 05:57:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 05:57:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:57:50 INFO - {'append_to_log': False, 05:57:50 INFO - 'base_work_dir': '/builds/slave/test', 05:57:50 INFO - 'blob_upload_branch': 'Mozilla-Beta', 05:57:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:57:50 INFO - 'branch': 'Mozilla-Beta', 05:57:50 INFO - 'buildbot_json_path': 'buildprops.json', 05:57:50 INFO - 'config_files': ('talos/mac_config.py',), 05:57:50 INFO - 'default_actions': ('clobber', 05:57:50 INFO - 'read-buildbot-config', 05:57:50 INFO - 'download-and-extract', 05:57:50 INFO - 'populate-webroot', 05:57:50 INFO - 'create-virtualenv', 05:57:50 INFO - 'install', 05:57:50 INFO - 'run-tests'), 05:57:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:57:50 INFO - 'download_minidump_stackwalk': True, 05:57:50 INFO - 'download_symbols': 'ondemand', 05:57:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:57:50 INFO - 'tooltool.py': '/tools/tooltool.py', 05:57:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:57:50 INFO - '/tools/misc-python/virtualenv.py')}, 05:57:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:57:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:57:50 INFO - 'installer_path': 'installer.exe', 05:57:50 INFO - 'log_level': 'info', 05:57:50 INFO - 'log_name': 'talos', 05:57:50 INFO - 'log_to_console': True, 05:57:50 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:57:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:57:50 INFO - 'opt_config_files': (), 05:57:50 INFO - 'pip_index': False, 05:57:50 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:57:50 INFO - 'cmd': ('bash', 05:57:50 INFO - '-c', 05:57:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:57:50 INFO - 'enabled': True, 05:57:50 INFO - 'halt_on_failure': False, 05:57:50 INFO - 'name': 'check_screen_resolution'},), 05:57:50 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:57:50 INFO - 'cmd': ('bash', 05:57:50 INFO - '-c', 05:57:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:57:50 INFO - 'enabled': True, 05:57:50 INFO - 'halt_on_failure': False, 05:57:50 INFO - 'name': 'check_screen_resolution'},), 05:57:50 INFO - 'run_cmd_checks_enabled': True, 05:57:50 INFO - 'sps_profile': False, 05:57:50 INFO - 'sps_profile_interval': 0, 05:57:50 INFO - 'suite': 'dromaeojs-e10s', 05:57:50 INFO - 'system_bits': '32', 05:57:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:57:50 INFO - 'title': 't-yosemite-r7-0025', 05:57:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:57:50 INFO - 'use_talos_json': True, 05:57:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:57:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:57:50 INFO - 'work_dir': 'build'} 05:57:50 INFO - ##### 05:57:50 INFO - ##### Running clobber step. 05:57:50 INFO - ##### 05:57:50 INFO - Running pre-action listener: _resource_record_pre_action 05:57:50 INFO - Running main action method: clobber 05:57:50 INFO - rmtree: /builds/slave/test/build 05:57:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:57:52 INFO - Running post-action listener: _resource_record_post_action 05:57:52 INFO - ##### 05:57:52 INFO - ##### Running read-buildbot-config step. 05:57:52 INFO - ##### 05:57:52 INFO - Running pre-action listener: _resource_record_pre_action 05:57:52 INFO - Running main action method: read_buildbot_config 05:57:52 INFO - Using buildbot properties: 05:57:52 INFO - { 05:57:52 INFO - "project": "", 05:57:52 INFO - "product": "firefox", 05:57:52 INFO - "script_repo_revision": "production", 05:57:52 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 05:57:52 INFO - "repository": "", 05:57:52 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 05:57:52 INFO - "buildid": "20160624143557", 05:57:52 INFO - "pgo_build": "False", 05:57:52 INFO - "basedir": "/builds/slave/test", 05:57:52 INFO - "buildnumber": 16, 05:57:52 INFO - "slavename": "t-yosemite-r7-0025", 05:57:52 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 05:57:52 INFO - "platform": "yosemite_r7", 05:57:52 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 05:57:52 INFO - "branch": "mozilla-beta", 05:57:52 INFO - "repo_path": "releases/mozilla-beta", 05:57:52 INFO - "revision": "229741b7de0485ca56b91e0e657fe5d37dbbc98f", 05:57:52 INFO - "stage_platform": "macosx64", 05:57:52 INFO - "builduid": "67b95f07284347e7aea2678b4c3b20e6", 05:57:52 INFO - "slavebuilddir": "test" 05:57:52 INFO - } 05:57:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 05:57:52 INFO - Running post-action listener: _resource_record_post_action 05:57:52 INFO - ##### 05:57:52 INFO - ##### Running download-and-extract step. 05:57:52 INFO - ##### 05:57:52 INFO - Running pre-action listener: _resource_record_pre_action 05:57:52 INFO - Running main action method: download_and_extract 05:57:52 INFO - mkdir: /builds/slave/test/build/tests 05:57:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:52 INFO - https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:57:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 05:57:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 05:57:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 05:57:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 05:57:57 INFO - Downloaded 1165 bytes. 05:57:57 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 05:57:57 INFO - Using the following test package requirements: 05:57:57 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 05:57:57 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 05:57:57 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 05:57:57 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 05:57:57 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 05:57:57 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 05:57:57 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 05:57:57 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 05:57:57 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 05:57:57 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 05:57:57 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 05:57:57 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 05:57:57 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 05:57:57 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 05:57:57 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 05:57:57 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 05:57:57 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 05:57:57 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 05:57:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:57:57 INFO - https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:57:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 05:57:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 05:57:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 05:57:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 05:58:00 INFO - Downloaded 18344069 bytes. 05:58:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:58:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:58:04 INFO - Return code: 0 05:58:04 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 05:58: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')]} 05:58:04 INFO - https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:58:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 05:58:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 05:58:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 05:58:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 05:58:06 INFO - Downloaded 18344069 bytes. 05:58:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:58:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:58:09 INFO - Return code: 0 05:58:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:58:09 INFO - https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:58:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 05:58:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 05:58:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 05:58:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 05:58:10 INFO - Downloaded 10840145 bytes. 05:58:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:58:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:58:10 INFO - Return code: 0 05:58: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')]} 05:58:10 INFO - https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 05:58:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 05:58:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 05:58:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 05:58:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 05:58:13 INFO - Downloaded 86227039 bytes. 05:58:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 05:58:13 INFO - mkdir: /builds/slave/test/properties 05:58:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:58:13 INFO - Writing to file /builds/slave/test/properties/build_url 05:58:13 INFO - Contents: 05:58:13 INFO - build_url:https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 05:58:14 INFO - Running post-action listener: _resource_record_post_action 05:58:14 INFO - Running post-action listener: set_extra_try_arguments 05:58:14 INFO - ##### 05:58:14 INFO - ##### Running populate-webroot step. 05:58:14 INFO - ##### 05:58:14 INFO - Running pre-action listener: _resource_record_pre_action 05:58:14 INFO - Running main action method: populate_webroot 05:58:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:58:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:58:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:58:14 INFO - '--tppagecycles', 05:58:14 INFO - '7'], 05:58:14 INFO - 'tests': ['tsvgm']}}, 05:58:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:58:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:58:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:58:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:58:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:58:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:58:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:14 INFO - 'talos_options': ['--disable-e10s'], 05:58:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:58:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:58:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:14 INFO - 'talos_options': ['--disable-e10s'], 05:58:14 INFO - 'tests': ['damp', 'tps']}, 05:58:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:14 INFO - 'tests': ['damp', 'tps']}, 05:58:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:58:14 INFO - 'tests': ['dromaeo_dom']}, 05:58:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:58:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:58:14 INFO - 'tests': ['a11yr', 05:58:14 INFO - 'ts_paint', 05:58:14 INFO - 'tpaint', 05:58:14 INFO - 'sessionrestore', 05:58:14 INFO - 'sessionrestore_no_auto_restore', 05:58:14 INFO - 'tabpaint']}, 05:58:14 INFO - 'other-e10s': {'tests': ['a11yr', 05:58:14 INFO - 'ts_paint', 05:58:14 INFO - 'tpaint', 05:58:14 INFO - 'sessionrestore', 05:58:14 INFO - 'sessionrestore_no_auto_restore', 05:58:14 INFO - 'tabpaint']}, 05:58:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:58:14 INFO - 'ts_paint', 05:58:14 INFO - 'tpaint', 05:58:14 INFO - 'sessionrestore', 05:58:14 INFO - 'sessionrestore_no_auto_restore', 05:58:14 INFO - 'tabpaint']}, 05:58:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:58:14 INFO - 'ts_paint', 05:58:14 INFO - 'tpaint', 05:58:14 INFO - 'sessionrestore', 05:58:14 INFO - 'sessionrestore_no_auto_restore', 05:58:14 INFO - 'tabpaint']}, 05:58:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:58:14 INFO - 'tests': ['a11yr', 05:58:14 INFO - 'ts_paint', 05:58:14 INFO - 'tpaint', 05:58:14 INFO - 'sessionrestore', 05:58:14 INFO - 'sessionrestore_no_auto_restore', 05:58:14 INFO - 'tabpaint']}, 05:58:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:58:14 INFO - 'tests': ['a11yr', 05:58:14 INFO - 'ts_paint', 05:58:14 INFO - 'tpaint', 05:58:14 INFO - 'sessionrestore', 05:58:14 INFO - 'sessionrestore_no_auto_restore', 05:58:14 INFO - 'tabpaint']}, 05:58:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:58:14 INFO - 'tests': ['tsvgx', 05:58:14 INFO - 'tsvgr_opacity', 05:58:14 INFO - 'tart', 05:58:14 INFO - 'tscrollx', 05:58:14 INFO - 'cart']}, 05:58:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:58:14 INFO - 'tsvgr_opacity', 05:58:14 INFO - 'tart', 05:58:14 INFO - 'tscrollx', 05:58:14 INFO - 'cart']}, 05:58:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:14 INFO - 'talos_options': ['--disable-e10s'], 05:58:14 INFO - 'tests': ['tp5o']}, 05:58:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:14 INFO - 'tests': ['tp5o']}, 05:58:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:14 INFO - 'talos_options': ['--disable-e10s', 05:58:14 INFO - '--xperf_path', 05:58:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:58:14 INFO - 'tests': ['tp5n']}, 05:58:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:14 INFO - 'talos_options': ['--xperf_path', 05:58:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:58:14 INFO - 'tests': ['tp5n']}}, 05:58:14 INFO - 'talos.zip': {'path': '', 05:58:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:58:14 INFO - Running post-action listener: _resource_record_post_action 05:58:14 INFO - ##### 05:58:14 INFO - ##### Running create-virtualenv step. 05:58:14 INFO - ##### 05:58:14 INFO - Running pre-action listener: _resource_record_pre_action 05:58:14 INFO - Running main action method: create_virtualenv 05:58:14 INFO - Creating virtualenv /builds/slave/test/build/venv 05:58:14 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 05:58:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:58:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:58:14 INFO - Using real prefix '/tools/python27' 05:58:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:58:14 INFO - Installing distribute.............................................................................................................................................................................................done. 05:58:17 INFO - Installing pip.................done. 05:58:17 INFO - Return code: 0 05:58:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:58:17 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')]} 05:58:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:17 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')]} 05:58:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:17 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 0x100bffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c0f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa271d7e6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a9ee00>, '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 0x100907db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a99b20>, '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.l07cEfk3CL/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.t31DGEV9O6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 05:58:17 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 05:58:17 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 05:58:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l07cEfk3CL/Render', 05:58:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:58:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:58:17 INFO - 'HOME': '/Users/cltbld', 05:58:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:58:17 INFO - 'LOGNAME': 'cltbld', 05:58:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:17 INFO - 'MOZ_NO_REMOTE': '1', 05:58:17 INFO - 'NO_EM_RESTART': '1', 05:58:17 INFO - 'PAGER': '/bin/cat', 05:58:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:58:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:17 INFO - 'PWD': '/builds/slave/test', 05:58:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:58:17 INFO - 'SHELL': '/bin/bash', 05:58:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t31DGEV9O6/Listeners', 05:58:17 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 05:58:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:58:17 INFO - 'USER': 'cltbld', 05:58:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:58:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:58:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:17 INFO - 'XPC_FLAGS': '0x0', 05:58:17 INFO - 'XPC_SERVICE_NAME': '0', 05:58:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:58:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:18 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 05:58:18 INFO - Cleaning up... 05:58:18 INFO - Return code: 0 05:58:18 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:58:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:18 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 0x100bffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c0f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa271d7e6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a9ee00>, '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 0x100907db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a99b20>, '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.l07cEfk3CL/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.t31DGEV9O6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 05:58:18 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 05:58:18 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 05:58:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l07cEfk3CL/Render', 05:58:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:58:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:58:18 INFO - 'HOME': '/Users/cltbld', 05:58:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:58:18 INFO - 'LOGNAME': 'cltbld', 05:58:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:18 INFO - 'MOZ_NO_REMOTE': '1', 05:58:18 INFO - 'NO_EM_RESTART': '1', 05:58:18 INFO - 'PAGER': '/bin/cat', 05:58:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:58:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:18 INFO - 'PWD': '/builds/slave/test', 05:58:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:58:18 INFO - 'SHELL': '/bin/bash', 05:58:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t31DGEV9O6/Listeners', 05:58:18 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 05:58:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:58:18 INFO - 'USER': 'cltbld', 05:58:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:58:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:58:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:18 INFO - 'XPC_FLAGS': '0x0', 05:58:18 INFO - 'XPC_SERVICE_NAME': '0', 05:58:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:58:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:18 INFO - Downloading/unpacking psutil>=0.7.1 05:58:18 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 05:58:18 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 05:58:18 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 05:58:18 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 05:58:18 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 05:58:18 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 05:58:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:58:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:58:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:58:21 INFO - Installing collected packages: psutil 05:58:21 INFO - Running setup.py install for psutil 05:58:21 INFO - building 'psutil._psutil_osx' extension 05:58:21 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 05:58:22 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 05:58:22 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 05:58:22 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 05:58:22 INFO - building 'psutil._psutil_posix' extension 05:58:22 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 05:58:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:58:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:58:22 INFO - ^ 05:58:22 INFO - 1 warning generated. 05:58:22 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 05:58:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:58:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:58:22 INFO - Successfully installed psutil 05:58:22 INFO - Cleaning up... 05:58:22 INFO - Return code: 0 05:58:22 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:58:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:58:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:58:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:22 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 0x100bffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c0f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa271d7e6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a9ee00>, '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 0x100907db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a99b20>, '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.l07cEfk3CL/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.t31DGEV9O6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 05:58:22 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 05:58:22 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 05:58:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l07cEfk3CL/Render', 05:58:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:58:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:58:22 INFO - 'HOME': '/Users/cltbld', 05:58:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:58:22 INFO - 'LOGNAME': 'cltbld', 05:58:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:22 INFO - 'MOZ_NO_REMOTE': '1', 05:58:22 INFO - 'NO_EM_RESTART': '1', 05:58:22 INFO - 'PAGER': '/bin/cat', 05:58:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:58:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:22 INFO - 'PWD': '/builds/slave/test', 05:58:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:58:22 INFO - 'SHELL': '/bin/bash', 05:58:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t31DGEV9O6/Listeners', 05:58:22 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 05:58:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:58:22 INFO - 'USER': 'cltbld', 05:58:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:58:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:58:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:22 INFO - 'XPC_FLAGS': '0x0', 05:58:22 INFO - 'XPC_SERVICE_NAME': '0', 05:58:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:58:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:58:22 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 05:58:22 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 05:58:22 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 05:58:22 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 05:58:22 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 05:58:22 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 05:58:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:58:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:58:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:58:25 INFO - Installing collected packages: mozsystemmonitor 05:58:25 INFO - Running setup.py install for mozsystemmonitor 05:58:25 INFO - Successfully installed mozsystemmonitor 05:58:25 INFO - Cleaning up... 05:58:25 INFO - Return code: 0 05:58:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:58:25 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')]} 05:58:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:25 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')]} 05:58:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:25 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 0x100bffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c0f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa271d7e6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a9ee00>, '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 0x100907db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a99b20>, '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.l07cEfk3CL/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.t31DGEV9O6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 05:58:25 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 05:58:25 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 05:58:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l07cEfk3CL/Render', 05:58:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:58:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:58:25 INFO - 'HOME': '/Users/cltbld', 05:58:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:58:25 INFO - 'LOGNAME': 'cltbld', 05:58:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:25 INFO - 'MOZ_NO_REMOTE': '1', 05:58:25 INFO - 'NO_EM_RESTART': '1', 05:58:25 INFO - 'PAGER': '/bin/cat', 05:58:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:58:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:25 INFO - 'PWD': '/builds/slave/test', 05:58:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:58:25 INFO - 'SHELL': '/bin/bash', 05:58:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t31DGEV9O6/Listeners', 05:58:25 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 05:58:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:58:25 INFO - 'USER': 'cltbld', 05:58:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:58:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:58:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:25 INFO - 'XPC_FLAGS': '0x0', 05:58:25 INFO - 'XPC_SERVICE_NAME': '0', 05:58:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:58:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:25 INFO - Downloading/unpacking blobuploader==1.2.4 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58:28 INFO - Downloading blobuploader-1.2.4.tar.gz 05:58:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:58:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:58:28 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 05:58:28 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 05:58:28 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 05:58:28 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 05:58:28 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 05:58:28 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 05:58:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:58:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:58:29 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 05:58:29 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 05:58:29 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 05:58:29 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 05:58:29 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 05:58:29 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 05:58:29 INFO - Downloading docopt-0.6.1.tar.gz 05:58:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:58:29 INFO - Installing collected packages: blobuploader, requests, docopt 05:58:29 INFO - Running setup.py install for blobuploader 05:58:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:58:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:58:29 INFO - Running setup.py install for requests 05:58:30 INFO - Running setup.py install for docopt 05:58:30 INFO - Successfully installed blobuploader requests docopt 05:58:30 INFO - Cleaning up... 05:58:30 INFO - Return code: 0 05:58:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:58:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:58:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:30 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 0x100bffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c0f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa271d7e6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a9ee00>, '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 0x100907db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a99b20>, '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.l07cEfk3CL/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.t31DGEV9O6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 05:58:30 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 05:58:30 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 05:58:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l07cEfk3CL/Render', 05:58:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:58:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:58:30 INFO - 'HOME': '/Users/cltbld', 05:58:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:58:30 INFO - 'LOGNAME': 'cltbld', 05:58:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:30 INFO - 'MOZ_NO_REMOTE': '1', 05:58:30 INFO - 'NO_EM_RESTART': '1', 05:58:30 INFO - 'PAGER': '/bin/cat', 05:58:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:58:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:30 INFO - 'PWD': '/builds/slave/test', 05:58:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:58:30 INFO - 'SHELL': '/bin/bash', 05:58:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t31DGEV9O6/Listeners', 05:58:30 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 05:58:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:58:30 INFO - 'USER': 'cltbld', 05:58:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:58:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:58:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:30 INFO - 'XPC_FLAGS': '0x0', 05:58:30 INFO - 'XPC_SERVICE_NAME': '0', 05:58:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:58:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:58:30 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-D6xMh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:58:30 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-PaIl8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:58:30 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-VXH9KF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:58:31 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-bejkb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:58:31 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-rC2c4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:58:31 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-yHSODu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:58:31 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-L6ulPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:58:31 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-GHvLfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:58:31 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-PmnjYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:58:31 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-NKtpZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:58:31 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-YaanrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:58:31 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-4yg6Ts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:58:32 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-hor5lR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:58:32 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-DzvVTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:32 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-4Fonpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:58:32 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-VJ3TMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:58:32 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-ZlrdRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:58:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:58:32 INFO - Running setup.py install for manifestparser 05:58:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:58:32 INFO - Running setup.py install for mozcrash 05:58:32 INFO - Running setup.py install for mozdebug 05:58:32 INFO - Running setup.py install for mozdevice 05:58:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:58:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:58:33 INFO - Running setup.py install for mozfile 05:58:33 INFO - Running setup.py install for mozhttpd 05:58:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:58:33 INFO - Running setup.py install for mozinfo 05:58:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:58:33 INFO - Running setup.py install for mozInstall 05:58:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:58:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:58:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:58:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:58:33 INFO - Running setup.py install for mozleak 05:58:33 INFO - Running setup.py install for mozlog 05:58:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:58:34 INFO - Running setup.py install for moznetwork 05:58:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:58:34 INFO - Running setup.py install for mozprocess 05:58:34 INFO - Running setup.py install for mozprofile 05:58:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:58:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:58:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:58:34 INFO - Running setup.py install for mozrunner 05:58:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:58:34 INFO - Running setup.py install for mozscreenshot 05:58:34 INFO - Running setup.py install for moztest 05:58:34 INFO - Running setup.py install for mozversion 05:58:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:58:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:58:35 INFO - Cleaning up... 05:58:35 INFO - Return code: 0 05:58:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:58:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:35 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 0x100bffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c0f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa271d7e6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a9ee00>, '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 0x100907db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a99b20>, '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.l07cEfk3CL/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.t31DGEV9O6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 05:58:35 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 05:58:35 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 05:58:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l07cEfk3CL/Render', 05:58:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:58:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:58:35 INFO - 'HOME': '/Users/cltbld', 05:58:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:58:35 INFO - 'LOGNAME': 'cltbld', 05:58:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:35 INFO - 'MOZ_NO_REMOTE': '1', 05:58:35 INFO - 'NO_EM_RESTART': '1', 05:58:35 INFO - 'PAGER': '/bin/cat', 05:58:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:58:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:35 INFO - 'PWD': '/builds/slave/test', 05:58:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:58:35 INFO - 'SHELL': '/bin/bash', 05:58:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t31DGEV9O6/Listeners', 05:58:35 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 05:58:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:58:35 INFO - 'USER': 'cltbld', 05:58:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:58:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:58:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:35 INFO - 'XPC_FLAGS': '0x0', 05:58:35 INFO - 'XPC_SERVICE_NAME': '0', 05:58:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:58:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:58:35 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-WPXyAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:58:35 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)) 05:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:58:35 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-_YJKUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:58:35 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)) 05:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:58:35 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-UAZyK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:58:35 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)) 05:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:58:35 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-tfwbgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:58:35 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)) 05:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:58:35 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-8CKMOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:58:35 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)) 05:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:58:35 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-Gi3hat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:58:36 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)) 05:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:58:36 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-tqY8HP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:58:36 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)) 05:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:58:36 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-MwPFRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:58:36 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)) 05:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:58:36 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-QsNA_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:58:36 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)) 05:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:58:36 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-t85Tgo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:58:36 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)) 05:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:58:36 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-u8jGwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:58:36 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)) 05:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:58:36 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-oVkV1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:58:36 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)) 05:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:58:36 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-ruko_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:58:36 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)) 05:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:58:36 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-lu3sL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:58:36 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)) 05:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:36 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-EddXcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:37 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)) 05:58:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:58:37 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-t8mpY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:58:37 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)) 05:58:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:58:37 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-9vc9E3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:58:37 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)) 05:58:37 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)) 05:58:37 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)) 05:58:37 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)) 05:58:37 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)) 05:58:37 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)) 05:58:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:58:37 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 05:58:37 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 05:58:37 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 05:58:37 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 05:58:37 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 05:58:37 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 05:58:39 INFO - Downloading blessings-1.6.tar.gz 05:58:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:58:39 INFO - Installing collected packages: blessings 05:58:39 INFO - Running setup.py install for blessings 05:58:39 INFO - Successfully installed blessings 05:58:39 INFO - Cleaning up... 05:58:40 INFO - Return code: 0 05:58:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:58:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:58:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:58:40 INFO - Reading from file tmpfile_stdout 05:58:40 INFO - Current package versions: 05:58:40 INFO - blessings == 1.6 05:58:40 INFO - blobuploader == 1.2.4 05:58:40 INFO - docopt == 0.6.1 05:58:40 INFO - manifestparser == 1.1 05:58:40 INFO - mozInstall == 1.12 05:58:40 INFO - mozcrash == 0.17 05:58:40 INFO - mozdebug == 0.1 05:58:40 INFO - mozdevice == 0.48 05:58:40 INFO - mozfile == 1.2 05:58:40 INFO - mozhttpd == 0.7 05:58:40 INFO - mozinfo == 0.9 05:58:40 INFO - mozleak == 0.1 05:58:40 INFO - mozlog == 3.1 05:58:40 INFO - moznetwork == 0.27 05:58:40 INFO - mozprocess == 0.22 05:58:40 INFO - mozprofile == 0.28 05:58:40 INFO - mozrunner == 6.11 05:58:40 INFO - mozscreenshot == 0.1 05:58:40 INFO - mozsystemmonitor == 0.0 05:58:40 INFO - moztest == 0.7 05:58:40 INFO - mozversion == 1.4 05:58:40 INFO - psutil == 3.1.1 05:58:40 INFO - requests == 1.2.3 05:58:40 INFO - wsgiref == 0.1.2 05:58:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58:40 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')]} 05:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:40 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')]} 05:58:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:40 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 0x100bffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c0f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa271d7e6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a9ee00>, '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 0x100907db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a99b20>, '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.l07cEfk3CL/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.t31DGEV9O6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 05:58:40 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 05:58:40 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 05:58:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l07cEfk3CL/Render', 05:58:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:58:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:58:40 INFO - 'HOME': '/Users/cltbld', 05:58:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:58:40 INFO - 'LOGNAME': 'cltbld', 05:58:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:40 INFO - 'MOZ_NO_REMOTE': '1', 05:58:40 INFO - 'NO_EM_RESTART': '1', 05:58:40 INFO - 'PAGER': '/bin/cat', 05:58:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:58:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:40 INFO - 'PWD': '/builds/slave/test', 05:58:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:58:40 INFO - 'SHELL': '/bin/bash', 05:58:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t31DGEV9O6/Listeners', 05:58:40 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 05:58:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:58:40 INFO - 'USER': 'cltbld', 05:58:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:58:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:58:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:40 INFO - 'XPC_FLAGS': '0x0', 05:58:40 INFO - 'XPC_SERVICE_NAME': '0', 05:58:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:58:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:40 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)) 05:58:40 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)) 05:58:40 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)) 05:58:40 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)) 05:58:40 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)) 05:58:40 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)) 05:58:40 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)) 05:58:40 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)) 05:58:40 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)) 05:58:40 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)) 05:58:40 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)) 05:58:40 INFO - Cleaning up... 05:58:40 INFO - Return code: 0 05:58:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:58:40 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')]} 05:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:40 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')]} 05:58:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:40 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 0x100bffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c0f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa271d7e6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a9ee00>, '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 0x100907db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a99b20>, '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.l07cEfk3CL/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.t31DGEV9O6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 05:58:40 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 05:58:40 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 05:58:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l07cEfk3CL/Render', 05:58:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:58:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:58:40 INFO - 'HOME': '/Users/cltbld', 05:58:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:58:40 INFO - 'LOGNAME': 'cltbld', 05:58:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:40 INFO - 'MOZ_NO_REMOTE': '1', 05:58:40 INFO - 'NO_EM_RESTART': '1', 05:58:40 INFO - 'PAGER': '/bin/cat', 05:58:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:58:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:40 INFO - 'PWD': '/builds/slave/test', 05:58:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:58:40 INFO - 'SHELL': '/bin/bash', 05:58:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t31DGEV9O6/Listeners', 05:58:40 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 05:58:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:58:40 INFO - 'USER': 'cltbld', 05:58:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:58:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:58:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:40 INFO - 'XPC_FLAGS': '0x0', 05:58:40 INFO - 'XPC_SERVICE_NAME': '0', 05:58:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:58:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:40 INFO - Downloading/unpacking jsonschema 05:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:58:43 INFO - Downloading/unpacking functools32 (from jsonschema) 05:58:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:43 INFO - Downloading functools32-3.2.3-2.tar.gz 05:58:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:58:43 INFO - warning: no files found matching '*.txt' 05:58:43 INFO - no previously-included directories found matching 'build' 05:58:43 INFO - no previously-included directories found matching 'dist' 05:58:43 INFO - no previously-included directories found matching '.git*' 05:58:43 INFO - Installing collected packages: jsonschema, functools32 05:58:43 INFO - Running setup.py install for functools32 05:58:44 INFO - warning: no files found matching '*.txt' 05:58:44 INFO - no previously-included directories found matching 'build' 05:58:44 INFO - no previously-included directories found matching 'dist' 05:58:44 INFO - no previously-included directories found matching '.git*' 05:58:44 INFO - Successfully installed jsonschema functools32 05:58:44 INFO - Cleaning up... 05:58:44 INFO - Return code: 0 05:58:44 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:58:44 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')]} 05:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:44 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')]} 05:58:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:44 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 0x100bffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c0f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa271d7e6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a9ee00>, '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 0x100907db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a99b20>, '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.l07cEfk3CL/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.t31DGEV9O6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 05:58:44 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 05:58:44 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 05:58:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l07cEfk3CL/Render', 05:58:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:58:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:58:44 INFO - 'HOME': '/Users/cltbld', 05:58:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:58:44 INFO - 'LOGNAME': 'cltbld', 05:58:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:44 INFO - 'MOZ_NO_REMOTE': '1', 05:58:44 INFO - 'NO_EM_RESTART': '1', 05:58:44 INFO - 'PAGER': '/bin/cat', 05:58:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:58:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:44 INFO - 'PWD': '/builds/slave/test', 05:58:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:58:44 INFO - 'SHELL': '/bin/bash', 05:58:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t31DGEV9O6/Listeners', 05:58:44 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 05:58:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:58:44 INFO - 'USER': 'cltbld', 05:58:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:58:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:58:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:44 INFO - 'XPC_FLAGS': '0x0', 05:58:44 INFO - 'XPC_SERVICE_NAME': '0', 05:58:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:58:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:44 INFO - Downloading/unpacking flake8 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:58:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:58:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:58:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:58:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:58:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:58:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:58:48 INFO - no previously-included directories found matching 'docs/_build' 05:58:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:58:48 INFO - Running setup.py install for pep8 05:58:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:58:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:58:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:58:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:58:48 INFO - no previously-included directories found matching 'docs/_build' 05:58:48 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:58:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:58:48 INFO - Cleaning up... 05:58:48 INFO - Return code: 0 05:58:48 INFO - Running post-action listener: _resource_record_post_action 05:58:48 INFO - Running post-action listener: _start_resource_monitoring 05:58:48 INFO - Starting resource monitoring. 05:58:48 INFO - ##### 05:58:48 INFO - ##### Running install step. 05:58:48 INFO - ##### 05:58:48 INFO - Running pre-action listener: _resource_record_pre_action 05:58:48 INFO - Running main action method: install 05:58:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:58:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:58:48 INFO - Reading from file tmpfile_stdout 05:58:48 INFO - Detecting whether we're running mozinstall >=1.0... 05:58:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:58:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:58:48 INFO - Reading from file tmpfile_stdout 05:58:48 INFO - Output received: 05:58:48 INFO - Usage: mozinstall [options] installer 05:58:48 INFO - Options: 05:58:48 INFO - -h, --help show this help message and exit 05:58:48 INFO - -d DEST, --destination=DEST 05:58:48 INFO - Directory to install application into. [default: 05:58:48 INFO - "/builds/slave/test"] 05:58:48 INFO - --app=APP Application being installed. [default: firefox] 05:58:48 INFO - mkdir: /builds/slave/test/build/application 05:58:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:58:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 05:59:10 INFO - Reading from file tmpfile_stdout 05:59:10 INFO - Output received: 05:59:10 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 05:59:10 INFO - Running post-action listener: _resource_record_post_action 05:59:10 INFO - ##### 05:59:10 INFO - ##### Running run-tests step. 05:59:10 INFO - ##### 05:59:10 INFO - Running pre-action listener: _resource_record_pre_action 05:59:10 INFO - Running main action method: run_tests 05:59:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:59:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:59:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:59:10 INFO - 2016-06-27 05:59:10.782 screenresolution[1643:8505] starting screenresolution argv=screenresolution get 05:59:10 INFO - 2016-06-27 05:59:10.785 screenresolution[1643:8505] Display 0: 1600x1200x32@60 05:59:10 INFO - 2016-06-27 05:59:10.791 screenresolution[1644:8508] starting screenresolution argv=screenresolution list 05:59:10 INFO - Available Modes on Display 0 05:59:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:59:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:59:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:59:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:59:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:59:11 INFO - Intel Iris: 05:59:11 INFO - Chipset Model: Intel Iris 05:59:11 INFO - Type: GPU 05:59:11 INFO - Bus: Built-In 05:59:11 INFO - VRAM (Dynamic, Max): 1536 MB 05:59:11 INFO - Vendor: Intel (0x8086) 05:59:11 INFO - Device ID: 0x0a2e 05:59:11 INFO - Revision ID: 0x0009 05:59:11 INFO - Displays: 05:59:11 INFO - Display: 05:59:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:59:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:59:11 INFO - Display Serial Number: 1600x1200 60 05:59:11 INFO - Main Display: Yes 05:59:11 INFO - Mirror: Off 05:59:11 INFO - Online: Yes 05:59:11 INFO - Rotation: Supported 05:59:11 INFO - Return code: 0 05:59:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:59:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:59:11 INFO - Python 2.7.3 05:59:11 INFO - Return code: 0 05:59:11 INFO - grabbing minidump binary from tooltool 05:59:11 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')]} 05:59:11 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 0x100a9ee00>, '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 0x100907db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a99b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:59:11 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 05:59:11 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 05:59:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:59:11 INFO - Return code: 0 05:59:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:59:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:59:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:59:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:59:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:59:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:59:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:59:12 INFO - Return code: 0 05:59:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:59:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0025 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:59:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.l07cEfk3CL/Render', 05:59:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:59:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:59:12 INFO - 'HOME': '/Users/cltbld', 05:59:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:59:12 INFO - 'LOGNAME': 'cltbld', 05:59:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:59:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:59:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:12 INFO - 'MOZ_NO_REMOTE': '1', 05:59:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:59:12 INFO - 'NO_EM_RESTART': '1', 05:59:12 INFO - 'PAGER': '/bin/cat', 05:59:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:59:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:12 INFO - 'PWD': '/builds/slave/test', 05:59:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:59:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:59:12 INFO - 'SHELL': '/bin/bash', 05:59:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t31DGEV9O6/Listeners', 05:59:12 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 05:59:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:59:12 INFO - 'USER': 'cltbld', 05:59:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:59:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:59:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:12 INFO - 'XPC_FLAGS': '0x0', 05:59:12 INFO - 'XPC_SERVICE_NAME': '0', 05:59:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:59:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:59:12 INFO - mozversion application_buildid: 20160624143557 05:59:12 INFO - mozversion application_changeset: 229741b7de0485ca56b91e0e657fe5d37dbbc98f 05:59:12 INFO - mozversion application_display_name: Firefox 05:59:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:59:12 INFO - mozversion application_name: Firefox 05:59:12 INFO - mozversion application_remotingname: firefox 05:59:12 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:59:12 INFO - mozversion application_vendor: Mozilla 05:59:12 INFO - mozversion application_version: 48.0 05:59:12 INFO - mozversion platform_buildid: 20160624143557 05:59:12 INFO - mozversion platform_changeset: 229741b7de0485ca56b91e0e657fe5d37dbbc98f 05:59:12 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:59:12 INFO - mozversion platform_version: 48.0 05:59:12 INFO - using testdate: 1467032352 05:59:12 INFO - actual date: 1467032352 05:59:12 INFO - starting webserver on 'localhost:49270' 05:59:12 INFO - SUITE-START | Running 2 tests 05:59:12 INFO - TEST-START | dromaeo_css 05:59:12 INFO - operating with platform_type : mac_ 05:59:12 INFO - Initialising browser for dromaeo_css test... 05:59:12 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/tmpZy6eV0/profile http://localhost:49270/getInfo.html) 05:59:15 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 05:59:15 INFO - PROCESS | 1662 | colorDepth:24 05:59:15 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 05:59:15 INFO - PROCESS | 1662 | __metrics 05:59:15 ERROR - PROCESS | 1662 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 05:59:16 INFO - TEST-INFO | 1662: exit 0 05:59:16 INFO - Browser initialized. 05:59:16 INFO - Running cycle 1/1 for dromaeo_css test... 05:59:16 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/tmpZy6eV0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:59:27 INFO - PROCESS | 1667 | RSS: Main: 171003904 05:59:27 INFO - PROCESS | 1667 | 06:00:17 INFO - PROCESS | 1667 | 1467032417520 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:02:27 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 06:02:29 INFO - PROCESS | 1667 | RSS: Main: 181731328 06:02:29 INFO - PROCESS | 1667 | 06:05:31 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 06:05:31 INFO - PROCESS | 1667 | RSS: Main: 192335872 06:05:31 INFO - PROCESS | 1667 | 06:08:33 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 06:08:34 INFO - PROCESS | 1667 | RSS: Main: 194359296 06:08:34 INFO - PROCESS | 1667 | 06:11:35 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 06:11:36 INFO - PROCESS | 1667 | RSS: Main: 198225920 06:11:36 INFO - PROCESS | 1667 | 06:14:39 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 06:14:39 INFO - PROCESS | 1667 | RSS: Main: 197382144 06:14:39 INFO - PROCESS | 1667 | 06:17:41 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 06:17:42 INFO - PROCESS | 1667 | RSS: Main: 202784768 06:17:42 INFO - PROCESS | 1667 | 06:17:42 INFO - PROCESS | 1667 | __start_tp_report 06:17:42 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 06:17:42 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 06:17:42 INFO - PROCESS | 1667 | |i|pagename|runs| 06:17:42 INFO - PROCESS | 1667 | |0;dojo.html;3374.2239284964458;3695;3740.9438858417147;3769.0954170998953;3769.868054618087;5458.4814442627885;5775.787084712216;6095.603785753923;6101.481374083208;6111.633302001877;5275.314209152814;5429.592780541465;5992.0712289595185;6104.206453161083;6108.144859719643;4472.3515090311885;5411.269478620385;5437.510624043835;5514.228008078872;5530.944690553103;5435.646682965615;5464.098423760095;5532.2531458253225;5536;5589.496945274925;5522.116461366182;5533.170024496318;5544.528715059205;5558.499735023847;5567.248421463111;5340.252364668911;5466.070767969455;5486.506214440699;5527.474889885454;5547.25112109864;5360.142377219665;5368.865778355534;5429.239906413105;5430.321209848769;5442.6462279951675;4966;5835.854103647401;5917.349091599921;5957.1362152487645;5978.641281523122;5862.622283763312;6198.566100372976;6344.777932772377;6368.490520758328;6369;5568.7215639217875;6419.069234960951;6419.325970773095;6437.83905402364;6439.323870993525;6071.1196876453105;6092.329843717188;6142.662153581596;6154.907676384813;6177.196964394645;5157;6410.839729006812;6477.093206951031;6608.603483790988;6617.139771829631;6256.874862502725;6276.592021518678;6281.403266689657;6284.497240220771;6324.019776934582;6420.454261387835;6433.453156481752;6442.033694945796;6447.903281450782;6454.612723236621;6180.289266734383;6290.55966082379;6307.842303942438;6309.337519560472;6340.524460665469;6321.178246827975;6324.146240257598;6328.873422531616;6337.17616709834;6350.33321501245;5102.979404119191;5147.56245719118;5147.819826306061;5147.871303217449;5149.922751158736;3841.8847434577006;4501.739512936318;4612.654050946193;4672.486026537078;4712.387389639325;4682.438107427062;6083.756649733961;6111.92601248044;6124.076603295837;6129.2032035835055;6335.271443783931;6375.968120159462;6385.074164246158;6401.58389704677;6407.167068281186;5999.70001499932;6065.909011364833;6126.326104128542;6143.754249830046;6158.784442544579;5609.49514543693;5612.494875461147;5615.326160860723;5620;5628.296462942132;5576.219329293983;6666.033425153326;6673.833154171185;6678.899816502756;6679.532432729759;6267.091271765659;6329.082283068838;6391.456726178327;6457.418832305115;6458.54790164684;6648.567843090377;6660.467162626881;6679.532432729857;6685.765998190234;6699.933000669931;6206.937930620817;6292.559520833498;6388.744450221939;6389.520785941166;6407.295197528361;6381.8723625528155;6419.967900160469;6476.417122458813;6485.837854053498;6498.902516462352;6220.191375121205;6270.122182894307;6278.246610406598;6280.7487700491465;6280.937190628035;6172.9074063889975;6183.752649893954;6270.184875966095;6279.654618995999;6281.340459251713;6071.028635418312;6103.05402662588;6160.969195153995;6240.968795155995;6274.247090349188;6217.906731398942;6235.719392627252;6250.1874756281395;6258.280297765815;6276.937230627818;5365.275687782099;6053.848653783691;6117.492485019787;6173.104899789595;6208.658523781055 06:17:42 INFO - PROCESS | 1667 | |1;ext.html;525.3485677759579;535.4538370861721;561.6714222180025;586.2730214533979;604.6674329118985;39824.2035159297;40781;40850.7957460213;40890.59109408909;40908.59091409085;41682;42107.57892421075;42115.578844211625;42613;42649.7867510662;9727.708168754949;9961.501924903761;9963.003699630015;9999.400035997827;9999.50002499872;8259.38054645901;8314.293285070777;8316.085230624627;8344;8372.330213582929;8338.749837504885;8375.03687075988;8494.957525212396;8504.192101750325;8584.74245772628;8252.546109963949;8271.2142346477;8351.123132071167;8407.159284071606;8472.915270847305;9912.950435247778;9927.007299270088;9948.90051099487;10065.144462720678;10122.443265620388;39945.400818987735;40412;40567.59432405668;40963.7951810239;41034.79482602598;2873.425314937;3098.411301852641;3238.3361410910943;3315.0386387947465;3385.4583266677214;29854.40291194164;30284.54573181404;30790.23024424385;31193.84403077993;31305;2834.4065180359944;2862.6994165612728;2874.583185438121;2884.5528943013865;2903.303207230271;509632;510372;518982;522236;523696;74202.25797742061;76233.61883190549;76330;76332;76410.85383719248;79277;81408.59295703484;81584.18415815885;81586;81826;18742.344017959305;18777.061146942873;19244.61510769777;19333.90333048354;19389.90305048494;14401.495947641783;14418.495352662607;14827.703445931022;14885.851141488663;14923.70152596942;21616.675749863763;21872.671909921362;22513.774862251496;22555.887220563793;22621.773782262295;7997.800329950438;9137.360384773136;9165.358424910326;9257;9295.304361735156;956.8899576548647;1007.8891321954579;1020.5662593397776;1057.8571892794528;1112.1992165640727;30642;30764.69235307663;31164.68835311663;31445.213869652984;31518.842405787826;1112.1269803204445;1136.3693150301497;1167.2062997161843;1173.8356630071796;1180.6044974933322;12684.556040538722;15148.16685082309;15192.860535459884;15236;15714.292856821241;668457;669723;673508;678186;683096;61719.691401543605;62393.37606623967;62795.6860215696;63584;63610.68194658997;1534.9539513814605;1538.2770098053898;1551.123615157455;1561.7188905996802;1566.537871327961;29356.853215733783;29647.555286671148;29653.40693186081;30052.84973575118;30309.090727278217;44250;52451.475485246185;52616.47383526116;52658.47341526689;52978.20532691936;604834.975825118;609283;609296;610996;611496;27722;27780.861095694392;28294.57558136671;28778;28881.566776497948;45569.860753480105;46659.300110497694;46735.53264467448;47242.52757472381;48448.51551484581;37218.81390593138;38049.80975095107;38783.99168814521;38965.02587435337;39784;38571.22857542778;38573.80713096417;38780.80609597047;38896;39543.01142471346;34009.829950850086;37892.62107378891;38632;39502.802485987384;39531.2093758129;32275.838620806746;34615.653843461245;35155.648443516264;35172.94481165569;35449.82275088608;25523;25809.225723228334;25825.870870645525;25896.8705156473;26241.606375903993 06:17:42 INFO - PROCESS | 1667 | |2;jquery.html;366.6351979780119;411.1345617475213;415.2090268039386;415.67577289714023;425.1242440572421;16144.919275403607;20736.170553177875;20820.37538873836;21425.14299428025;21461.141554337828;17873.659475539353;17879;19992.700109498368;20411;20563.868987205697;5835.854103647401;5945.37573554777;6151.415615516541;6168.75324987;6240.469560087398;5791.044477661202;6038.124471951564;6176.8455788605415;6225.906611400833;6232.283287421959;5969.522438204955;5970.104484327364;6065.8180254592435;6072.301685306202;6082.939170608303;5355.732213389315;5509.586780991422;6714.29499902513;6785.796426107225;6793.354631310018;5068.873278168038;5228.529432351107;5901.616394934315;6029.095635654643;6034.275886893557;13709.657258568515;14002.57992260234;14182.645433864132;14196.290185490685;14244.928775356057;2043.5606344635974;2135.572885422906;2146.624340740364;2152.849300548962;2202.658587918875;8678.00202976653;9128.89199860059;9181.89817221931;15148.469803556933;15811.762823557656;1726.499315198591;1744.3720260706136;1792.793828709702;1811.6447224269507;1845.796962334142;87553;102328;106699.265525707;108474.66101355937;119322.40338798337;11672.182947193614;12204.694882627828;12307.015438764878;12367.505299787908;12393.814092788616;15518.534443966699;15615.375384984472;15649.843501565067;15661;15710.842891571167;9247.953760231156;9258.398204116711;9394.389364691273;9464.668736594185;9471.715848524555;9098.181163695299;9323.02108278621;9334.253259739204;9370.718878433658;9415.435073895589;4856.660033797601;4860.3195552622665;4952;4953.628477864175;4975.5522003019905;1682.0916704979174;1750.5536088297658;2118.7033815265877;2120.978790212109;2159.7084393606974;779.7621725373815;991.97024089276;994.5623925472769;1032.3238278927165;1032.607609108549;18955.715664265048;20915.581688366146;20990.370288891358;21283.36149915505;21326.78673213279;933.2487347685178;1006.6778630838062;1025.9076683098408;1066.1470823341297;1071.3197119828808;10734.463276836126;11177.161712871568;11197.94401028006;11221.495032723547;11235.775284494264;625932;628172;637065;641004;643342;110136;113908;135608.32195839155;136207;138792.30603846916;969.486172328667;1069.79139067881;1073.951672174754;1083.7236504691252;1098.4013712526692;17432;17596.208170632097;17828.643427131643;18234.544136396697;18530.351437699617;51856;53004;53901.46098539121;54429;54732.726336369655;58351;74138.25861741313;74506;76986.8451973232;78685.21314786779;7616.96191519061;7797.064352277763;7850.371970242481;7861.646225919962;7907.090684571118;8371.41400101987;10255.128314093086;11318.09455243595;11642.70893227676;11704.297742135159;9513.048695130432;9857.014298570086;9881.604735810488;9949.950250248703;10095.394276343442;9352.953235233781;9468.763280918032;9548.761280967754;9658.613655453984;9723.02769723022;9141.720159177854;9337.906620933976;9742.756431088996;10184.490775461345;10390.532426040696;7943.563104029103;8008.319292859939;8135.227153420416;8382.413231073766;8417.158284171534;8468.195521425454;10657.840132398176;11683.299002059564;11709.531618735155;11857.5849845255 06:17:42 INFO - PROCESS | 1667 | |3;mootools.html;1606.6224437257242;1624.3664970661443;1890.971635425468;1981.3560592807341;2028.5841402512488;8371.706990255343;9045.45727256365;9229.584668689908;9418.152366287033;9431.622735090605;9045.185933266004;9097;9151.908480915188;9188.1730644242;9198.126178013095;2563.9615405768927;2568.987155064227;2570.832895861763;2577.9871100644473;2586.896524139032;2191.791779780918;2525.5201511712808;2600.4669042846267;2604.882780274883;2616.3982284074673;2466.7779899809016;2520.861352625605;2524.7475252474696;2542.402535404188;2578.0847799031353;2225.254539729193;2531.531666641668;2544.592865141578;2606.8044896632637;2610.9869450652627;2564.9487010259877;2567.9229623111337;2584.8707564621695;2602.9088981885543;2618.952419032383;9303.906960930439;9358.53207339637;9368.95315523418;9388.155066044088;9390.295727820441;5837.795677151322;5879.500242479395;5995.760169593211;6010.068439391901;6011.068284415923;3671.6328367163337;3752.2307926874923;3765.755225910307;3839.347310957116;3841.3661745811905;1054.2778196935124;1060.9946950265198;1065.985070264865;1075.693427373195;1083.9458027098613;12219.572314968933;12430.254184748945;12445.439955202037;12452.875471245352;12470.937645311806;5013.974930125326;5096.439391666913;5151.2788209649925;5196.402413722395;5230.895382092413;9859.964703706151;9925.404475731479;10594.735131621772;10724.41015744126;10806.297590656739;5585.301837270341;5660.8867822643315;5694.373618901917;5697.572682048863;5713.457221563945;4717.528247175255;5112.744362781846;5145.922811157836;5224.16413373866;5239.345081864767;4290.528041915387;4321.9135617287475;4356.215881141362;4386.539413361551;4395.714278571946;1404.2136403613804;1407.7606806842657;1417.985820141806;1428.4928850258216;1446.9855301447062;836.5022811427191;924.3021518753433;972.7616733900098;980.1032055669126;1004.2417974429259;5310.442403547572;5948.107783832374;6167.198264225712;6193.225846769154;6234.906476402857;876.6931573949067;963.6819849449805;1050.7478205230843;1108.2630051015983;1119.972000699989;3543.94684079739;4073.89815254621;4124.1133156370925;4140.855070072533;4154.189932963043;11141.665750027512;11190.552377904793;11248.381339026431;11457.026152777107;11469.967702906612;11168.93895079966;11208.83186752183;11256.549738010552;11263.324200547993;11314.717132071764;8705.521196334263;8757.168069033432;8770.298376130022;8801.075887031897;8814.118588141262;5162.8967420652125;5875.764969401176;6014.308354539284;6051.939480605138;6067.878642427038;9897.50512474359;9932.25508086882;9973.551190196313;10049.095581397709;10118.949405252926;9923.65267215644;10098.242631802497;10396.220283478619;10425.270231083752;10436.269461137952;6705.966470167618;7335.926640733524;7426.702931882664;8304.252617264476;8555.914440855511;8513.82972340562;8566;8617.224449799549;8647.0920553341;8665.740027799176;7515.098188217449;7762.068551773823;7768.106667733057;7787.844243115219;7811.257930496594;7356.77929662111;7582.469227154046;7595.088589369311;7697.88453173214;7755.495892766952;7266.600336981517;7297.598632075287;7305.41556675454;7316.158641756266;7330.853382932418;4898.4121905371585;4923.286123512143;5055.570276526537;5098.082345177755;5114.5652619527755;5114.258432527337;5115.18157094863;5120.871978200575;5199.506046925536;5345.545628621455 06:17:42 INFO - PROCESS | 1667 | |4;prototype.html;339.3755489898586;340.9147713071732;341.87350680248295;346.28664950202585;349.435661406828;6245.406686364794;7077.823054423636;7182.784516464508;7193.064901562802;7207.603581802999;7063.540869843457;7069.187043489987;7092.432605391569;7093.467989900765;7102.467314951374;4955.876103097416;5062.924056139161;5184.300119483859;5197.636165468419;5213.556847667934;5149.510796474347;5183.315422487688;5193.792248310063;5193.948060519403;5194.818181363634;4075.2664520386465;4593.874500747322;4689.695169813968;5132;5157.587393008569;4508.729476231437;4559.67769346889;5131.794728210867;5148.948510514884;5154.716490593016;4468.932966005513;4487.618552423048;4499.482559505666;4502.347159661864;4508.391367165456;5416.83749487516;5494.835154945318;6484.708188131545;6796.35434633709;6881;6061.969690151565;6077.20996270482;6085.2697676278685;6091.969540152271;6116.26604807426;7598.126215485235;7611.771646850603;7626;7631.35133513652;7638.350740187036;5015.423226328982;5031.77357018935;5033.119204139298;5039.773210205512;5056.2162864755655;6663.533552651316;7959.8408031839035;7985.441019128663;8035.799105022363;8064.879026814602;4999.650024498323;5088.592912566985;5090.643654944192;5094.108531007059;5123.154679477919;5167.793288268427;5184.092783762826;5194.662346947436;5200.193969934666;5212.035773381936;6052.757889684363;6085.847853803691;6087.05650624154;6096.817095487142;6108.602940808833;7575.356094732009;7603.7338693146585;7634.847303053908;7638.007059082283;7656.196099409593;1462.700146469971;1726.335360886068;1748.5715999580184;1821.6356728654323;1822.48059303098;974.4396971741277;1161.2625982501172;1167.3871217610822;1178.2753606532092;1185.4309931233056;7091.11361079865;7099.751508697171;7126.394256488153;7136.536125151849;7138.750143744944;6977.81377165883;7379.262073792685;7865.567393793282;7874.173211812677;7887.605619719106;7093.361597456254;7099.538529995534;7112.431005519546;7122.323379278961;7155.821104472429;3232.612086549629;4069.4302797608357;4127.628513433805;4175.853845115406;4187.811548480326;8126.065502467174;8266.214709602578;8279.54462504556;8292.37807164465;8298.502089874626;8180.918190818015;8254.05078415978;8506.447080939719;8508.574571271412;8512.74461766148;8332.458390204618;8368.623411946477;8386.454880432751;8394.538300393415;8418.494890306602;7753.4960227585025;7979.72070977513;8003.879941800761;8031.437799353989;8048.5975701215875;7784.143744188248;7862.213778622092;7869.724559640385;7882.960585197037;7890.447668663139;8356.122607126408;8366.205210504992;8375.539345336065;8389;8400.369972251983;4984.501549845131;5159.174532075001;5162.354705661793;5169.095408303607;5178.326817513699;6775.830604234933;7626.656800444104;7951.681932722627;8018.518888866687;8036.357091432788;7646.541207527566;7705.22947705225;7712.383009359126;7717.2668596483245;7717.768466946;7700.4224683150105;7715.729949451742;7716.92283077162;7720;7733.110692270461;7262.092238470192;7481.738139165103;7489.400847932261;7557.848843023219;7591.696332146652;7659.195784442553;7684.500507466997;7701.922980770345;7724.652390642322;7733.8839917400155;6105.694715264308;7493.4379921505015;7528.962355188189;7559.659815308214;7581.128170260491 06:17:42 INFO - PROCESS | 1667 | |5;yui.html;689.841336492607;726.8473620539687;759.745485262437;771.3674786674925;774.0633833061996;15585.908986370945;15816.999999999985;15818.604534886634;15845.286962086704;15878.364865405385;14686.779698304534;14690.265486725675;14697.338619762137;14716.117032978029;14767.704645907075;770.4491288728558;922.3866129024191;947.369998950697;956.775157837911;958.1376760915198;948.9572969216401;949.9050094990515;955.1356022799378;959.2901253072711;961.9519024048805;1007.2948935744971;1008.2589296866797;1008.9445080520568;1010;1010.8685870836781;995.0199053931872;997.3417544420683;1005.5877090392904;1005.9144972677332;1006.1598565198105;724.5181954000583;735.481485552684;746.6789280609336;747.4319517166992;747.8466914282614;14916.254187290591;15069.171195584238;15074.623134421618;15255.38978440861;15358.078515289119;13253.46986120554;13311.201327920258;13334.733305333935;13413.46346146153;13486.705676009282;10343.327683700536;10400.375977441377;10403.427811470367;10449.47752612374;10776.299540529919;3399.5070714746225;3560.8219589020446;3605;3666.633336666339;3840.539135303781;83227.16772832254;83486.58256708678;83908;83940.99999999939;86328.13671863264;9561.856572151284;9807.362521436084;9834.704958851245;9843.557039933221;9926.106650401354;21818.563628727654;22229.77736224491;22282.442938926655;22587.757673328124;22774.975126119363;7633.465657404039;7741.690332386642;7747.070351557849;7785.1436342002335;7915.802104947423;4186.832526698959;4191.392248124005;4198.895027624334;4235.53409124996;4294.527601963781;3760;3760;3839.5584507781405;3843.2121415110396;3857.3828187490426;663.548786824954;670.4770279182246;680.3094858718405;680.5950459476702;695.7251885505198;535.2426316761816;551.2447946313496;605.7879742090233;612.8804883047852;627.6391075131726;8121.228483294078;8298.460600060977;8421.621027053798;8785.956070219609;8879.112088791198;599.3766482857866;599.385629729522;616.8704572039832;618.0358640520802;637.1430426076919;3842.4044273137706;3940.665043471337;3949.6050394960275;3952.26883026641;4148.398482220061;86698.56650716832;87554.56222718845;91708.53140980503;99784;99925.50111748329;82739.17260827315;83397.58301208577;83532;84376.73434898481;84775.57612212023;71767.64116179386;72790;73148.26851731415;74248.62875685588;75409.62295188488;7791.415643826623;7903.920960790549;8059.83880322402;8081.555514446762;8167.387445941459;32168.35663286768;51199;51488.22767658413;51724;53014.384677667964;67349.3265067343;71190;71781.92327114994;72488.63755681188;72535;10007.097584339848;10099.20457592298;10223.846642300223;10309.896901030894;10729.088027517437;11047.779044418905;11256.549738010388;11431.371274579978;11432.142589306002;11748.471318790846;10437.68686939393;10840.403777792297;10913.345199288067;10976;11468.082553395541;10596.8940310599;10622.044016038593;10741.194410419093;11031.393273370042;11469.483873225892;10587.682369528926;10605.575776968835;10713.035826775627;10839.674809755405;11226;8767.833724118584;8957.417767845069;9001.54992250398;9156.862647060432;9292.070792920655;8622.094680058504;8630.654773809229;8713.607887645197;8801.91198088011;8911.420757650732 06:17:42 INFO - PROCESS | 1667 | __end_tp_report 06:17:42 INFO - PROCESS | 1667 | __start_cc_report 06:17:42 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,396 06:17:42 INFO - PROCESS | 1667 | __end_cc_report 06:17:42 INFO - PROCESS | 1667 | __startTimestamp1467033462142__endTimestamp 06:17:42 INFO - PROCESS | 1667 | 06:17:42 INFO - PROCESS | 1667 | ------- Summary: start ------- 06:17:42 INFO - PROCESS | 1667 | Number of tests: 6 06:17:42 INFO - PROCESS | 1667 | 06:17:42 INFO - PROCESS | 1667 | [#0] dojo.html Cycles:165 Average:5916.57 Median:6158.78 stddev:656.00 (10.7%) stddev-sans-first:626.96 06:17:42 INFO - PROCESS | 1667 | Values: 3374.2 3695.0 3740.9 3769.1 3769.9 5458.5 5775.8 6095.6 6101.5 6111.6 5275.3 5429.6 5992.1 6104.2 6108.1 4472.4 5411.3 5437.5 5514.2 5530.9 5435.6 5464.1 5532.3 5536.0 5589.5 5522.1 5533.2 5544.5 5558.5 5567.2 5340.3 5466.1 5486.5 5527.5 5547.3 5360.1 5368.9 5429.2 5430.3 5442.6 4966.0 5835.9 5917.3 5957.1 5978.6 5862.6 6198.6 6344.8 6368.5 6369.0 5568.7 6419.1 6419.3 6437.8 6439.3 6071.1 6092.3 6142.7 6154.9 6177.2 5157.0 6410.8 6477.1 6608.6 6617.1 6256.9 6276.6 6281.4 6284.5 6324.0 6420.5 6433.5 6442.0 6447.9 6454.6 6180.3 6290.6 6307.8 6309.3 6340.5 6321.2 6324.1 6328.9 6337.2 6350.3 5103.0 5147.6 5147.8 5147.9 5149.9 3841.9 4501.7 4612.7 4672.5 4712.4 4682.4 6083.8 6111.9 6124.1 6129.2 6335.3 6376.0 6385.1 6401.6 6407.2 5999.7 6065.9 6126.3 6143.8 6158.8 5609.5 5612.5 5615.3 5620.0 5628.3 5576.2 6666.0 6673.8 6678.9 6679.5 6267.1 6329.1 6391.5 6457.4 6458.5 6648.6 6660.5 6679.5 6685.8 6699.9 6206.9 6292.6 6388.7 6389.5 6407.3 6381.9 6420.0 6476.4 6485.8 6498.9 6220.2 6270.1 6278.2 6280.7 6280.9 6172.9 6183.8 6270.2 6279.7 6281.3 6071.0 6103.1 6161.0 6241.0 6274.2 6217.9 6235.7 6250.2 6258.3 6276.9 5365.3 6053.8 6117.5 6173.1 6208.7 06:17:42 INFO - PROCESS | 1667 | 06:17:42 INFO - PROCESS | 1667 | [#1] ext.html Cycles:180 Average:74245.50 Median:39804.10 stddev:161433.57 (405.6%) stddev-sans-first:161791.55 06:17:42 INFO - PROCESS | 1667 | Values: 525.3 535.5 561.7 586.3 604.7 39824.2 40781.0 40850.8 40890.6 40908.6 41682.0 42107.6 42115.6 42613.0 42649.8 9727.7 9961.5 9963.0 9999.4 9999.5 8259.4 8314.3 8316.1 8344.0 8372.3 8338.7 8375.0 8495.0 8504.2 8584.7 8252.5 8271.2 8351.1 8407.2 8472.9 9913.0 9927.0 9948.9 10065.1 10122.4 39945.4 40412.0 40567.6 40963.8 41034.8 2873.4 3098.4 3238.3 3315.0 3385.5 29854.4 30284.5 30790.2 31193.8 31305.0 2834.4 2862.7 2874.6 2884.6 2903.3 509632.0 510372.0 518982.0 522236.0 523696.0 74202.3 76233.6 76330.0 76332.0 76410.9 79277.0 81408.6 81584.2 81586.0 81826.0 18742.3 18777.1 19244.6 19333.9 19389.9 14401.5 14418.5 14827.7 14885.9 14923.7 21616.7 21872.7 22513.8 22555.9 22621.8 7997.8 9137.4 9165.4 9257.0 9295.3 956.9 1007.9 1020.6 1057.9 1112.2 30642.0 30764.7 31164.7 31445.2 31518.8 1112.1 1136.4 1167.2 1173.8 1180.6 12684.6 15148.2 15192.9 15236.0 15714.3 668457.0 669723.0 673508.0 678186.0 683096.0 61719.7 62393.4 62795.7 63584.0 63610.7 1535.0 1538.3 1551.1 1561.7 1566.5 29356.9 29647.6 29653.4 30052.8 30309.1 44250.0 52451.5 52616.5 52658.5 52978.2 604835.0 609283.0 609296.0 610996.0 611496.0 27722.0 27780.9 28294.6 28778.0 28881.6 45569.9 46659.3 46735.5 47242.5 48448.5 37218.8 38049.8 38784.0 38965.0 39784.0 38571.2 38573.8 38780.8 38896.0 39543.0 34009.8 37892.6 38632.0 39502.8 39531.2 32275.8 34615.7 35155.6 35172.9 35449.8 25523.0 25809.2 25825.9 25896.9 26241.6 06:17:42 INFO - PROCESS | 1667 | 06:17:42 INFO - PROCESS | 1667 | [#2] jquery.html Cycles:180 Average:35149.92 Median:420.40 stddev:105427.41 (25077.9%) stddev-sans-first:105690.81 06:17:42 INFO - PROCESS | 1667 | Values: 366.6 411.1 415.2 415.7 425.1 16144.9 20736.2 20820.4 21425.1 21461.1 17873.7 17879.0 19992.7 20411.0 20563.9 5835.9 5945.4 6151.4 6168.8 6240.5 5791.0 6038.1 6176.8 6225.9 6232.3 5969.5 5970.1 6065.8 6072.3 6082.9 5355.7 5509.6 6714.3 6785.8 6793.4 5068.9 5228.5 5901.6 6029.1 6034.3 13709.7 14002.6 14182.6 14196.3 14244.9 2043.6 2135.6 2146.6 2152.8 2202.7 8678.0 9128.9 9181.9 15148.5 15811.8 1726.5 1744.4 1792.8 1811.6 1845.8 87553.0 102328.0 106699.3 108474.7 119322.4 11672.2 12204.7 12307.0 12367.5 12393.8 15518.5 15615.4 15649.8 15661.0 15710.8 9248.0 9258.4 9394.4 9464.7 9471.7 9098.2 9323.0 9334.3 9370.7 9415.4 4856.7 4860.3 4952.0 4953.6 4975.6 1682.1 1750.6 2118.7 2121.0 2159.7 779.8 992.0 994.6 1032.3 1032.6 18955.7 20915.6 20990.4 21283.4 21326.8 933.2 1006.7 1025.9 1066.1 1071.3 10734.5 11177.2 11197.9 11221.5 11235.8 625932.0 628172.0 637065.0 641004.0 643342.0 110136.0 113908.0 135608.3 136207.0 138792.3 969.5 1069.8 1074.0 1083.7 1098.4 17432.0 17596.2 17828.6 18234.5 18530.4 51856.0 53004.0 53901.5 54429.0 54732.7 58351.0 74138.3 74506.0 76986.8 78685.2 7617.0 7797.1 7850.4 7861.6 7907.1 8371.4 10255.1 11318.1 11642.7 11704.3 9513.0 9857.0 9881.6 9950.0 10095.4 9353.0 9468.8 9548.8 9658.6 9723.0 9141.7 9337.9 9742.8 10184.5 10390.5 7943.6 8008.3 8135.2 8382.4 8417.2 8468.2 10657.8 11683.3 11709.5 11857.6 06:17:42 INFO - PROCESS | 1667 | 06:17:42 INFO - PROCESS | 1667 | [#3] mootools.html Cycles:180 Average:5994.57 Median:5113.50 stddev:3318.80 (64.9%) stddev-sans-first:3311.73 06:17:42 INFO - PROCESS | 1667 | Values: 1606.6 1624.4 1891.0 1981.4 2028.6 8371.7 9045.5 9229.6 9418.2 9431.6 9045.2 9097.0 9151.9 9188.2 9198.1 2564.0 2569.0 2570.8 2578.0 2586.9 2191.8 2525.5 2600.5 2604.9 2616.4 2466.8 2520.9 2524.7 2542.4 2578.1 2225.3 2531.5 2544.6 2606.8 2611.0 2564.9 2567.9 2584.9 2602.9 2619.0 9303.9 9358.5 9369.0 9388.2 9390.3 5837.8 5879.5 5995.8 6010.1 6011.1 3671.6 3752.2 3765.8 3839.3 3841.4 1054.3 1061.0 1066.0 1075.7 1083.9 12219.6 12430.3 12445.4 12452.9 12470.9 5014.0 5096.4 5151.3 5196.4 5230.9 9860.0 9925.4 10594.7 10724.4 10806.3 5585.3 5660.9 5694.4 5697.6 5713.5 4717.5 5112.7 5145.9 5224.2 5239.3 4290.5 4321.9 4356.2 4386.5 4395.7 1404.2 1407.8 1418.0 1428.5 1447.0 836.5 924.3 972.8 980.1 1004.2 5310.4 5948.1 6167.2 6193.2 6234.9 876.7 963.7 1050.7 1108.3 1120.0 3543.9 4073.9 4124.1 4140.9 4154.2 11141.7 11190.6 11248.4 11457.0 11470.0 11168.9 11208.8 11256.5 11263.3 11314.7 8705.5 8757.2 8770.3 8801.1 8814.1 5162.9 5875.8 6014.3 6051.9 6067.9 9897.5 9932.3 9973.6 10049.1 10118.9 9923.7 10098.2 10396.2 10425.3 10436.3 6706.0 7335.9 7426.7 8304.3 8555.9 8513.8 8566.0 8617.2 8647.1 8665.7 7515.1 7762.1 7768.1 7787.8 7811.3 7356.8 7582.5 7595.1 7697.9 7755.5 7266.6 7297.6 7305.4 7316.2 7330.9 4898.4 4923.3 5055.6 5098.1 5114.6 5114.3 5115.2 5120.9 5199.5 5345.5 06:17:42 INFO - PROCESS | 1667 | 06:17:42 INFO - PROCESS | 1667 | [#4] prototype.html Cycles:180 Average:6223.40 Median:7096.50 stddev:2035.93 (28.7%) stddev-sans-first:1993.17 06:17:42 INFO - PROCESS | 1667 | Values: 339.4 340.9 341.9 346.3 349.4 6245.4 7077.8 7182.8 7193.1 7207.6 7063.5 7069.2 7092.4 7093.5 7102.5 4955.9 5062.9 5184.3 5197.6 5213.6 5149.5 5183.3 5193.8 5193.9 5194.8 4075.3 4593.9 4689.7 5132.0 5157.6 4508.7 4559.7 5131.8 5148.9 5154.7 4468.9 4487.6 4499.5 4502.3 4508.4 5416.8 5494.8 6484.7 6796.4 6881.0 6062.0 6077.2 6085.3 6092.0 6116.3 7598.1 7611.8 7626.0 7631.4 7638.4 5015.4 5031.8 5033.1 5039.8 5056.2 6663.5 7959.8 7985.4 8035.8 8064.9 4999.7 5088.6 5090.6 5094.1 5123.2 5167.8 5184.1 5194.7 5200.2 5212.0 6052.8 6085.8 6087.1 6096.8 6108.6 7575.4 7603.7 7634.8 7638.0 7656.2 1462.7 1726.3 1748.6 1821.6 1822.5 974.4 1161.3 1167.4 1178.3 1185.4 7091.1 7099.8 7126.4 7136.5 7138.8 6977.8 7379.3 7865.6 7874.2 7887.6 7093.4 7099.5 7112.4 7122.3 7155.8 3232.6 4069.4 4127.6 4175.9 4187.8 8126.1 8266.2 8279.5 8292.4 8298.5 8180.9 8254.1 8506.4 8508.6 8512.7 8332.5 8368.6 8386.5 8394.5 8418.5 7753.5 7979.7 8003.9 8031.4 8048.6 7784.1 7862.2 7869.7 7883.0 7890.4 8356.1 8366.2 8375.5 8389.0 8400.4 4984.5 5159.2 5162.4 5169.1 5178.3 6775.8 7626.7 7951.7 8018.5 8036.4 7646.5 7705.2 7712.4 7717.3 7717.8 7700.4 7715.7 7716.9 7720.0 7733.1 7262.1 7481.7 7489.4 7557.8 7591.7 7659.2 7684.5 7701.9 7724.7 7733.9 6105.7 7493.4 7529.0 7559.7 7581.1 06:17:42 INFO - PROCESS | 1667 | 06:17:42 INFO - PROCESS | 1667 | [#5] yui.html Cycles:180 Average:18730.68 Median:599.38 stddev:26732.70 (4460.1%) stddev-sans-first:26773.37 06:17:42 INFO - PROCESS | 1667 | Values: 689.8 726.8 759.7 771.4 774.1 15585.9 15817.0 15818.6 15845.3 15878.4 14686.8 14690.3 14697.3 14716.1 14767.7 770.4 922.4 947.4 956.8 958.1 949.0 949.9 955.1 959.3 962.0 1007.3 1008.3 1008.9 1010.0 1010.9 995.0 997.3 1005.6 1005.9 1006.2 724.5 735.5 746.7 747.4 747.8 14916.3 15069.2 15074.6 15255.4 15358.1 13253.5 13311.2 13334.7 13413.5 13486.7 10343.3 10400.4 10403.4 10449.5 10776.3 3399.5 3560.8 3605.0 3666.6 3840.5 83227.2 83486.6 83908.0 83941.0 86328.1 9561.9 9807.4 9834.7 9843.6 9926.1 21818.6 22229.8 22282.4 22587.8 22775.0 7633.5 7741.7 7747.1 7785.1 7915.8 4186.8 4191.4 4198.9 4235.5 4294.5 3760.0 3760.0 3839.6 3843.2 3857.4 663.5 670.5 680.3 680.6 695.7 535.2 551.2 605.8 612.9 627.6 8121.2 8298.5 8421.6 8786.0 8879.1 599.4 599.4 616.9 618.0 637.1 3842.4 3940.7 3949.6 3952.3 4148.4 86698.6 87554.6 91708.5 99784.0 99925.5 82739.2 83397.6 83532.0 84376.7 84775.6 71767.6 72790.0 73148.3 74248.6 75409.6 7791.4 7903.9 8059.8 8081.6 8167.4 32168.4 51199.0 51488.2 51724.0 53014.4 67349.3 71190.0 71781.9 72488.6 72535.0 10007.1 10099.2 10223.8 10309.9 10729.1 11047.8 11256.5 11431.4 11432.1 11748.5 10437.7 10840.4 10913.3 10976.0 11468.1 10596.9 10622.0 10741.2 11031.4 11469.5 10587.7 10605.6 10713.0 10839.7 11226.0 8767.8 8957.4 9001.5 9156.9 9292.1 8622.1 8630.7 8713.6 8801.9 8911.4 06:17:42 INFO - PROCESS | 1667 | -------- Summary: end -------- 06:17:42 INFO - PROCESS | 1667 | 06:17:42 INFO - TEST-INFO | 1667: exit 0 06:17:42 INFO - TEST-OK | dromaeo_css | took 1110222ms 06:17:42 INFO - TEST-START | kraken 06:17:42 INFO - operating with platform_type : mac_ 06:17:42 INFO - Initialising browser for kraken test... 06:17:42 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/tmplogcau/profile http://localhost:49270/getInfo.html) 06:17:45 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 06:17:45 INFO - PROCESS | 1676 | colorDepth:24 06:17:45 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 06:17:45 INFO - PROCESS | 1676 | __metrics 06:17:45 ERROR - PROCESS | 1676 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 06:17:46 INFO - TEST-INFO | 1676: exit 0 06:17:46 INFO - Browser initialized. 06:17:46 INFO - Running cycle 1/1 for kraken test... 06:17:46 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/tmplogcau/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:17:57 INFO - PROCESS | 1680 | RSS: Main: 171020288 06:17:57 INFO - PROCESS | 1680 | 06:18:00 INFO - PROCESS | 1680 | 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:18:01 INFO - PROCESS | 1680 | RSS: Main: 183697408 06:18:01 INFO - PROCESS | 1680 | 06:18:04 INFO - PROCESS | 1680 | 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:18:04 INFO - PROCESS | 1680 | RSS: Main: 192311296 06:18:04 INFO - PROCESS | 1680 | 06:18:07 INFO - PROCESS | 1680 | 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:18:08 INFO - PROCESS | 1680 | RSS: Main: 196321280 06:18:08 INFO - PROCESS | 1680 | 06:18:10 INFO - PROCESS | 1680 | 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:18:11 INFO - PROCESS | 1680 | RSS: Main: 197640192 06:18:11 INFO - PROCESS | 1680 | 06:18:13 INFO - PROCESS | 1680 | 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:18:13 INFO - PROCESS | 1680 | RSS: Main: 197398528 06:18:13 INFO - PROCESS | 1680 | 06:18:16 INFO - PROCESS | 1680 | 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:18:17 INFO - PROCESS | 1680 | RSS: Main: 198172672 06:18:17 INFO - PROCESS | 1680 | 06:18:20 INFO - PROCESS | 1680 | 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:18:20 INFO - PROCESS | 1680 | RSS: Main: 197869568 06:18:20 INFO - PROCESS | 1680 | 06:18:23 INFO - PROCESS | 1680 | 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:18:24 INFO - PROCESS | 1680 | RSS: Main: 198242304 06:18:24 INFO - PROCESS | 1680 | 06:18:25 INFO - PROCESS | 1680 | 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:18:26 INFO - PROCESS | 1680 | RSS: Main: 197554176 06:18:26 INFO - PROCESS | 1680 | 06:18:28 INFO - PROCESS | 1680 | 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:18:28 INFO - PROCESS | 1680 | RSS: Main: 197726208 06:18:28 INFO - PROCESS | 1680 | 06:18:30 INFO - PROCESS | 1680 | 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:18:31 INFO - PROCESS | 1680 | RSS: Main: 197971968 06:18:31 INFO - PROCESS | 1680 | 06:18:34 INFO - PROCESS | 1680 | 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:18:35 INFO - PROCESS | 1680 | RSS: Main: 198201344 06:18:35 INFO - PROCESS | 1680 | 06:18:37 INFO - PROCESS | 1680 | 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:18:38 INFO - PROCESS | 1680 | RSS: Main: 198029312 06:18:38 INFO - PROCESS | 1680 | 06:18:40 INFO - PROCESS | 1680 | 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:18:40 INFO - PROCESS | 1680 | RSS: Main: 200114176 06:18:40 INFO - PROCESS | 1680 | 06:18:40 INFO - PROCESS | 1680 | __start_tp_report 06:18:40 INFO - PROCESS | 1680 | _x_x_mozilla_page_load 06:18:40 INFO - PROCESS | 1680 | _x_x_mozilla_page_load_details 06:18:40 INFO - PROCESS | 1680 | |i|pagename|runs| 06:18:40 INFO - PROCESS | 1680 | |0;ai-astar;115;111;118;113;117;133;115;116;115;114 06:18:40 INFO - PROCESS | 1680 | |1;audio-beat-detection;157;120;142;156;118;142;161;149;204;145 06:18:40 INFO - PROCESS | 1680 | |2;audio-dft;194;192;196;198;194;196;196;195;196;193 06:18:40 INFO - PROCESS | 1680 | |3;audio-fft;69;84;73;136;57;69;64;64;132;58 06:18:40 INFO - PROCESS | 1680 | |4;audio-oscillator;107;119;147;77;78;97;121;77;79;124 06:18:40 INFO - PROCESS | 1680 | |5;imaging-gaussian-blur;88;86;88;96;132;85;90;88;106;129 06:18:40 INFO - PROCESS | 1680 | |6;imaging-darkroom;95;95;94;94;96;93;94;95;95;94 06:18:40 INFO - PROCESS | 1680 | |7;imaging-desaturate;100;143;91;90;91;91;123;146;91;142 06:18:40 INFO - PROCESS | 1680 | |8;json-parse-financial;58;63;63;63;64;65;63;80;62;61 06:18:40 INFO - PROCESS | 1680 | |9;json-stringify-tinderbox;60;64;62;66;67;71;68;64;63;64 06:18:40 INFO - PROCESS | 1680 | |10;stanford-crypto-aes;80;80;79;83;70;80;97;105;74;100 06:18:40 INFO - PROCESS | 1680 | |11;stanford-crypto-ccm;150;149;136;139;128;127;128;121;169;166 06:18:40 INFO - PROCESS | 1680 | |12;stanford-crypto-pbkdf2;164;164;164;164;161;159;162;157;202;162 06:18:40 INFO - PROCESS | 1680 | |13;stanford-crypto-sha256-iterative;69;65;69;77;90;97;91;91;66;73 06:18:40 INFO - PROCESS | 1680 | __end_tp_report 06:18:40 INFO - PROCESS | 1680 | __start_cc_report 06:18:40 INFO - PROCESS | 1680 | _x_x_mozilla_cycle_collect,1038 06:18:40 INFO - PROCESS | 1680 | __end_cc_report 06:18:40 INFO - PROCESS | 1680 | __startTimestamp1467033520505__endTimestamp 06:18:40 INFO - PROCESS | 1680 | 06:18:40 INFO - PROCESS | 1680 | ------- Summary: start ------- 06:18:40 INFO - PROCESS | 1680 | Number of tests: 14 06:18:40 INFO - PROCESS | 1680 | 06:18:40 INFO - PROCESS | 1680 | [#0] ai-astar Cycles:10 Average:116.70 Median:115.50 stddev:6.06 (5.2%) stddev-sans-first:6.39 06:18:40 INFO - PROCESS | 1680 | Values: 115.0 111.0 118.0 113.0 117.0 133.0 115.0 116.0 115.0 114.0 06:18:40 INFO - PROCESS | 1680 | 06:18:40 INFO - PROCESS | 1680 | [#1] audio-beat-detection Cycles:10 Average:149.40 Median:152.50 stddev:24.03 (15.8%) stddev-sans-first:25.33 06:18:40 INFO - PROCESS | 1680 | Values: 157.0 120.0 142.0 156.0 118.0 142.0 161.0 149.0 204.0 145.0 06:18:40 INFO - PROCESS | 1680 | 06:18:40 INFO - PROCESS | 1680 | [#2] audio-dft Cycles:10 Average:195.00 Median:196.00 stddev:1.76 (0.9%) stddev-sans-first:1.83 06:18:40 INFO - PROCESS | 1680 | Values: 194.0 192.0 196.0 198.0 194.0 196.0 196.0 195.0 196.0 193.0 06:18:40 INFO - PROCESS | 1680 | 06:18:40 INFO - PROCESS | 1680 | [#3] audio-fft Cycles:10 Average:80.60 Median:66.50 stddev:29.19 (43.9%) stddev-sans-first:30.66 06:18:40 INFO - PROCESS | 1680 | Values: 69.0 84.0 73.0 136.0 57.0 69.0 64.0 64.0 132.0 58.0 06:18:40 INFO - PROCESS | 1680 | 06:18:40 INFO - PROCESS | 1680 | [#4] audio-oscillator Cycles:10 Average:102.60 Median:77.00 stddev:24.86 (32.3%) stddev-sans-first:26.31 06:18:40 INFO - PROCESS | 1680 | Values: 107.0 119.0 147.0 77.0 78.0 97.0 121.0 77.0 79.0 124.0 06:18:40 INFO - PROCESS | 1680 | 06:18:40 INFO - PROCESS | 1680 | [#5] imaging-gaussian-blur Cycles:10 Average:98.80 Median:88.00 stddev:17.81 (20.2%) stddev-sans-first:18.46 06:18:40 INFO - PROCESS | 1680 | Values: 88.0 86.0 88.0 96.0 132.0 85.0 90.0 88.0 106.0 129.0 06:18:40 INFO - PROCESS | 1680 | 06:18:40 INFO - PROCESS | 1680 | [#6] imaging-darkroom Cycles:10 Average:94.50 Median:95.00 stddev:0.85 (0.9%) stddev-sans-first:0.88 06:18:40 INFO - PROCESS | 1680 | Values: 95.0 95.0 94.0 94.0 96.0 93.0 94.0 95.0 95.0 94.0 06:18:40 INFO - PROCESS | 1680 | 06:18:40 INFO - PROCESS | 1680 | [#7] imaging-desaturate Cycles:10 Average:110.80 Median:90.50 stddev:24.76 (27.4%) stddev-sans-first:25.95 06:18:40 INFO - PROCESS | 1680 | Values: 100.0 143.0 91.0 90.0 91.0 91.0 123.0 146.0 91.0 142.0 06:18:40 INFO - PROCESS | 1680 | 06:18:40 INFO - PROCESS | 1680 | [#8] json-parse-financial Cycles:10 Average:64.20 Median:63.00 stddev:5.87 (9.3%) stddev-sans-first:5.78 06:18:40 INFO - PROCESS | 1680 | Values: 58.0 63.0 63.0 63.0 64.0 65.0 63.0 80.0 62.0 61.0 06:18:40 INFO - PROCESS | 1680 | 06:18:40 INFO - PROCESS | 1680 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:3.18 (4.9%) stddev-sans-first:2.83 06:18:40 INFO - PROCESS | 1680 | Values: 60.0 64.0 62.0 66.0 67.0 71.0 68.0 64.0 63.0 64.0 06:18:40 INFO - PROCESS | 1680 | 06:18:40 INFO - PROCESS | 1680 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:80.00 stddev:11.69 (14.6%) stddev-sans-first:12.27 06:18:40 INFO - PROCESS | 1680 | Values: 80.0 80.0 79.0 83.0 70.0 80.0 97.0 105.0 74.0 100.0 06:18:40 INFO - PROCESS | 1680 | 06:18:40 INFO - PROCESS | 1680 | [#11] stanford-crypto-ccm Cycles:10 Average:141.30 Median:144.00 stddev:16.72 (11.6%) stddev-sans-first:17.44 06:18:40 INFO - PROCESS | 1680 | Values: 150.0 149.0 136.0 139.0 128.0 127.0 128.0 121.0 169.0 166.0 06:18:40 INFO - PROCESS | 1680 | 06:18:40 INFO - PROCESS | 1680 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.90 Median:164.00 stddev:12.91 (7.9%) stddev-sans-first:13.67 06:18:40 INFO - PROCESS | 1680 | Values: 164.0 164.0 164.0 164.0 161.0 159.0 162.0 157.0 202.0 162.0 06:18:40 INFO - PROCESS | 1680 | 06:18:40 INFO - PROCESS | 1680 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.80 Median:83.50 stddev:12.19 (14.6%) stddev-sans-first:12.40 06:18:40 INFO - PROCESS | 1680 | Values: 69.0 65.0 69.0 77.0 90.0 97.0 91.0 91.0 66.0 73.0 06:18:40 INFO - PROCESS | 1680 | -------- Summary: end -------- 06:18:40 INFO - PROCESS | 1680 | 06:18:41 INFO - TEST-INFO | 1680: exit 0 06:18:41 INFO - TEST-OK | kraken | took 58565ms 06:18:41 INFO - SUITE-END | took 1168s 06:18:41 INFO - Completed test suite (00:19:29) 06:18:41 INFO - javascript benchmark 06:18:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3374.2239284964458, 3695.0, 3740.9438858417147, 3769.0954170998953, 3769.868054618087, 5458.4814442627885, 5775.787084712216, 6095.603785753923, 6101.481374083208, 6111.633302001877, 5275.314209152814, 5429.592780541465, 5992.0712289595185, 6104.206453161083, 6108.144859719643, 4472.3515090311885, 5411.269478620385, 5437.510624043835, 5514.228008078872, 5530.944690553103, 5435.646682965615, 5464.098423760095, 5532.2531458253225, 5536.0, 5589.496945274925, 5522.116461366182, 5533.170024496318, 5544.528715059205, 5558.499735023847, 5567.248421463111, 5340.252364668911, 5466.070767969455, 5486.506214440699, 5527.474889885454, 5547.25112109864, 5360.142377219665, 5368.865778355534, 5429.239906413105, 5430.321209848769, 5442.6462279951675, 4966.0, 5835.854103647401, 5917.349091599921, 5957.1362152487645, 5978.641281523122, 5862.622283763312, 6198.566100372976, 6344.777932772377, 6368.490520758328, 6369.0, 5568.7215639217875, 6419.069234960951, 6419.325970773095, 6437.83905402364, 6439.323870993525, 6071.1196876453105, 6092.329843717188, 6142.662153581596, 6154.907676384813, 6177.196964394645, 5157.0, 6410.839729006812, 6477.093206951031, 6608.603483790988, 6617.139771829631, 6256.874862502725, 6276.592021518678, 6281.403266689657, 6284.497240220771, 6324.019776934582, 6420.454261387835, 6433.453156481752, 6442.033694945796, 6447.903281450782, 6454.612723236621, 6180.289266734383, 6290.55966082379, 6307.842303942438, 6309.337519560472, 6340.524460665469, 6321.178246827975, 6324.146240257598, 6328.873422531616, 6337.17616709834, 6350.33321501245, 5102.979404119191, 5147.56245719118, 5147.819826306061, 5147.871303217449, 5149.922751158736, 3841.8847434577006, 4501.739512936318, 4612.654050946193, 4672.486026537078, 4712.387389639325, 4682.438107427062, 6083.756649733961, 6111.92601248044, 6124.076603295837, 6129.2032035835055, 6335.271443783931, 6375.968120159462, 6385.074164246158, 6401.58389704677, 6407.167068281186, 5999.70001499932, 6065.909011364833, 6126.326104128542, 6143.754249830046, 6158.784442544579, 5609.49514543693, 5612.494875461147, 5615.326160860723, 5620.0, 5628.296462942132, 5576.219329293983, 6666.033425153326, 6673.833154171185, 6678.899816502756, 6679.532432729759, 6267.091271765659, 6329.082283068838, 6391.456726178327, 6457.418832305115, 6458.54790164684, 6648.567843090377, 6660.467162626881, 6679.532432729857, 6685.765998190234, 6699.933000669931, 6206.937930620817, 6292.559520833498, 6388.744450221939, 6389.520785941166, 6407.295197528361, 6381.8723625528155, 6419.967900160469, 6476.417122458813, 6485.837854053498, 6498.902516462352, 6220.191375121205, 6270.122182894307, 6278.246610406598, 6280.7487700491465, 6280.937190628035, 6172.9074063889975, 6183.752649893954, 6270.184875966095, 6279.654618995999, 6281.340459251713, 6071.028635418312, 6103.05402662588, 6160.969195153995, 6240.968795155995, 6274.247090349188, 6217.906731398942, 6235.719392627252, 6250.1874756281395, 6258.280297765815, 6276.937230627818, 5365.275687782099, 6053.848653783691, 6117.492485019787, 6173.104899789595, 6208.658523781055], "value": 5879.421472688945, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [525.3485677759579, 535.4538370861721, 561.6714222180025, 586.2730214533979, 604.6674329118985, 39824.2035159297, 40781.0, 40850.7957460213, 40890.59109408909, 40908.59091409085, 41682.0, 42107.57892421075, 42115.578844211625, 42613.0, 42649.7867510662, 9727.708168754949, 9961.501924903761, 9963.003699630015, 9999.400035997827, 9999.50002499872, 8259.38054645901, 8314.293285070777, 8316.085230624627, 8344.0, 8372.330213582929, 8338.749837504885, 8375.03687075988, 8494.957525212396, 8504.192101750325, 8584.74245772628, 8252.546109963949, 8271.2142346477, 8351.123132071167, 8407.159284071606, 8472.915270847305, 9912.950435247778, 9927.007299270088, 9948.90051099487, 10065.144462720678, 10122.443265620388, 39945.400818987735, 40412.0, 40567.59432405668, 40963.7951810239, 41034.79482602598, 2873.425314937, 3098.411301852641, 3238.3361410910943, 3315.0386387947465, 3385.4583266677214, 29854.40291194164, 30284.54573181404, 30790.23024424385, 31193.84403077993, 31305.0, 2834.4065180359944, 2862.6994165612728, 2874.583185438121, 2884.5528943013865, 2903.303207230271, 509632.0, 510372.0, 518982.0, 522236.0, 523696.0, 74202.25797742061, 76233.61883190549, 76330.0, 76332.0, 76410.85383719248, 79277.0, 81408.59295703484, 81584.18415815885, 81586.0, 81826.0, 18742.344017959305, 18777.061146942873, 19244.61510769777, 19333.90333048354, 19389.90305048494, 14401.495947641783, 14418.495352662607, 14827.703445931022, 14885.851141488663, 14923.70152596942, 21616.675749863763, 21872.671909921362, 22513.774862251496, 22555.887220563793, 22621.773782262295, 7997.800329950438, 9137.360384773136, 9165.358424910326, 9257.0, 9295.304361735156, 956.8899576548647, 1007.8891321954579, 1020.5662593397776, 1057.8571892794528, 1112.1992165640727, 30642.0, 30764.69235307663, 31164.68835311663, 31445.213869652984, 31518.842405787826, 1112.1269803204445, 1136.3693150301497, 1167.2062997161843, 1173.8356630071796, 1180.6044974933322, 12684.556040538722, 15148.16685082309, 15192.860535459884, 15236.0, 15714.292856821241, 668457.0, 669723.0, 673508.0, 678186.0, 683096.0, 61719.691401543605, 62393.37606623967, 62795.6860215696, 63584.0, 63610.68194658997, 1534.9539513814605, 1538.2770098053898, 1551.123615157455, 1561.7188905996802, 1566.537871327961, 29356.853215733783, 29647.555286671148, 29653.40693186081, 30052.84973575118, 30309.090727278217, 44250.0, 52451.475485246185, 52616.47383526116, 52658.47341526689, 52978.20532691936, 604834.975825118, 609283.0, 609296.0, 610996.0, 611496.0, 27722.0, 27780.861095694392, 28294.57558136671, 28778.0, 28881.566776497948, 45569.860753480105, 46659.300110497694, 46735.53264467448, 47242.52757472381, 48448.51551484581, 37218.81390593138, 38049.80975095107, 38783.99168814521, 38965.02587435337, 39784.0, 38571.22857542778, 38573.80713096417, 38780.80609597047, 38896.0, 39543.01142471346, 34009.829950850086, 37892.62107378891, 38632.0, 39502.802485987384, 39531.2093758129, 32275.838620806746, 34615.653843461245, 35155.648443516264, 35172.94481165569, 35449.82275088608, 25523.0, 25809.225723228334, 25825.870870645525, 25896.8705156473, 26241.606375903993], "value": 20748.108070223512, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.6351979780119, 411.1345617475213, 415.2090268039386, 415.67577289714023, 425.1242440572421, 16144.919275403607, 20736.170553177875, 20820.37538873836, 21425.14299428025, 21461.141554337828, 17873.659475539353, 17879.0, 19992.700109498368, 20411.0, 20563.868987205697, 5835.854103647401, 5945.37573554777, 6151.415615516541, 6168.75324987, 6240.469560087398, 5791.044477661202, 6038.124471951564, 6176.8455788605415, 6225.906611400833, 6232.283287421959, 5969.522438204955, 5970.104484327364, 6065.8180254592435, 6072.301685306202, 6082.939170608303, 5355.732213389315, 5509.586780991422, 6714.29499902513, 6785.796426107225, 6793.354631310018, 5068.873278168038, 5228.529432351107, 5901.616394934315, 6029.095635654643, 6034.275886893557, 13709.657258568515, 14002.57992260234, 14182.645433864132, 14196.290185490685, 14244.928775356057, 2043.5606344635974, 2135.572885422906, 2146.624340740364, 2152.849300548962, 2202.658587918875, 8678.00202976653, 9128.89199860059, 9181.89817221931, 15148.469803556933, 15811.762823557656, 1726.499315198591, 1744.3720260706136, 1792.793828709702, 1811.6447224269507, 1845.796962334142, 87553.0, 102328.0, 106699.265525707, 108474.66101355937, 119322.40338798337, 11672.182947193614, 12204.694882627828, 12307.015438764878, 12367.505299787908, 12393.814092788616, 15518.534443966699, 15615.375384984472, 15649.843501565067, 15661.0, 15710.842891571167, 9247.953760231156, 9258.398204116711, 9394.389364691273, 9464.668736594185, 9471.715848524555, 9098.181163695299, 9323.02108278621, 9334.253259739204, 9370.718878433658, 9415.435073895589, 4856.660033797601, 4860.3195552622665, 4952.0, 4953.628477864175, 4975.5522003019905, 1682.0916704979174, 1750.5536088297658, 2118.7033815265877, 2120.978790212109, 2159.7084393606974, 779.7621725373815, 991.97024089276, 994.5623925472769, 1032.3238278927165, 1032.607609108549, 18955.715664265048, 20915.581688366146, 20990.370288891358, 21283.36149915505, 21326.78673213279, 933.2487347685178, 1006.6778630838062, 1025.9076683098408, 1066.1470823341297, 1071.3197119828808, 10734.463276836126, 11177.161712871568, 11197.94401028006, 11221.495032723547, 11235.775284494264, 625932.0, 628172.0, 637065.0, 641004.0, 643342.0, 110136.0, 113908.0, 135608.32195839155, 136207.0, 138792.30603846916, 969.486172328667, 1069.79139067881, 1073.951672174754, 1083.7236504691252, 1098.4013712526692, 17432.0, 17596.208170632097, 17828.643427131643, 18234.544136396697, 18530.351437699617, 51856.0, 53004.0, 53901.46098539121, 54429.0, 54732.726336369655, 58351.0, 74138.25861741313, 74506.0, 76986.8451973232, 78685.21314786779, 7616.96191519061, 7797.064352277763, 7850.371970242481, 7861.646225919962, 7907.090684571118, 8371.41400101987, 10255.128314093086, 11318.09455243595, 11642.70893227676, 11704.297742135159, 9513.048695130432, 9857.014298570086, 9881.604735810488, 9949.950250248703, 10095.394276343442, 9352.953235233781, 9468.763280918032, 9548.761280967754, 9658.613655453984, 9723.02769723022, 9141.720159177854, 9337.906620933976, 9742.756431088996, 10184.490775461345, 10390.532426040696, 7943.563104029103, 8008.319292859939, 8135.227153420416, 8382.413231073766, 8417.158284171534, 8468.195521425454, 10657.840132398176, 11683.299002059564, 11709.531618735155, 11857.5849845255], "value": 9428.432863502565, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1606.6224437257242, 1624.3664970661443, 1890.971635425468, 1981.3560592807341, 2028.5841402512488, 8371.706990255343, 9045.45727256365, 9229.584668689908, 9418.152366287033, 9431.622735090605, 9045.185933266004, 9097.0, 9151.908480915188, 9188.1730644242, 9198.126178013095, 2563.9615405768927, 2568.987155064227, 2570.832895861763, 2577.9871100644473, 2586.896524139032, 2191.791779780918, 2525.5201511712808, 2600.4669042846267, 2604.882780274883, 2616.3982284074673, 2466.7779899809016, 2520.861352625605, 2524.7475252474696, 2542.402535404188, 2578.0847799031353, 2225.254539729193, 2531.531666641668, 2544.592865141578, 2606.8044896632637, 2610.9869450652627, 2564.9487010259877, 2567.9229623111337, 2584.8707564621695, 2602.9088981885543, 2618.952419032383, 9303.906960930439, 9358.53207339637, 9368.95315523418, 9388.155066044088, 9390.295727820441, 5837.795677151322, 5879.500242479395, 5995.760169593211, 6010.068439391901, 6011.068284415923, 3671.6328367163337, 3752.2307926874923, 3765.755225910307, 3839.347310957116, 3841.3661745811905, 1054.2778196935124, 1060.9946950265198, 1065.985070264865, 1075.693427373195, 1083.9458027098613, 12219.572314968933, 12430.254184748945, 12445.439955202037, 12452.875471245352, 12470.937645311806, 5013.974930125326, 5096.439391666913, 5151.2788209649925, 5196.402413722395, 5230.895382092413, 9859.964703706151, 9925.404475731479, 10594.735131621772, 10724.41015744126, 10806.297590656739, 5585.301837270341, 5660.8867822643315, 5694.373618901917, 5697.572682048863, 5713.457221563945, 4717.528247175255, 5112.744362781846, 5145.922811157836, 5224.16413373866, 5239.345081864767, 4290.528041915387, 4321.9135617287475, 4356.215881141362, 4386.539413361551, 4395.714278571946, 1404.2136403613804, 1407.7606806842657, 1417.985820141806, 1428.4928850258216, 1446.9855301447062, 836.5022811427191, 924.3021518753433, 972.7616733900098, 980.1032055669126, 1004.2417974429259, 5310.442403547572, 5948.107783832374, 6167.198264225712, 6193.225846769154, 6234.906476402857, 876.6931573949067, 963.6819849449805, 1050.7478205230843, 1108.2630051015983, 1119.972000699989, 3543.94684079739, 4073.89815254621, 4124.1133156370925, 4140.855070072533, 4154.189932963043, 11141.665750027512, 11190.552377904793, 11248.381339026431, 11457.026152777107, 11469.967702906612, 11168.93895079966, 11208.83186752183, 11256.549738010552, 11263.324200547993, 11314.717132071764, 8705.521196334263, 8757.168069033432, 8770.298376130022, 8801.075887031897, 8814.118588141262, 5162.8967420652125, 5875.764969401176, 6014.308354539284, 6051.939480605138, 6067.878642427038, 9897.50512474359, 9932.25508086882, 9973.551190196313, 10049.095581397709, 10118.949405252926, 9923.65267215644, 10098.242631802497, 10396.220283478619, 10425.270231083752, 10436.269461137952, 6705.966470167618, 7335.926640733524, 7426.702931882664, 8304.252617264476, 8555.914440855511, 8513.82972340562, 8566.0, 8617.224449799549, 8647.0920553341, 8665.740027799176, 7515.098188217449, 7762.068551773823, 7768.106667733057, 7787.844243115219, 7811.257930496594, 7356.77929662111, 7582.469227154046, 7595.088589369311, 7697.88453173214, 7755.495892766952, 7266.600336981517, 7297.598632075287, 7305.41556675454, 7316.158641756266, 7330.853382932418, 4898.4121905371585, 4923.286123512143, 5055.570276526537, 5098.082345177755, 5114.5652619527755, 5114.258432527337, 5115.18157094863, 5120.871978200575, 5199.506046925536, 5345.545628621455], "value": 4848.952242425999, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.3755489898586, 340.9147713071732, 341.87350680248295, 346.28664950202585, 349.435661406828, 6245.406686364794, 7077.823054423636, 7182.784516464508, 7193.064901562802, 7207.603581802999, 7063.540869843457, 7069.187043489987, 7092.432605391569, 7093.467989900765, 7102.467314951374, 4955.876103097416, 5062.924056139161, 5184.300119483859, 5197.636165468419, 5213.556847667934, 5149.510796474347, 5183.315422487688, 5193.792248310063, 5193.948060519403, 5194.818181363634, 4075.2664520386465, 4593.874500747322, 4689.695169813968, 5132.0, 5157.587393008569, 4508.729476231437, 4559.67769346889, 5131.794728210867, 5148.948510514884, 5154.716490593016, 4468.932966005513, 4487.618552423048, 4499.482559505666, 4502.347159661864, 4508.391367165456, 5416.83749487516, 5494.835154945318, 6484.708188131545, 6796.35434633709, 6881.0, 6061.969690151565, 6077.20996270482, 6085.2697676278685, 6091.969540152271, 6116.26604807426, 7598.126215485235, 7611.771646850603, 7626.0, 7631.35133513652, 7638.350740187036, 5015.423226328982, 5031.77357018935, 5033.119204139298, 5039.773210205512, 5056.2162864755655, 6663.533552651316, 7959.8408031839035, 7985.441019128663, 8035.799105022363, 8064.879026814602, 4999.650024498323, 5088.592912566985, 5090.643654944192, 5094.108531007059, 5123.154679477919, 5167.793288268427, 5184.092783762826, 5194.662346947436, 5200.193969934666, 5212.035773381936, 6052.757889684363, 6085.847853803691, 6087.05650624154, 6096.817095487142, 6108.602940808833, 7575.356094732009, 7603.7338693146585, 7634.847303053908, 7638.007059082283, 7656.196099409593, 1462.700146469971, 1726.335360886068, 1748.5715999580184, 1821.6356728654323, 1822.48059303098, 974.4396971741277, 1161.2625982501172, 1167.3871217610822, 1178.2753606532092, 1185.4309931233056, 7091.11361079865, 7099.751508697171, 7126.394256488153, 7136.536125151849, 7138.750143744944, 6977.81377165883, 7379.262073792685, 7865.567393793282, 7874.173211812677, 7887.605619719106, 7093.361597456254, 7099.538529995534, 7112.431005519546, 7122.323379278961, 7155.821104472429, 3232.612086549629, 4069.4302797608357, 4127.628513433805, 4175.853845115406, 4187.811548480326, 8126.065502467174, 8266.214709602578, 8279.54462504556, 8292.37807164465, 8298.502089874626, 8180.918190818015, 8254.05078415978, 8506.447080939719, 8508.574571271412, 8512.74461766148, 8332.458390204618, 8368.623411946477, 8386.454880432751, 8394.538300393415, 8418.494890306602, 7753.4960227585025, 7979.72070977513, 8003.879941800761, 8031.437799353989, 8048.5975701215875, 7784.143744188248, 7862.213778622092, 7869.724559640385, 7882.960585197037, 7890.447668663139, 8356.122607126408, 8366.205210504992, 8375.539345336065, 8389.0, 8400.369972251983, 4984.501549845131, 5159.174532075001, 5162.354705661793, 5169.095408303607, 5178.326817513699, 6775.830604234933, 7626.656800444104, 7951.681932722627, 8018.518888866687, 8036.357091432788, 7646.541207527566, 7705.22947705225, 7712.383009359126, 7717.2668596483245, 7717.768466946, 7700.4224683150105, 7715.729949451742, 7716.92283077162, 7720.0, 7733.110692270461, 7262.092238470192, 7481.738139165103, 7489.400847932261, 7557.848843023219, 7591.696332146652, 7659.195784442553, 7684.500507466997, 7701.922980770345, 7724.652390642322, 7733.8839917400155, 6105.694715264308, 7493.4379921505015, 7528.962355188189, 7559.659815308214, 7581.128170260491], "value": 5536.683066931788, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [689.841336492607, 726.8473620539687, 759.745485262437, 771.3674786674925, 774.0633833061996, 15585.908986370945, 15816.999999999985, 15818.604534886634, 15845.286962086704, 15878.364865405385, 14686.779698304534, 14690.265486725675, 14697.338619762137, 14716.117032978029, 14767.704645907075, 770.4491288728558, 922.3866129024191, 947.369998950697, 956.775157837911, 958.1376760915198, 948.9572969216401, 949.9050094990515, 955.1356022799378, 959.2901253072711, 961.9519024048805, 1007.2948935744971, 1008.2589296866797, 1008.9445080520568, 1010.0, 1010.8685870836781, 995.0199053931872, 997.3417544420683, 1005.5877090392904, 1005.9144972677332, 1006.1598565198105, 724.5181954000583, 735.481485552684, 746.6789280609336, 747.4319517166992, 747.8466914282614, 14916.254187290591, 15069.171195584238, 15074.623134421618, 15255.38978440861, 15358.078515289119, 13253.46986120554, 13311.201327920258, 13334.733305333935, 13413.46346146153, 13486.705676009282, 10343.327683700536, 10400.375977441377, 10403.427811470367, 10449.47752612374, 10776.299540529919, 3399.5070714746225, 3560.8219589020446, 3605.0, 3666.633336666339, 3840.539135303781, 83227.16772832254, 83486.58256708678, 83908.0, 83940.99999999939, 86328.13671863264, 9561.856572151284, 9807.362521436084, 9834.704958851245, 9843.557039933221, 9926.106650401354, 21818.563628727654, 22229.77736224491, 22282.442938926655, 22587.757673328124, 22774.975126119363, 7633.465657404039, 7741.690332386642, 7747.070351557849, 7785.1436342002335, 7915.802104947423, 4186.832526698959, 4191.392248124005, 4198.895027624334, 4235.53409124996, 4294.527601963781, 3760.0, 3760.0, 3839.5584507781405, 3843.2121415110396, 3857.3828187490426, 663.548786824954, 670.4770279182246, 680.3094858718405, 680.5950459476702, 695.7251885505198, 535.2426316761816, 551.2447946313496, 605.7879742090233, 612.8804883047852, 627.6391075131726, 8121.228483294078, 8298.460600060977, 8421.621027053798, 8785.956070219609, 8879.112088791198, 599.3766482857866, 599.385629729522, 616.8704572039832, 618.0358640520802, 637.1430426076919, 3842.4044273137706, 3940.665043471337, 3949.6050394960275, 3952.26883026641, 4148.398482220061, 86698.56650716832, 87554.56222718845, 91708.53140980503, 99784.0, 99925.50111748329, 82739.17260827315, 83397.58301208577, 83532.0, 84376.73434898481, 84775.57612212023, 71767.64116179386, 72790.0, 73148.26851731415, 74248.62875685588, 75409.62295188488, 7791.415643826623, 7903.920960790549, 8059.83880322402, 8081.555514446762, 8167.387445941459, 32168.35663286768, 51199.0, 51488.22767658413, 51724.0, 53014.384677667964, 67349.3265067343, 71190.0, 71781.92327114994, 72488.63755681188, 72535.0, 10007.097584339848, 10099.20457592298, 10223.846642300223, 10309.896901030894, 10729.088027517437, 11047.779044418905, 11256.549738010388, 11431.371274579978, 11432.142589306002, 11748.471318790846, 10437.68686939393, 10840.403777792297, 10913.345199288067, 10976.0, 11468.082553395541, 10596.8940310599, 10622.044016038593, 10741.194410419093, 11031.393273370042, 11469.483873225892, 10587.682369528926, 10605.575776968835, 10713.035826775627, 10839.674809755405, 11226.0, 8767.833724118584, 8957.417767845069, 9001.54992250398, 9156.862647060432, 9292.070792920655, 8622.094680058504, 8630.654773809229, 8713.607887645197, 8801.91198088011, 8911.420757650732], "value": 7027.599798514439, "unit": "score"}], "name": "dromaeo_css", "value": 7752.027167007276, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 111.0, 118.0, 113.0, 117.0, 133.0, 115.0, 116.0, 115.0, 114.0], "value": 116.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 120.0, 142.0, 156.0, 118.0, 142.0, 161.0, 149.0, 204.0, 145.0], "value": 149.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 192.0, 196.0, 198.0, 194.0, 196.0, 196.0, 195.0, 196.0, 193.0], "value": 195.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 84.0, 73.0, 136.0, 57.0, 69.0, 64.0, 64.0, 132.0, 58.0], "value": 80.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 119.0, 147.0, 77.0, 78.0, 97.0, 121.0, 77.0, 79.0, 124.0], "value": 102.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 88.0, 96.0, 132.0, 85.0, 90.0, 88.0, 106.0, 129.0], "value": 98.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 96.0, 93.0, 94.0, 95.0, 95.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 143.0, 91.0, 90.0, 91.0, 91.0, 123.0, 146.0, 91.0, 142.0], "value": 110.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 63.0, 63.0, 63.0, 64.0, 65.0, 63.0, 80.0, 62.0, 61.0], "value": 64.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 64.0, 62.0, 66.0, 67.0, 71.0, 68.0, 64.0, 63.0, 64.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 79.0, 83.0, 70.0, 80.0, 97.0, 105.0, 74.0, 100.0], "value": 84.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 136.0, 139.0, 128.0, 127.0, 128.0, 121.0, 169.0, 166.0], "value": 141.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 164.0, 164.0, 161.0, 159.0, 162.0, 157.0, 202.0, 162.0], "value": 165.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 65.0, 69.0, 77.0, 90.0, 97.0, 91.0, 91.0, 66.0, 73.0], "value": 78.8, "unit": "score"}], "name": "kraken", "value": 1548.3, "alertThreshold": 2.0}]} 06:18:41 INFO - Return code: 0 06:18:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:18:41 ERROR - # TBPL SUCCESS # 06:18:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:18:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:18:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:18:41 INFO - 2016-06-27 06:18:41.851 screenresolution[1685:11493] starting screenresolution argv=screenresolution get 06:18:41 INFO - 2016-06-27 06:18:41.853 screenresolution[1685:11493] Display 0: 1600x1200x32@60 06:18:41 INFO - 2016-06-27 06:18:41.859 screenresolution[1686:11496] starting screenresolution argv=screenresolution list 06:18:41 INFO - Available Modes on Display 0 06:18:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:18:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:18:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:18:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:18:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:18:42 INFO - Intel Iris: 06:18:42 INFO - Chipset Model: Intel Iris 06:18:42 INFO - Type: GPU 06:18:42 INFO - Bus: Built-In 06:18:42 INFO - VRAM (Dynamic, Max): 1536 MB 06:18:42 INFO - Vendor: Intel (0x8086) 06:18:42 INFO - Device ID: 0x0a2e 06:18:42 INFO - Revision ID: 0x0009 06:18:42 INFO - Displays: 06:18:42 INFO - Display: 06:18:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:18:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:18:42 INFO - Display Serial Number: 1600x1200 60 06:18:42 INFO - Main Display: Yes 06:18:42 INFO - Mirror: Off 06:18:42 INFO - Online: Yes 06:18:42 INFO - Rotation: Supported 06:18:42 INFO - Return code: 0 06:18:42 INFO - Running post-action listener: _resource_record_post_action 06:18:42 INFO - Running post-run listener: _resource_record_post_run 06:18:43 INFO - Total resource usage - Wall time: 1193s; CPU: 53.0%; Read bytes: 32751104; Write bytes: 500284416; Read time: 336; Write time: 1669 06:18:43 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 193399296; Write bytes: 189174784; Read time: 17698; Write time: 387 06:18:43 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 30969344; Write bytes: 301369344; Read time: 318; Write time: 1251 06:18:43 INFO - Running post-run listener: _upload_blobber_files 06:18:43 INFO - Blob upload gear active. 06:18:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:18:43 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:18:43 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:18:43 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:18:43 INFO - (blobuploader) - INFO - Open directory for files ... 06:18:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:18:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:18:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:18:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:18:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:18:45 INFO - (blobuploader) - INFO - Done attempting. 06:18:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:18:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:18:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:18:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:18:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:18:47 INFO - (blobuploader) - INFO - Done attempting. 06:18:47 INFO - (blobuploader) - INFO - Iteration through files over. 06:18:47 INFO - Return code: 0 06:18:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:18:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:18:47 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/58e958f2434ac88f88a9ee5fa06d0d525620d9caf02ddeb7f401b836cb7ff265fab42ee2156399347e9bf498e7b02b5f498fa77686d527619f0dbfb8f6c15698", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c65bca458ddf8054d175caedbb3962882928c4b8dfba14ba31da700908c9c67fca627be164b727ee87babc3c6468a53556748a20f8ec24a8b89b0078cc5ba17e"} 06:18:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:18:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:18:47 INFO - Contents: 06:18:47 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/58e958f2434ac88f88a9ee5fa06d0d525620d9caf02ddeb7f401b836cb7ff265fab42ee2156399347e9bf498e7b02b5f498fa77686d527619f0dbfb8f6c15698", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c65bca458ddf8054d175caedbb3962882928c4b8dfba14ba31da700908c9c67fca627be164b727ee87babc3c6468a53556748a20f8ec24a8b89b0078cc5ba17e"} 06:18:47 INFO - Running post-run listener: copy_logs_to_upload_dir 06:18:47 INFO - Copying logs to upload dir... 06:18:47 INFO - mkdir: /builds/slave/test/build/upload/logs 06:18:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.562377 ========= master_lag: 0.51 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-06-27 06:18:47.570725) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 06:18:47.574100) ========= 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.l07cEfk3CL/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.t31DGEV9O6/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/58e958f2434ac88f88a9ee5fa06d0d525620d9caf02ddeb7f401b836cb7ff265fab42ee2156399347e9bf498e7b02b5f498fa77686d527619f0dbfb8f6c15698", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c65bca458ddf8054d175caedbb3962882928c4b8dfba14ba31da700908c9c67fca627be164b727ee87babc3c6468a53556748a20f8ec24a8b89b0078cc5ba17e"} build_url:https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010872 build_url: 'https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/58e958f2434ac88f88a9ee5fa06d0d525620d9caf02ddeb7f401b836cb7ff265fab42ee2156399347e9bf498e7b02b5f498fa77686d527619f0dbfb8f6c15698", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c65bca458ddf8054d175caedbb3962882928c4b8dfba14ba31da700908c9c67fca627be164b727ee87babc3c6468a53556748a20f8ec24a8b89b0078cc5ba17e"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 06:18:47.611202) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:18:47.611513) ========= 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.l07cEfk3CL/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.t31DGEV9O6/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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.005115 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:18:47.659396) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 06:18:47.659692) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 06:18:47.660007) ========= ========= Total master_lag: 0.64 =========