builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0026 starttime: 1467032266.63 results: success (0) buildid: 20160624143557 builduid: 67b95f07284347e7aea2678b4c3b20e6 revision: 229741b7de0485ca56b91e0e657fe5d37dbbc98f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:46.627482) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:46.627879) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:46.628169) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:46.662249) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:46.662557) ========= 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.HTWEtY2qoM/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.neMTPKGDz4/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 76.2M=0s 2016-06-27 05:57:47 (76.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.635073 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:47.319407) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:47.319737) ========= 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.HTWEtY2qoM/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.neMTPKGDz4/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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.021510 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:47.368965) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-27 05:57:47.369347) ========= 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.HTWEtY2qoM/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.neMTPKGDz4/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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:47,446 truncating revision to first 12 chars 2016-06-27 05:57:47,446 Setting DEBUG logging. 2016-06-27 05:57:47,446 attempt 1/10 2016-06-27 05:57:47,447 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:48,176 unpacking tar archive at: mozilla-beta-229741b7de04/testing/mozharness/ program finished with exit code 0 elapsedTime=1.004132 ========= master_lag: 0.50 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-27 05:57:48.874270) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:48.874658) ========= script_repo_revision: 229741b7de0485ca56b91e0e657fe5d37dbbc98f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:48.875066) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:48.875342) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 05:57:48.967501) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-06-27 05:57:48.967916) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.HTWEtY2qoM/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.neMTPKGDz4/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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:49 INFO - MultiFileLogger online at 20160627 05:57:49 in /builds/slave/test 05:57:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:57:49 INFO - {'append_to_log': False, 05:57:49 INFO - 'base_work_dir': '/builds/slave/test', 05:57:49 INFO - 'blob_upload_branch': 'Mozilla-Beta', 05:57:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:57:49 INFO - 'branch': 'Mozilla-Beta', 05:57:49 INFO - 'buildbot_json_path': 'buildprops.json', 05:57:49 INFO - 'config_files': ('talos/mac_config.py',), 05:57:49 INFO - 'default_actions': ('clobber', 05:57:49 INFO - 'read-buildbot-config', 05:57:49 INFO - 'download-and-extract', 05:57:49 INFO - 'populate-webroot', 05:57:49 INFO - 'create-virtualenv', 05:57:49 INFO - 'install', 05:57:49 INFO - 'run-tests'), 05:57:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:57:49 INFO - 'download_minidump_stackwalk': True, 05:57:49 INFO - 'download_symbols': 'ondemand', 05:57:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:57:49 INFO - 'tooltool.py': '/tools/tooltool.py', 05:57:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:57:49 INFO - '/tools/misc-python/virtualenv.py')}, 05:57:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:57:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:57:49 INFO - 'installer_path': 'installer.exe', 05:57:49 INFO - 'log_level': 'info', 05:57:49 INFO - 'log_name': 'talos', 05:57:49 INFO - 'log_to_console': True, 05:57:49 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:57:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:57:49 INFO - 'opt_config_files': (), 05:57:49 INFO - 'pip_index': False, 05:57:49 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:57:49 INFO - 'cmd': ('bash', 05:57:49 INFO - '-c', 05:57:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:57:49 INFO - 'enabled': True, 05:57:49 INFO - 'halt_on_failure': False, 05:57:49 INFO - 'name': 'check_screen_resolution'},), 05:57:49 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:57:49 INFO - 'cmd': ('bash', 05:57:49 INFO - '-c', 05:57:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:57:49 INFO - 'enabled': True, 05:57:49 INFO - 'halt_on_failure': False, 05:57:49 INFO - 'name': 'check_screen_resolution'},), 05:57:49 INFO - 'run_cmd_checks_enabled': True, 05:57:49 INFO - 'sps_profile': False, 05:57:49 INFO - 'sps_profile_interval': 0, 05:57:49 INFO - 'suite': 'dromaeojs', 05:57:49 INFO - 'system_bits': '32', 05:57:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:57:49 INFO - 'title': 't-yosemite-r7-0026', 05:57:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:57:49 INFO - 'use_talos_json': True, 05:57:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:57:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:57:49 INFO - 'work_dir': 'build'} 05:57:49 INFO - ##### 05:57:49 INFO - ##### Running clobber step. 05:57:49 INFO - ##### 05:57:49 INFO - Running pre-action listener: _resource_record_pre_action 05:57:49 INFO - Running main action method: clobber 05:57:49 INFO - rmtree: /builds/slave/test/build 05:57:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:57:50 INFO - Running post-action listener: _resource_record_post_action 05:57:50 INFO - ##### 05:57:50 INFO - ##### Running read-buildbot-config 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: read_buildbot_config 05:57:50 INFO - Using buildbot properties: 05:57:50 INFO - { 05:57:50 INFO - "project": "", 05:57:50 INFO - "product": "firefox", 05:57:50 INFO - "script_repo_revision": "production", 05:57:50 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 05:57:50 INFO - "repository": "", 05:57:50 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 05:57:50 INFO - "buildid": "20160624143557", 05:57:50 INFO - "pgo_build": "False", 05:57:50 INFO - "basedir": "/builds/slave/test", 05:57:50 INFO - "buildnumber": 14, 05:57:50 INFO - "slavename": "t-yosemite-r7-0026", 05:57:50 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 05:57:50 INFO - "platform": "yosemite_r7", 05:57:50 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 05:57:50 INFO - "branch": "mozilla-beta", 05:57:50 INFO - "repo_path": "releases/mozilla-beta", 05:57:50 INFO - "revision": "229741b7de0485ca56b91e0e657fe5d37dbbc98f", 05:57:50 INFO - "stage_platform": "macosx64", 05:57:50 INFO - "builduid": "67b95f07284347e7aea2678b4c3b20e6", 05:57:50 INFO - "slavebuilddir": "test" 05:57:50 INFO - } 05:57:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 05:57:50 INFO - Running post-action listener: _resource_record_post_action 05:57:50 INFO - ##### 05:57:50 INFO - ##### Running download-and-extract 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: download_and_extract 05:57:50 INFO - mkdir: /builds/slave/test/build/tests 05:57:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:50 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:50 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:50 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:50 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:50 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:03 INFO - Return code: 0 05:58:03 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:03 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:03 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:03 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:03 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:03 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:03 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:21 INFO - Downloaded 18344069 bytes. 05:58:21 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:21 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:25 INFO - Return code: 0 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 - 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:25 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:25 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:25 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:25 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:26 INFO - Downloaded 10840145 bytes. 05:58:26 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:26 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:26 INFO - Return code: 0 05:58:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:26 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:26 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:26 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:26 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:26 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:32 INFO - Downloaded 86227039 bytes. 05:58:32 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:32 INFO - mkdir: /builds/slave/test/properties 05:58:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:58:32 INFO - Writing to file /builds/slave/test/properties/build_url 05:58:32 INFO - Contents: 05:58:32 INFO - build_url:https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 05:58:33 INFO - Running post-action listener: _resource_record_post_action 05:58:33 INFO - Running post-action listener: set_extra_try_arguments 05:58:33 INFO - ##### 05:58:33 INFO - ##### Running populate-webroot step. 05:58:33 INFO - ##### 05:58:33 INFO - Running pre-action listener: _resource_record_pre_action 05:58:33 INFO - Running main action method: populate_webroot 05:58:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:58:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:58:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:58:33 INFO - '--tppagecycles', 05:58:33 INFO - '7'], 05:58:33 INFO - 'tests': ['tsvgm']}}, 05:58:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:58:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:58:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:58:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:58:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:58:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:58:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:33 INFO - 'talos_options': ['--disable-e10s'], 05:58:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:58:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:58:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:33 INFO - 'talos_options': ['--disable-e10s'], 05:58:33 INFO - 'tests': ['damp', 'tps']}, 05:58:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:33 INFO - 'tests': ['damp', 'tps']}, 05:58:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:58:33 INFO - 'tests': ['dromaeo_dom']}, 05:58:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:58:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:58:33 INFO - 'tests': ['a11yr', 05:58:33 INFO - 'ts_paint', 05:58:33 INFO - 'tpaint', 05:58:33 INFO - 'sessionrestore', 05:58:33 INFO - 'sessionrestore_no_auto_restore', 05:58:33 INFO - 'tabpaint']}, 05:58:33 INFO - 'other-e10s': {'tests': ['a11yr', 05:58:33 INFO - 'ts_paint', 05:58:33 INFO - 'tpaint', 05:58:33 INFO - 'sessionrestore', 05:58:33 INFO - 'sessionrestore_no_auto_restore', 05:58:33 INFO - 'tabpaint']}, 05:58:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:58:33 INFO - 'ts_paint', 05:58:33 INFO - 'tpaint', 05:58:33 INFO - 'sessionrestore', 05:58:33 INFO - 'sessionrestore_no_auto_restore', 05:58:33 INFO - 'tabpaint']}, 05:58:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:58:33 INFO - 'ts_paint', 05:58:33 INFO - 'tpaint', 05:58:33 INFO - 'sessionrestore', 05:58:33 INFO - 'sessionrestore_no_auto_restore', 05:58:33 INFO - 'tabpaint']}, 05:58:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:58:33 INFO - 'tests': ['a11yr', 05:58:33 INFO - 'ts_paint', 05:58:33 INFO - 'tpaint', 05:58:33 INFO - 'sessionrestore', 05:58:33 INFO - 'sessionrestore_no_auto_restore', 05:58:33 INFO - 'tabpaint']}, 05:58:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:58:33 INFO - 'tests': ['a11yr', 05:58:33 INFO - 'ts_paint', 05:58:33 INFO - 'tpaint', 05:58:33 INFO - 'sessionrestore', 05:58:33 INFO - 'sessionrestore_no_auto_restore', 05:58:33 INFO - 'tabpaint']}, 05:58:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:58:33 INFO - 'tests': ['tsvgx', 05:58:33 INFO - 'tsvgr_opacity', 05:58:33 INFO - 'tart', 05:58:33 INFO - 'tscrollx', 05:58:33 INFO - 'cart']}, 05:58:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:58:33 INFO - 'tsvgr_opacity', 05:58:33 INFO - 'tart', 05:58:33 INFO - 'tscrollx', 05:58:33 INFO - 'cart']}, 05:58:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:33 INFO - 'talos_options': ['--disable-e10s'], 05:58:33 INFO - 'tests': ['tp5o']}, 05:58:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:33 INFO - 'tests': ['tp5o']}, 05:58:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:33 INFO - 'talos_options': ['--disable-e10s', 05:58:33 INFO - '--xperf_path', 05:58:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:58:33 INFO - 'tests': ['tp5n']}, 05:58:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:33 INFO - 'talos_options': ['--xperf_path', 05:58:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:58:33 INFO - 'tests': ['tp5n']}}, 05:58:33 INFO - 'talos.zip': {'path': '', 05:58:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:58:33 INFO - Running post-action listener: _resource_record_post_action 05:58:33 INFO - ##### 05:58:33 INFO - ##### Running create-virtualenv step. 05:58:33 INFO - ##### 05:58:33 INFO - Running pre-action listener: _resource_record_pre_action 05:58:33 INFO - Running main action method: create_virtualenv 05:58:33 INFO - Creating virtualenv /builds/slave/test/build/venv 05:58:33 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:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:58:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:58:33 INFO - Using real prefix '/tools/python27' 05:58:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:58:34 INFO - Installing distribute.............................................................................................................................................................................................done. 05:58:37 INFO - Installing pip.................done. 05:58:37 INFO - Return code: 0 05:58:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:58:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:37 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 0x101f09a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f19420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba1bd940f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101da8e00>, '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 0x101c11db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101da3b20>, '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.HTWEtY2qoM/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.neMTPKGDz4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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:37 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:37 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:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HTWEtY2qoM/Render', 05:58:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:58:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:58:37 INFO - 'HOME': '/Users/cltbld', 05:58:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:58:37 INFO - 'LOGNAME': 'cltbld', 05:58:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:37 INFO - 'MOZ_NO_REMOTE': '1', 05:58:37 INFO - 'NO_EM_RESTART': '1', 05:58:37 INFO - 'PAGER': '/bin/cat', 05:58:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:58:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:37 INFO - 'PWD': '/builds/slave/test', 05:58:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:58:37 INFO - 'SHELL': '/bin/bash', 05:58:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.neMTPKGDz4/Listeners', 05:58:37 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 05:58:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:58:37 INFO - 'USER': 'cltbld', 05:58:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:58:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:58:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:37 INFO - 'XPC_FLAGS': '0x0', 05:58:37 INFO - 'XPC_SERVICE_NAME': '0', 05:58:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:58:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:37 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:37 INFO - Cleaning up... 05:58:37 INFO - Return code: 0 05:58:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:58:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:37 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 0x101f09a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f19420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba1bd940f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101da8e00>, '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 0x101c11db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101da3b20>, '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.HTWEtY2qoM/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.neMTPKGDz4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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:37 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:37 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:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HTWEtY2qoM/Render', 05:58:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:58:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:58:37 INFO - 'HOME': '/Users/cltbld', 05:58:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:58:37 INFO - 'LOGNAME': 'cltbld', 05:58:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:37 INFO - 'MOZ_NO_REMOTE': '1', 05:58:37 INFO - 'NO_EM_RESTART': '1', 05:58:37 INFO - 'PAGER': '/bin/cat', 05:58:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:58:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:37 INFO - 'PWD': '/builds/slave/test', 05:58:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:58:37 INFO - 'SHELL': '/bin/bash', 05:58:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.neMTPKGDz4/Listeners', 05:58:37 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 05:58:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:58:37 INFO - 'USER': 'cltbld', 05:58:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:58:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:58:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:37 INFO - 'XPC_FLAGS': '0x0', 05:58:37 INFO - 'XPC_SERVICE_NAME': '0', 05:58:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:58:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:37 INFO - Downloading/unpacking psutil>=0.7.1 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:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:58:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:58:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:58:41 INFO - Installing collected packages: psutil 05:58:41 INFO - Running setup.py install for psutil 05:58:41 INFO - building 'psutil._psutil_osx' extension 05:58:41 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:41 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:41 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:41 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:41 INFO - building 'psutil._psutil_posix' extension 05:58:41 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:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:58:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:58:41 INFO - ^ 05:58:41 INFO - 1 warning generated. 05:58:41 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:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:58:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:58:41 INFO - Successfully installed psutil 05:58:41 INFO - Cleaning up... 05:58:41 INFO - Return code: 0 05:58:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:58:41 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:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:41 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:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:41 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 0x101f09a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f19420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba1bd940f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101da8e00>, '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 0x101c11db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101da3b20>, '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.HTWEtY2qoM/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.neMTPKGDz4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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:41 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:41 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:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HTWEtY2qoM/Render', 05:58:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:58:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:58:41 INFO - 'HOME': '/Users/cltbld', 05:58:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:58:41 INFO - 'LOGNAME': 'cltbld', 05:58:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:41 INFO - 'MOZ_NO_REMOTE': '1', 05:58:41 INFO - 'NO_EM_RESTART': '1', 05:58:41 INFO - 'PAGER': '/bin/cat', 05:58:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:58:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:41 INFO - 'PWD': '/builds/slave/test', 05:58:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:58:41 INFO - 'SHELL': '/bin/bash', 05:58:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.neMTPKGDz4/Listeners', 05:58:41 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 05:58:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:58:41 INFO - 'USER': 'cltbld', 05:58:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:58:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:58:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:41 INFO - 'XPC_FLAGS': '0x0', 05:58:41 INFO - 'XPC_SERVICE_NAME': '0', 05:58:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:58:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:58:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:58:44 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:44 INFO - Installing collected packages: mozsystemmonitor 05:58:44 INFO - Running setup.py install for mozsystemmonitor 05:58:44 INFO - Successfully installed mozsystemmonitor 05:58:44 INFO - Cleaning up... 05:58:44 INFO - Return code: 0 05:58:44 INFO - Installing blobuploader==1.2.4 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', '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 0x101f09a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f19420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba1bd940f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101da8e00>, '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 0x101c11db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101da3b20>, '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.HTWEtY2qoM/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.neMTPKGDz4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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', 'blobuploader==1.2.4'] 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 blobuploader==1.2.4 05:58:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HTWEtY2qoM/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.neMTPKGDz4/Listeners', 05:58:44 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:45 INFO - Downloading/unpacking blobuploader==1.2.4 05:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:47 INFO - Downloading blobuploader-1.2.4.tar.gz 05:58:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:58:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 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/requests/setup.py) egg_info for package requests 05:58:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:58:48 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:48 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 - 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:48 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:48 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:48 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 - Downloading docopt-0.6.1.tar.gz 05:58:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:58:48 INFO - Installing collected packages: blobuploader, requests, docopt 05:58:48 INFO - Running setup.py install for blobuploader 05:58:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:58:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:58:49 INFO - Running setup.py install for requests 05:58:49 INFO - Running setup.py install for docopt 05:58:49 INFO - Successfully installed blobuploader requests docopt 05:58:49 INFO - Cleaning up... 05:58:49 INFO - Return code: 0 05:58:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58:49 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:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:49 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:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:49 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 0x101f09a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f19420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba1bd940f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101da8e00>, '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 0x101c11db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101da3b20>, '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.HTWEtY2qoM/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.neMTPKGDz4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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:49 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:49 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:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HTWEtY2qoM/Render', 05:58:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:58:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:58:49 INFO - 'HOME': '/Users/cltbld', 05:58:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:58:49 INFO - 'LOGNAME': 'cltbld', 05:58:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:49 INFO - 'MOZ_NO_REMOTE': '1', 05:58:49 INFO - 'NO_EM_RESTART': '1', 05:58:49 INFO - 'PAGER': '/bin/cat', 05:58:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:58:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:49 INFO - 'PWD': '/builds/slave/test', 05:58:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:58:49 INFO - 'SHELL': '/bin/bash', 05:58:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.neMTPKGDz4/Listeners', 05:58:49 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 05:58:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:58:49 INFO - 'USER': 'cltbld', 05:58:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:58:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:58:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:49 INFO - 'XPC_FLAGS': '0x0', 05:58:49 INFO - 'XPC_SERVICE_NAME': '0', 05:58:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:58:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:58:50 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-qPwa5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:58:50 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-l84h2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:58:50 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-gcoVsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:58:50 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-XhDRQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:58:50 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-f4hBcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:58:50 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-3uxDJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:58:50 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-Xbh0Up-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:58:50 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-zEiEVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:58:50 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-xLrVaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:58:51 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-4Zxbs1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:58:51 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-RkrVeu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:58:51 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-7SuU3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:58:51 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-ef3rAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:58:51 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-jHkNos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:51 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-qf5R3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:58:51 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-xJOffm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:58:51 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-8d5VuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:58:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:58:51 INFO - Running setup.py install for manifestparser 05:58:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:58:51 INFO - Running setup.py install for mozcrash 05:58:52 INFO - Running setup.py install for mozdebug 05:58:52 INFO - Running setup.py install for mozdevice 05:58:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:58:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:58:52 INFO - Running setup.py install for mozfile 05:58:52 INFO - Running setup.py install for mozhttpd 05:58:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:58:52 INFO - Running setup.py install for mozinfo 05:58:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:58:52 INFO - Running setup.py install for mozInstall 05:58:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:58:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:58:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:58:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:58:52 INFO - Running setup.py install for mozleak 05:58:53 INFO - Running setup.py install for mozlog 05:58:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:58:53 INFO - Running setup.py install for moznetwork 05:58:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:58:53 INFO - Running setup.py install for mozprocess 05:58:53 INFO - Running setup.py install for mozprofile 05:58:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:58:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:58:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:58:53 INFO - Running setup.py install for mozrunner 05:58:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:58:53 INFO - Running setup.py install for mozscreenshot 05:58:54 INFO - Running setup.py install for moztest 05:58:54 INFO - Running setup.py install for mozversion 05:58:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:58:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:58:54 INFO - Cleaning up... 05:58:54 INFO - Return code: 0 05:58:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58:54 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:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:54 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:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:54 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 0x101f09a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f19420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba1bd940f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101da8e00>, '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 0x101c11db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101da3b20>, '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.HTWEtY2qoM/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.neMTPKGDz4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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:54 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:54 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:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HTWEtY2qoM/Render', 05:58:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:58:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:58:54 INFO - 'HOME': '/Users/cltbld', 05:58:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:58:54 INFO - 'LOGNAME': 'cltbld', 05:58:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:54 INFO - 'MOZ_NO_REMOTE': '1', 05:58:54 INFO - 'NO_EM_RESTART': '1', 05:58:54 INFO - 'PAGER': '/bin/cat', 05:58:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:58:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:54 INFO - 'PWD': '/builds/slave/test', 05:58:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:58:54 INFO - 'SHELL': '/bin/bash', 05:58:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.neMTPKGDz4/Listeners', 05:58:54 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 05:58:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:58:54 INFO - 'USER': 'cltbld', 05:58:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:58:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:58:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:54 INFO - 'XPC_FLAGS': '0x0', 05:58:54 INFO - 'XPC_SERVICE_NAME': '0', 05:58:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:58:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:58:55 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-3wzxZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:58:55 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:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:58:55 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-nVTTxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:58:55 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:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:58:55 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-Isvh3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:58:55 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:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:58:55 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-wod2YR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:58:55 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:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:58:55 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-95NCsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:58:55 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:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:58:55 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-emxyDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:58:55 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:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:58:55 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-7QjBpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:58:55 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:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:58:55 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-0QSsVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:58:55 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:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:58:55 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-oXjBV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:58:56 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:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:58:56 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-QWwQJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:58:56 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:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:58:56 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-pX2Z6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:58:56 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:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:58:56 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-kSyNYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:58:56 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:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:58:56 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-LHUXnP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:58:56 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:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:58:56 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-08G98N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:58:56 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:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:56 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-7f9_q7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:56 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:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:58:56 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-Lvwyp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:58:56 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:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:58:56 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-oztbfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:58:56 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:56 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:56 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:56 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:56 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:56 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:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:58:56 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:56 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:56 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:56 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:56 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:56 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:59 INFO - Downloading blessings-1.6.tar.gz 05:58:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:58:59 INFO - Installing collected packages: blessings 05:58:59 INFO - Running setup.py install for blessings 05:59:00 INFO - Successfully installed blessings 05:59:00 INFO - Cleaning up... 05:59:00 INFO - Return code: 0 05:59:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:59:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:59:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:59:00 INFO - Reading from file tmpfile_stdout 05:59:00 INFO - Current package versions: 05:59:00 INFO - blessings == 1.6 05:59:00 INFO - blobuploader == 1.2.4 05:59:00 INFO - docopt == 0.6.1 05:59:00 INFO - manifestparser == 1.1 05:59:00 INFO - mozInstall == 1.12 05:59:00 INFO - mozcrash == 0.17 05:59:00 INFO - mozdebug == 0.1 05:59:00 INFO - mozdevice == 0.48 05:59:00 INFO - mozfile == 1.2 05:59:00 INFO - mozhttpd == 0.7 05:59:00 INFO - mozinfo == 0.9 05:59:00 INFO - mozleak == 0.1 05:59:00 INFO - mozlog == 3.1 05:59:00 INFO - moznetwork == 0.27 05:59:00 INFO - mozprocess == 0.22 05:59:00 INFO - mozprofile == 0.28 05:59:00 INFO - mozrunner == 6.11 05:59:00 INFO - mozscreenshot == 0.1 05:59:00 INFO - mozsystemmonitor == 0.0 05:59:00 INFO - moztest == 0.7 05:59:00 INFO - mozversion == 1.4 05:59:00 INFO - psutil == 3.1.1 05:59:00 INFO - requests == 1.2.3 05:59:00 INFO - wsgiref == 0.1.2 05:59:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:59:00 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:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:00 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:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:00 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 0x101f09a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f19420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba1bd940f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101da8e00>, '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 0x101c11db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101da3b20>, '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.HTWEtY2qoM/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.neMTPKGDz4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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:59:00 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:59:00 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:59:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HTWEtY2qoM/Render', 05:59:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:59:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:59:00 INFO - 'HOME': '/Users/cltbld', 05:59:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:59:00 INFO - 'LOGNAME': 'cltbld', 05:59:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:00 INFO - 'MOZ_NO_REMOTE': '1', 05:59:00 INFO - 'NO_EM_RESTART': '1', 05:59:00 INFO - 'PAGER': '/bin/cat', 05:59:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:59:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:00 INFO - 'PWD': '/builds/slave/test', 05:59:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:59:00 INFO - 'SHELL': '/bin/bash', 05:59:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.neMTPKGDz4/Listeners', 05:59:00 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 05:59:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:59:00 INFO - 'USER': 'cltbld', 05:59:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:59:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:59:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:00 INFO - 'XPC_FLAGS': '0x0', 05:59:00 INFO - 'XPC_SERVICE_NAME': '0', 05:59:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:59:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:00 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:59:00 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:59:00 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:59:00 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:59:00 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:59:00 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:59:00 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:59:00 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:59:00 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:59:00 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:59:00 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:59:00 INFO - Cleaning up... 05:59:00 INFO - Return code: 0 05:59:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:59:00 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:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:00 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:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:00 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 0x101f09a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f19420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba1bd940f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101da8e00>, '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 0x101c11db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101da3b20>, '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.HTWEtY2qoM/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.neMTPKGDz4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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:59:00 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:59:00 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:59:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HTWEtY2qoM/Render', 05:59:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:59:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:59:00 INFO - 'HOME': '/Users/cltbld', 05:59:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:59:00 INFO - 'LOGNAME': 'cltbld', 05:59:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:00 INFO - 'MOZ_NO_REMOTE': '1', 05:59:00 INFO - 'NO_EM_RESTART': '1', 05:59:00 INFO - 'PAGER': '/bin/cat', 05:59:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:59:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:00 INFO - 'PWD': '/builds/slave/test', 05:59:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:59:00 INFO - 'SHELL': '/bin/bash', 05:59:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.neMTPKGDz4/Listeners', 05:59:00 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 05:59:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:59:00 INFO - 'USER': 'cltbld', 05:59:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:59:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:59:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:00 INFO - 'XPC_FLAGS': '0x0', 05:59:00 INFO - 'XPC_SERVICE_NAME': '0', 05:59:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:59:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:00 INFO - Downloading/unpacking jsonschema 05:59:00 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:59:00 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:59:00 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:59:00 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:59:00 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:59:00 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:59:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:59:03 INFO - Downloading/unpacking functools32 (from jsonschema) 05:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:03 INFO - Downloading functools32-3.2.3-2.tar.gz 05:59:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:59:03 INFO - warning: no files found matching '*.txt' 05:59:03 INFO - no previously-included directories found matching 'build' 05:59:03 INFO - no previously-included directories found matching 'dist' 05:59:03 INFO - no previously-included directories found matching '.git*' 05:59:03 INFO - Installing collected packages: jsonschema, functools32 05:59:03 INFO - Running setup.py install for functools32 05:59:04 INFO - warning: no files found matching '*.txt' 05:59:04 INFO - no previously-included directories found matching 'build' 05:59:04 INFO - no previously-included directories found matching 'dist' 05:59:04 INFO - no previously-included directories found matching '.git*' 05:59:04 INFO - Successfully installed jsonschema functools32 05:59:04 INFO - Cleaning up... 05:59:04 INFO - Return code: 0 05:59:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:59: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:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59: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:59:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:04 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 0x101f09a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f19420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba1bd940f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101da8e00>, '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 0x101c11db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101da3b20>, '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.HTWEtY2qoM/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.neMTPKGDz4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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:59:04 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:59:04 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:59:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HTWEtY2qoM/Render', 05:59:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:59:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:59:04 INFO - 'HOME': '/Users/cltbld', 05:59:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:59:04 INFO - 'LOGNAME': 'cltbld', 05:59:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:04 INFO - 'MOZ_NO_REMOTE': '1', 05:59:04 INFO - 'NO_EM_RESTART': '1', 05:59:04 INFO - 'PAGER': '/bin/cat', 05:59:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:59:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:04 INFO - 'PWD': '/builds/slave/test', 05:59:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:59:04 INFO - 'SHELL': '/bin/bash', 05:59:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.neMTPKGDz4/Listeners', 05:59:04 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 05:59:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:59:04 INFO - 'USER': 'cltbld', 05:59:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:59:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:59:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:04 INFO - 'XPC_FLAGS': '0x0', 05:59:04 INFO - 'XPC_SERVICE_NAME': '0', 05:59:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:59:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:04 INFO - Downloading/unpacking flake8 05:59:04 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:59:04 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:59:04 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:59:04 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:59:04 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:59:04 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:59:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:59:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:59:06 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:59:06 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:59:06 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:59:06 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:59:06 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:59:06 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:59:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:59:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:59:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:59:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:59:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:59:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:59:08 INFO - no previously-included directories found matching 'docs/_build' 05:59:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:59:08 INFO - Running setup.py install for pep8 05:59:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:59:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:59:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:59:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:59:08 INFO - no previously-included directories found matching 'docs/_build' 05:59:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:59:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:59:08 INFO - Cleaning up... 05:59:08 INFO - Return code: 0 05:59:08 INFO - Running post-action listener: _resource_record_post_action 05:59:08 INFO - Running post-action listener: _start_resource_monitoring 05:59:08 INFO - Starting resource monitoring. 05:59:08 INFO - ##### 05:59:08 INFO - ##### Running install step. 05:59:08 INFO - ##### 05:59:08 INFO - Running pre-action listener: _resource_record_pre_action 05:59:08 INFO - Running main action method: install 05:59:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:59:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:59:08 INFO - Reading from file tmpfile_stdout 05:59:08 INFO - Detecting whether we're running mozinstall >=1.0... 05:59:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:59:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:59:09 INFO - Reading from file tmpfile_stdout 05:59:09 INFO - Output received: 05:59:09 INFO - Usage: mozinstall [options] installer 05:59:09 INFO - Options: 05:59:09 INFO - -h, --help show this help message and exit 05:59:09 INFO - -d DEST, --destination=DEST 05:59:09 INFO - Directory to install application into. [default: 05:59:09 INFO - "/builds/slave/test"] 05:59:09 INFO - --app=APP Application being installed. [default: firefox] 05:59:09 INFO - mkdir: /builds/slave/test/build/application 05:59:09 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:59:09 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:30 INFO - Reading from file tmpfile_stdout 05:59:30 INFO - Output received: 05:59:30 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 05:59:30 INFO - Running post-action listener: _resource_record_post_action 05:59:30 INFO - ##### 05:59:30 INFO - ##### Running run-tests step. 05:59:30 INFO - ##### 05:59:30 INFO - Running pre-action listener: _resource_record_pre_action 05:59:30 INFO - Running main action method: run_tests 05:59:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:59:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:59:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:59:30 INFO - 2016-06-27 05:59:30.747 screenresolution[2852:27461] starting screenresolution argv=screenresolution get 05:59:30 INFO - 2016-06-27 05:59:30.750 screenresolution[2852:27461] Display 0: 1600x1200x32@60 05:59:30 INFO - 2016-06-27 05:59:30.755 screenresolution[2853:27465] starting screenresolution argv=screenresolution list 05:59:30 INFO - Available Modes on Display 0 05:59:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:59:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:59:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:59:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:59:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:59:30 INFO - Intel Iris: 05:59:30 INFO - Chipset Model: Intel Iris 05:59:30 INFO - Type: GPU 05:59:30 INFO - Bus: Built-In 05:59:30 INFO - VRAM (Dynamic, Max): 1536 MB 05:59:30 INFO - Vendor: Intel (0x8086) 05:59:30 INFO - Device ID: 0x0a2e 05:59:30 INFO - Revision ID: 0x0009 05:59:30 INFO - Displays: 05:59:30 INFO - Display: 05:59:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:59:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:59:30 INFO - Display Serial Number: 1600x1200 60 05:59:30 INFO - Main Display: Yes 05:59:30 INFO - Mirror: Off 05:59:30 INFO - Online: Yes 05:59:30 INFO - Rotation: Supported 05:59:30 INFO - Return code: 0 05:59:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:59:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:59:31 INFO - Python 2.7.3 05:59:31 INFO - Return code: 0 05:59:31 INFO - grabbing minidump binary from tooltool 05:59:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:31 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 0x101da8e00>, '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 0x101c11db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101da3b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:59:31 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:31 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:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:59:31 INFO - Return code: 0 05:59:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:59:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:59:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:59:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:59:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:59:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:59:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:59:32 INFO - Return code: 0 05:59:32 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', '--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-0026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:59:32 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 --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-0026 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:59:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HTWEtY2qoM/Render', 05:59:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:59:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:59:32 INFO - 'HOME': '/Users/cltbld', 05:59:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:59:32 INFO - 'LOGNAME': 'cltbld', 05:59:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:59:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:59:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:32 INFO - 'MOZ_NO_REMOTE': '1', 05:59:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:59:32 INFO - 'NO_EM_RESTART': '1', 05:59:32 INFO - 'PAGER': '/bin/cat', 05:59:32 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:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:32 INFO - 'PWD': '/builds/slave/test', 05:59:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:59:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:59:32 INFO - 'SHELL': '/bin/bash', 05:59:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.neMTPKGDz4/Listeners', 05:59:32 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 05:59:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:59:32 INFO - 'USER': 'cltbld', 05:59:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:59:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:59:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:32 INFO - 'XPC_FLAGS': '0x0', 05:59:32 INFO - 'XPC_SERVICE_NAME': '0', 05:59:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:59:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--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-0026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:59:32 INFO - mozversion application_buildid: 20160624143557 05:59:32 INFO - mozversion application_changeset: 229741b7de0485ca56b91e0e657fe5d37dbbc98f 05:59:32 INFO - mozversion application_display_name: Firefox 05:59:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:59:32 INFO - mozversion application_name: Firefox 05:59:32 INFO - mozversion application_remotingname: firefox 05:59:32 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:59:32 INFO - mozversion application_vendor: Mozilla 05:59:32 INFO - mozversion application_version: 48.0 05:59:32 INFO - mozversion platform_buildid: 20160624143557 05:59:32 INFO - mozversion platform_changeset: 229741b7de0485ca56b91e0e657fe5d37dbbc98f 05:59:32 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:59:32 INFO - mozversion platform_version: 48.0 05:59:32 INFO - using testdate: 1467032372 05:59:32 INFO - actual date: 1467032372 05:59:32 INFO - starting webserver on 'localhost:52185' 05:59:32 INFO - SUITE-START | Running 2 tests 05:59:32 INFO - TEST-START | dromaeo_css 05:59:32 INFO - operating with platform_type : mac_ 05:59:32 INFO - Initialising browser for dromaeo_css test... 05:59:32 INFO - TEST-INFO | started process 2871 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/tmpEl5Ndf/profile http://localhost:52185/getInfo.html) 05:59:34 INFO - PROCESS | 2871 | __metrics Screen width/height:1600/1200 05:59:34 INFO - PROCESS | 2871 | colorDepth:24 05:59:34 INFO - PROCESS | 2871 | Browser inner width/height: 1024/689 05:59:34 INFO - PROCESS | 2871 | __metrics 05:59:34 INFO - PROCESS | 2871 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:59:34 ERROR - PROCESS | 2871 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:59:35 INFO - TEST-INFO | 2871: exit 0 05:59:35 INFO - Browser initialized. 05:59:35 INFO - Running cycle 1/1 for dromaeo_css test... 05:59:35 INFO - TEST-INFO | started process 2874 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/tmpEl5Ndf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:59:47 INFO - PROCESS | 2874 | RSS: Main: 161083392 05:59:47 INFO - PROCESS | 2874 | 06:00:38 INFO - PROCESS | 2874 | 1467032438374 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:48 INFO - PROCESS | 2874 | Cycle 1(1): loaded http://localhost:52185/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52185/tests/dromaeo/cssquery-ext.html) 06:02:49 INFO - PROCESS | 2874 | RSS: Main: 293744640 06:02:49 INFO - PROCESS | 2874 | 06:05:52 INFO - PROCESS | 2874 | Cycle 1(1): loaded http://localhost:52185/tests/dromaeo/cssquery-ext.html (next: http://localhost:52185/tests/dromaeo/cssquery-jquery.html) 06:05:53 INFO - PROCESS | 2874 | RSS: Main: 301625344 06:05:53 INFO - PROCESS | 2874 | 06:08:55 INFO - PROCESS | 2874 | Cycle 1(1): loaded http://localhost:52185/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52185/tests/dromaeo/cssquery-mootools.html) 06:08:55 INFO - PROCESS | 2874 | RSS: Main: 308658176 06:08:55 INFO - PROCESS | 2874 | 06:11:57 INFO - PROCESS | 2874 | Cycle 1(1): loaded http://localhost:52185/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52185/tests/dromaeo/cssquery-prototype.html) 06:11:58 INFO - PROCESS | 2874 | RSS: Main: 302559232 06:11:58 INFO - PROCESS | 2874 | 06:15:01 INFO - PROCESS | 2874 | Cycle 1(1): loaded http://localhost:52185/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52185/tests/dromaeo/cssquery-yui.html) 06:15:02 INFO - PROCESS | 2874 | RSS: Main: 272056320 06:15:02 INFO - PROCESS | 2874 | 06:18:05 INFO - PROCESS | 2874 | Cycle 1(1): loaded http://localhost:52185/tests/dromaeo/cssquery-yui.html (next: http://localhost:52185/tests/dromaeo/cssquery-dojo.html) 06:18:05 INFO - PROCESS | 2874 | RSS: Main: 316055552 06:18:05 INFO - PROCESS | 2874 | 06:18:05 INFO - PROCESS | 2874 | __start_tp_report 06:18:05 INFO - PROCESS | 2874 | _x_x_mozilla_page_load 06:18:05 INFO - PROCESS | 2874 | _x_x_mozilla_page_load_details 06:18:05 INFO - PROCESS | 2874 | |i|pagename|runs| 06:18:05 INFO - PROCESS | 2874 | |0;dojo.html;3464.2551851351964;3554.786712797234;3567.250877315763;3578.999999999998;3631.0559254593813;5922.555808314372;5935.910961335583;5948.340733874543;5961.165436838841;6027.276726792786;5950.821475355736;5971.1043343498495;5987.610805297652;5991.370906054867;6009.338972713009;5213.635045546814;5312.123499622558;5350;5401.135818269077;5432.348118225818;5385.919211211835;5423;5448.073827449323;5449.3188351456065;5449.754761035743;4435.62297204738;5411.83764487064;5431.809886653968;5463.071277882749;5490.725463726818;5442.074847275952;5466.289382380305;5470.753816078286;5482.506574408282;5502.58730595203;5206.453322401169;5263.421023687391;5363.490468405495;5374.059539580597;5394.163904594794;5753.827385178452;5782.479576838105;5837.066069428871;5874.265716785402;5877.882442351129;6204.534236125292;6237.095621134956;6259.530535209832;6269.7178626961895;6277.089821975834;6219.502439804804;6237.220347456568;6302.338254483259;6307.8738425231695;6352.078948552434;6043.576949613529;6046.153538504657;6063.242094738158;6067.605605635664;6069.332373439007;6396.264429590564;6406.231252249667;6416.165898433173;6422.45409140219;6448;6104.519788040277;6204.534659900525;6273.309935907047;6278.780242691575;6291.370862913764;6308;6338.524610654219;6338.809835704937;6352.65060421672;6359.872802543923;6203.410675985774;6276.623402595859;6277;6280.874382512324;6288.868003759276;6191.25704915413;6236;6251.593646412968;6256.624602523863;6272.5922815016875;5035.420926593415;5075.97462012695;5076.974615126901;5080.491950804964;5120.769565369567;4552.7495987720995;4554.3851580036935;4556.407667003335;4574.336721175411;4592.747398893093;5048.72232027242;5894.115882617556;5995.160677505153;6018.067199584071;6030.18592490017;6248.687565621701;6255.78104766331;6285.654289014148;6293.2762732285455;6300.401461861115;4929.7781599828095;5905.645661260252;5907.675077870673;5945.970270148708;5956.940430595639;5392.5416339611575;5437.13005919051;5460.399356070829;5493.890122197614;5503.614746967673;6389.456896163878;6395.776147834804;6446;6457.6771161442675;6463.838404039937;6268.686565671607;6283.308836027942;6285.151504546828;6286.905696414466;6293.3391993841815;6245.469135123383;6477.1579694639395;6484.221893372825;6502.869942601216;6515.02274658786;5354.143337066206;6213.285472170758;6273.780417685359;6295.118683384421;6296.842578935563;6222.533310001678;6289.716962736779;6292.182016337847;6292.4966002720585;6308.873822523616;6279.937200628118;6296.842578935563;6297.622142671455;6313.621182729051;6328.7152078157515;5102.387713474407;6040.486558642565;6178.289496707756;6255.562110652393;6271.686415679289;6141.884937092248;6162.983107787165;6168.383161683796;6185.948388774009;6188.040853667689;6276.529260305404;6285.779997700059;6287.182666253358;6289.559730818799;6310.463610592968;5986.281646202484;6133.754649813957;6140.62695141751;6202.782902598387;6210.223722034746 06:18:05 INFO - PROCESS | 2874 | |1;ext.html;544.053347175914;545.4845171313108;565.7425871228592;587.9651812809456;598.3836648252302;30035;33168.33663326735;38551.03622409441;39470.01324966877;39525;39378.01554961127;39862;39887.60112398875;39889.202215955665;39892.800535997354;9561.856572151406;9779.70660880171;9783.608655653801;9789.55946982384;9802.264830137732;9080.501717216652;11766.941165294162;12040.879591204064;12043.578474753385;12048.337341446217;11628.476718547643;11696.181267311249;11705.59030433935;11720.648380548597;11734.53061877524;11699.766004679901;11826.94086529566;11830.290182589073;11847.289162650268;11848.40757962107;11515.712107197303;11627.476763545661;11635.185537012412;11644.126690498246;11644.475998580085;41089;41687.957801054916;41707;41739.37390939138;41837.58162418367;3099.7600959616107;3181.7454603631654;3483.4252348362743;3775.244951009809;3801.4107813288983;28148.296292592644;29253;29372.292533763644;29978.400431991457;30389.24026899323;2202.4714068623575;2814.6481689788775;2824.2515733330683;2859.4567032263803;2971.52455607104;424835;430763;431813;431904.99999999686;432202;37590.62409375926;38014.61985380166;38140.42789358162;64139.35860641427;64632.35367646357;36181.63818361835;36538;36571;36613.633863661555;36617.90146295616;15918.681626367408;16079.919600402158;16089.839101608834;16122.516324510283;16132.354705811871;11523.539058437736;12847;12945.223286602833;13604.04771665974;13674.17954922688;8431.873521897054;8453.957730211432;8454.196851299239;8530.232279094911;8538.70114545988;3434.9828250858586;3467.6879080882336;3469.9479507807405;3473.565804274466;3518.5425894633536;888.9688860889838;983.5131609853025;1024.9180065594735;1116.7543140509074;1125.1729978465821;25531.61702574463;27439.725602744118;30032.94884679026;30283.848580757396;30606.38787224243;996.8006398720285;1101.895319944604;1131.8415421840948;1160.4893846707591;1209.9939500302619;15450.304736286895;15780.210989450481;15845.52463426099;16172.272247748879;16323.347066117221;621040;624895;627100;629115;632471;51766.74116629393;62500.687496563136;62679;62685.37314626796;62695.373046269866;1397.1128333508093;1553.1535313254528;1553.5184092931227;1566.9294881730577;1595.2103708664285;29180.27049323784;30620.77516899388;30864.845675772376;31022.42398543332;31138.22154446157;49959.75020124876;49965.75017124891;50471.74764126303;50512.74743626258;50615.746921265156;455612;455722;456959;458281;458437;24395.26814195577;27254.454910901273;27607;27948;27958.580621291105;42508.78745606252;43816;44399.33400998923;44477.555224447344;45049.87375315512;35872.820635896656;36437.08907277339;36889.63110368862;37440.6255937448;38926.80536597299;37239.069023274635;37246.255074898894;37960.430593540565;38049.42925856059;38334.808325959304;37973.05067373338;38593.614063859;39392;40122.39816402698;40194.799026004686;31245.84377078191;33494.66505335013;33550.83224583959;33589.328213436085;33693.49459758057;24722.011119555016;25640.17958024653;26724.866375668775;26952.865235673697;26981 06:18:05 INFO - PROCESS | 2874 | |2;jquery.html;406.0964354311659;406.74578388507183;407.1389012239115;411.3397996216073;416.9700838927847;15633.843661563382;21056.684149737746;21670.808105554188;21756.02097905596;21779.673304900418;21567.352979410603;21883.67174492384;23152.30543083706;23197.30408087756;23226;5785.132230165477;5901.291844978608;6099;6100.69496525172;6101.237345331833;5999.160117583542;6139.9869021611385;6153.569250152491;6153.938460615382;6155.138280640714;5934.88130237395;6181.474574661159;6189.6286222826775;6196.535259855506;6208;5954.851128721773;6053.999999999978;6129.601575897553;6142.3550527194675;6155.815325540241;6058.666773327465;6076.756929722806;6095.451409373133;6101;6106.114613381079;12185.45165467556;14186.858131418658;14209.928950355285;14247.073940193854;14391.568252952427;2257.559775843711;2400.8559486430695;2489.7012358516913;2571.97121151539;2894.7394734473787;8317.41778075535;10041.297109202358;10672.252942294042;11622.593209237637;14846.960712750111;1772.4328214971215;1811.0673003403258;1836.9632607347778;1856.0626883423784;1886.3303527247904;72533.63733181353;73791.63104184499;73948.63025684837;75998;76071.23928760752;10285.588576456857;11325.451773351095;11755.177137600456;11766.705832354088;11868.525258989544;14372;14812.333444995002;14819.259037048105;15290.311935962909;15715.607109822346;8179.018517777905;8571.871421928676;9248.861267081;9291;9323.25413966881;8926.642934282685;8974.685885993958;8989.46063236208;9173.128552787475;9305.53472326381;4809.422869255712;4932.926006109911;4936.950630493649;4939.802407903716;4968.90062198754;1778.0952564820316;1951.3365455745115;2030.4517780199265;2034.5727397246449;2045.498852781078;920.8342498350361;953.0897992417225;959.6593209410559;982.1062832822098;1044.8693913260843;17346.392876249272;19797.505062373555;19944.501387465138;20836.27073052436;20992.580148396948;993.5628323537765;1005.2410430125209;1014.1886490807325;1043.0039312456586;1096.5504143301368;9441;10993.505292261867;11455.484503197376;11457.656270311903;11485.483153258123;588394;593224;622451;632031;650156;124139;128153.3592332051;128741;132279.33860330636;134399;974.1768205866032;984.950752462374;985.5959056786683;986.329296078659;1025.0979138358346;18345.724814128065;18454.984975826457;18462.81537184611;18636.906815465834;18967.90516047411;53649.463505364445;54824.725876370365;55100.72449637726;56995;57094.71452642876;73885.63057184679;74475;77505;78021.60989195018;80409.59795200986;8331.33349332064;8353.20644538768;8431.325493960347;8497.192766687402;8709.608067636846;8484.40609157353;12187.878121218675;12679.746405072032;12919.741605167656;13020.47918083266;8888.555572221234;9359.438433694;10494.265401421828;11751.942325190774;11935.283882967049;11473.426328683365;11489.770204596029;11581.478833452684;11689.766204675689;11890.16768826174;11610.76778464443;11841;11930.463129159036;12064.276143431422;12236.75526489483;8170;8360.205780450848;8376.790580235544;8665.740027799176;8930.285577153942;10487.737806554896;11454.026407755435;11707;11763.588274410355;11830.822537662114 06:18:05 INFO - PROCESS | 2874 | |3;mootools.html;1459.8467160948107;1611.347404301258;1615.4991952494727;1867.729179269006;1979.2083166733314;8358.37312201585;9008.279337652988;9156.404833685805;9177.03641117683;9178.082191780819;8986.910130898688;9008.54957252138;9112.453252804837;9115.453072815635;9119.452832830035;2541.949161016774;2570.652961850145;2571.125817222144;2571.8842652080607;2572.922812315624;2471.9258422247362;2543.186180422266;2545.478176973725;2548.4011257354505;2553.310606136342;2527.633493143493;2562.269753120361;2574.6266791315247;2575.5492788761985;2577.226831950417;2514.735952724956;2550.4644024754825;2552.6681531400986;2555.4889022195543;2558.616207568861;2513.40934880303;2534.4677617700304;2541.6314634378095;2542.186500319898;2554.3231043773417;8943.731688049369;9149.085091490864;9203.217726493256;9210.953945230298;9250.953745231298;5672.149177623348;5748.310202775652;5763.740631671543;5794.826155215308;5828.679422631753;3576.7853928764357;3621.167131559756;3683.889483315505;3799.297130030953;3817.3319669058083;1038.2109596706482;1045.122097438148;1066.4987455895794;1073.0932362154044;1088.7060493666745;12480.313582752944;12571.874281257253;12680.112392132554;12681.429335679824;12716.618501444971;4797.771821326372;4813.638977076734;4847.80608775645;4852.80588776445;4874.634402419832;9820.919698833122;9832.164266037467;9851.753706157404;9856;9861.950690246504;5627.409122042127;5628.352739435018;5663.66018038919;5680.5455563554815;5695.088785794253;4626.282926146453;4778.259369797687;5101.158308879068;5201.349831271091;5208.166693329049;3634.890953271406;3920.3335432976464;3993.4409182714444;4091.7135800494275;4107.014316564003;1239.3679223596032;1239.7954337534206;1242.6644805902356;1259.7354555543438;1261.2621616354536;918.5177781664546;925.3707478914403;952.5427794658602;970.5680971967548;975.6390135649855;6014.909776353358;6113.663748493876;6214.471769899519;6238.157848690369;6287.339829317947;461.47622448520497;461.4831388844448;467.4437419470819;470.8163816111719;497.50746760707364;3917.490726205632;4030.1335212928775;4053.8175782089875;4055.4322394864744;4110.815013324348;11142.665720028412;11666.358350290815;11675.35785531804;11706.239094458833;11723.41382930867;10292.639757608447;10677.145828333714;11148.163887708455;11463.426828658701;11590.188686791844;8210.671573137128;8835.028146903964;8841;8967.596458159398;8989.730308090768;6009.939900600938;6033.698315084141;6055.727492262947;6103.542234332354;6148.200733904742;9869.851952220866;10004.649837255662;10180.643677471253;10374.066334029672;10394.636187733393;10349.223808214263;10469.738256543647;10538;10702;10704.30422022566;7148.392386647193;7335.266473352622;7339.889901651586;7867.331276841533;8019.478733882279;7739.264769846855;8028.558429286445;8360.749177524684;8381.58092095405;8689.913100869164;7316.524425912298;7365.373943214887;7403.296686814744;7416.740414085697;7506.43701722384;6549.7380104795275;7510.812229694083;7619.771406857803;7674.2325767425045;7687.846243075219;7250.637468126678;7280.162781280221;7303.452241081834;7340.522866013692;7418.66616002292;5060.3168572242275;5118.616103792156;5150.4592017837585;5198.532132108128;5226.686398816083;5081.415637201769;5098.875629991834;5143.8456846294675;5284.418713941386;5343.0916744154365 06:18:05 INFO - PROCESS | 2874 | |4;prototype.html;334.585114458072;336.549024307428;343.7095654172225;349.83208060131153;351.6097132183278;6670.566413183145;6707.932920670792;6715.899261511076;6720.580590987241;6743.4942379321565;5327.46725327468;6667.833304167399;6683.69923353449;6705.932940670604;6719.6640167991645;4806.086843499733;4909.091818013661;4918.950810491903;4971.825986090487;5004.674696144757;4923.82766603169;4994.525520075587;5006.424261209952;5014.598832093424;5022.573081288095;4951.133551628469;4956.083124621957;4959.876003099916;4968.503149685039;4970.353853998975;4749.857504274877;4897.828575999859;4907.2393778964315;4908.607311415079;4923.458419573844;3681;4170.082581831992;4270.487541495009;4280.101178752466;4286;6005.669688167149;6514.348565143495;6525.641089740062;6527.118838956728;6527.281998980108;4840.685355451885;5362.651427657229;5444.40111587725;5916.970415147896;5939.881202375971;6905.620190889499;7167.74912878052;7172.784816455514;7186.1735900371605;7187.425005999507;4837.250226214942;4839.782209800567;4844.5155484451625;4857.975710121462;4867.756612169377;7468.178500364956;7525.698972041112;7553.055868016498;7558.811029724246;7568.924310756932;4881.829135980294;4904.068227036852;4907.631927605444;4919.557239848431;4923.556879880756;4986.750662466862;4990.800367985313;4993;4993.7503124843615;5004.549590536869;4891.926621100686;5287.07476191665;5343.679379237258;5696.572757043238;5907.881842363128;7176;7197.568145911262;7199.604021778852;7207.603581802946;7243.0946131733535;1694.9067801271049;1737.4700716281654;1740.2516917725247;1743.808181100078;1745.1012728444862;1083.1659622090947;1105.364415461097;1112.0214211493833;1119.171812858479;1121.7027487715761;6555.770548030796;6722.29415911332;6724;6736.8989465158065;6740.696668649923;5939.940600594025;6500.829850626933;6964.686589103502;7115.466340024519;7395.741149059757;6895.896561551581;6941.236463988957;7037.190723066913;7050.365467107985;7077.256888026683;3933.350997085506;3988.541317748496;3991.980040099781;3995.9810248386475;4002.0195052212393;7504.962475187698;7741.225877412327;7742.651580678883;7830.725924592612;7846.764597061983;7630.122535908442;7688.577128257888;7743.341815945595;7756.224377562198;7767.2232776723;7819.726309579138;7837.020372453443;7850.960745196352;7851.882221766678;7858.214178582096;7471.514351567131;7484.850302994018;7485.88771168422;7494.063242094739;7527.849443011219;7055.2944705529035;7326.560406375635;7354.338109570164;7354.558726476428;7365.926340736738;6330.620162790247;7763.029621297338;7793.961030194812;7819.0617125945255;7827.295543401121;4910.459849416633;4969.925451118308;4970.353853998957;4980.900381992412;4992.8751781205765;7428.368588670023;7442.96278518604;7444.776656700307;7453.590052547162;7470.813229669302;5503.9174412383045;5861.35525092231;6528.824811533779;7201.603911784902;7209;7129.215786263403;7165.24764899678;7192.784216473514;7194.712211511481;7204.423646108404;7004.789856304319;7006.719731210898;7022.2275549688475;7025.051618031501;7025.789226323219;6940.583564986117;7162.713491460283;7176;7180.820479488055;7182.928170718435;6789.490788191004;6945.236024037251;7098.396636285767;7118.750843720445;7138.107736532934 06:18:05 INFO - PROCESS | 2874 | |5;yui.html;710.8080818179092;717.9030830837837;756.8183635927376;808.6361137488132;823.0534884882383;15745.685086298266;15931.44239951602;15988.920055399736;16030;16060.518184454455;13298.468061277561;14483.927580362084;14577.34401951912;16365.918170409132;16559.66880662389;769.1846642558877;793.1750978981852;960.6109525642127;988.8516722491612;990.9603615855357;973.265184785486;982.7051884434677;985.7584891701543;987.7975015121918;988.7972965542046;807.6527093349857;826.8842362069315;1035.8394448860402;1036.2435422141841;1042.854000439939;995.6465454763563;1021.9744506387362;1022.974425639365;1022.9897701022969;1024.7899180667946;760.8288135169598;761.4936067515096;763.091920614467;763.133843088099;763.3702195688523;15349.539513814603;15439.61400964985;15440.996335238173;15459.613509662237;15470.381184752596;13061.804072938914;13358.265295408748;13394.598162055154;13432.328383580782;13645.522406715718;10306.690799276033;10479;10528.631497897537;10807.783844323149;10855.837162442569;3607.332643460968;3626.075350785533;3638.745287829853;3675.117971686776;3771.396576547739;72299.55400892005;85333;85485.57257213673;87494;88575.55712221462;9961.50192490387;9991.850122248172;10017.198624110053;10141.492925353703;10715.303505272132;22901.427464313525;22952.4261893454;23462.7653723464;23462.882685586465;23489.765102348756;7676.232376762279;7720.343770779435;7816.937358438262;7852.175521570267;7953.323967462715;4003.499562554681;4086.203190377907;4186.204621121977;4280.6789490788315;4289.420928174656;3864;3912.56961734209;3914.9804250978564;3926.411038344214;3937.370020796659;651.3453978751419;693.5110746923407;721.1886627544013;723.0383589825519;753.997183745617;539.1804457224996;542.2327406719447;556.5074908705825;560.5515587530041;575.4331982996829;8122.350211983027;8423.536705481258;8425.873611895826;8597.054324024351;8619.870701939475;550.6365798572923;578.5834199376442;583.2184872271177;588.6026931821003;638.1767519899278;3973.8013099344917;4008.2584721825974;4084.016915219218;4086.7956602169775;4253.255680255943;85302.61671216162;89862.65206021914;90668.54665726628;92701;96001.5199923996;74386.62806685932;78785;79034;80148.59925700334;80351.59824200842;70681.58636827132;70699.64650176819;70931;71111;72379.27620723726;6917.619530925847;7787.844243115219;7968.92031079705;8094.716684915999;8232.8173374613;48804.75597622131;49537;49863;50447.24329134992;50906;65648.6717566409;69025;69515.95726064012;70944.29055709377;70957.6452117736;10144.087032167141;10205.285630005828;10210.642627508001;10701;10848.945755271488;11571.710707232387;11646.88353116458;11802.114841386758;12040.157188996685;12252.816207756712;11708.824367634323;11825.231359961575;11870.881291186977;11921.105917056082;12256.632301030982;11395.202335836411;11552.480138393961;11775.293482391084;11822.231554949245;11913.987311078656;10710.143188545053;11412.543498259976;11477.139214558774;11712.70718232051;12100.273983561014;9768;9787.46168960714;10190.082892539707;10244.846327304947;10485.633002844865;9742.415455072718;9921.15670168015;9977.20436758351;10007.427309569335;10051.346662466916 06:18:05 INFO - PROCESS | 2874 | __end_tp_report 06:18:05 INFO - PROCESS | 2874 | __start_cc_report 06:18:05 INFO - PROCESS | 2874 | _x_x_mozilla_cycle_collect,1126 06:18:05 INFO - PROCESS | 2874 | __end_cc_report 06:18:05 INFO - PROCESS | 2874 | __startTimestamp1467033485340__endTimestamp 06:18:05 INFO - PROCESS | 2874 | 06:18:05 INFO - PROCESS | 2874 | ------- Summary: start ------- 06:18:05 INFO - PROCESS | 2874 | Number of tests: 6 06:18:05 INFO - PROCESS | 2874 | 06:18:05 INFO - PROCESS | 2874 | [#0] dojo.html Cycles:165 Average:5864.34 Median:6141.88 stddev:631.48 (10.3%) stddev-sans-first:604.70 06:18:05 INFO - PROCESS | 2874 | Values: 3464.3 3554.8 3567.3 3579.0 3631.1 5922.6 5935.9 5948.3 5961.2 6027.3 5950.8 5971.1 5987.6 5991.4 6009.3 5213.6 5312.1 5350.0 5401.1 5432.3 5385.9 5423.0 5448.1 5449.3 5449.8 4435.6 5411.8 5431.8 5463.1 5490.7 5442.1 5466.3 5470.8 5482.5 5502.6 5206.5 5263.4 5363.5 5374.1 5394.2 5753.8 5782.5 5837.1 5874.3 5877.9 6204.5 6237.1 6259.5 6269.7 6277.1 6219.5 6237.2 6302.3 6307.9 6352.1 6043.6 6046.2 6063.2 6067.6 6069.3 6396.3 6406.2 6416.2 6422.5 6448.0 6104.5 6204.5 6273.3 6278.8 6291.4 6308.0 6338.5 6338.8 6352.7 6359.9 6203.4 6276.6 6277.0 6280.9 6288.9 6191.3 6236.0 6251.6 6256.6 6272.6 5035.4 5076.0 5077.0 5080.5 5120.8 4552.7 4554.4 4556.4 4574.3 4592.7 5048.7 5894.1 5995.2 6018.1 6030.2 6248.7 6255.8 6285.7 6293.3 6300.4 4929.8 5905.6 5907.7 5946.0 5956.9 5392.5 5437.1 5460.4 5493.9 5503.6 6389.5 6395.8 6446.0 6457.7 6463.8 6268.7 6283.3 6285.2 6286.9 6293.3 6245.5 6477.2 6484.2 6502.9 6515.0 5354.1 6213.3 6273.8 6295.1 6296.8 6222.5 6289.7 6292.2 6292.5 6308.9 6279.9 6296.8 6297.6 6313.6 6328.7 5102.4 6040.5 6178.3 6255.6 6271.7 6141.9 6163.0 6168.4 6185.9 6188.0 6276.5 6285.8 6287.2 6289.6 6310.5 5986.3 6133.8 6140.6 6202.8 6210.2 06:18:05 INFO - PROCESS | 2874 | 06:18:05 INFO - PROCESS | 2874 | [#1] ext.html Cycles:180 Average:63456.41 Median:19695.68 stddev:136769.12 (694.4%) stddev-sans-first:137071.23 06:18:05 INFO - PROCESS | 2874 | Values: 544.1 545.5 565.7 588.0 598.4 30035.0 33168.3 38551.0 39470.0 39525.0 39378.0 39862.0 39887.6 39889.2 39892.8 9561.9 9779.7 9783.6 9789.6 9802.3 9080.5 11766.9 12040.9 12043.6 12048.3 11628.5 11696.2 11705.6 11720.6 11734.5 11699.8 11826.9 11830.3 11847.3 11848.4 11515.7 11627.5 11635.2 11644.1 11644.5 41089.0 41688.0 41707.0 41739.4 41837.6 3099.8 3181.7 3483.4 3775.2 3801.4 28148.3 29253.0 29372.3 29978.4 30389.2 2202.5 2814.6 2824.3 2859.5 2971.5 424835.0 430763.0 431813.0 431905.0 432202.0 37590.6 38014.6 38140.4 64139.4 64632.4 36181.6 36538.0 36571.0 36613.6 36617.9 15918.7 16079.9 16089.8 16122.5 16132.4 11523.5 12847.0 12945.2 13604.0 13674.2 8431.9 8454.0 8454.2 8530.2 8538.7 3435.0 3467.7 3469.9 3473.6 3518.5 889.0 983.5 1024.9 1116.8 1125.2 25531.6 27439.7 30032.9 30283.8 30606.4 996.8 1101.9 1131.8 1160.5 1210.0 15450.3 15780.2 15845.5 16172.3 16323.3 621040.0 624895.0 627100.0 629115.0 632471.0 51766.7 62500.7 62679.0 62685.4 62695.4 1397.1 1553.2 1553.5 1566.9 1595.2 29180.3 30620.8 30864.8 31022.4 31138.2 49959.8 49965.8 50471.7 50512.7 50615.7 455612.0 455722.0 456959.0 458281.0 458437.0 24395.3 27254.5 27607.0 27948.0 27958.6 42508.8 43816.0 44399.3 44477.6 45049.9 35872.8 36437.1 36889.6 37440.6 38926.8 37239.1 37246.3 37960.4 38049.4 38334.8 37973.1 38593.6 39392.0 40122.4 40194.8 31245.8 33494.7 33550.8 33589.3 33693.5 24722.0 25640.2 26724.9 26952.9 26981.0 06:18:05 INFO - PROCESS | 2874 | 06:18:05 INFO - PROCESS | 2874 | [#2] jquery.html Cycles:180 Average:34297.37 Median:1650.42 stddev:102238.01 (6194.7%) stddev-sans-first:102493.15 06:18:05 INFO - PROCESS | 2874 | Values: 406.1 406.7 407.1 411.3 417.0 15633.8 21056.7 21670.8 21756.0 21779.7 21567.4 21883.7 23152.3 23197.3 23226.0 5785.1 5901.3 6099.0 6100.7 6101.2 5999.2 6140.0 6153.6 6153.9 6155.1 5934.9 6181.5 6189.6 6196.5 6208.0 5954.9 6054.0 6129.6 6142.4 6155.8 6058.7 6076.8 6095.5 6101.0 6106.1 12185.5 14186.9 14209.9 14247.1 14391.6 2257.6 2400.9 2489.7 2572.0 2894.7 8317.4 10041.3 10672.3 11622.6 14847.0 1772.4 1811.1 1837.0 1856.1 1886.3 72533.6 73791.6 73948.6 75998.0 76071.2 10285.6 11325.5 11755.2 11766.7 11868.5 14372.0 14812.3 14819.3 15290.3 15715.6 8179.0 8571.9 9248.9 9291.0 9323.3 8926.6 8974.7 8989.5 9173.1 9305.5 4809.4 4932.9 4937.0 4939.8 4968.9 1778.1 1951.3 2030.5 2034.6 2045.5 920.8 953.1 959.7 982.1 1044.9 17346.4 19797.5 19944.5 20836.3 20992.6 993.6 1005.2 1014.2 1043.0 1096.6 9441.0 10993.5 11455.5 11457.7 11485.5 588394.0 593224.0 622451.0 632031.0 650156.0 124139.0 128153.4 128741.0 132279.3 134399.0 974.2 985.0 985.6 986.3 1025.1 18345.7 18455.0 18462.8 18636.9 18967.9 53649.5 54824.7 55100.7 56995.0 57094.7 73885.6 74475.0 77505.0 78021.6 80409.6 8331.3 8353.2 8431.3 8497.2 8709.6 8484.4 12187.9 12679.7 12919.7 13020.5 8888.6 9359.4 10494.3 11751.9 11935.3 11473.4 11489.8 11581.5 11689.8 11890.2 11610.8 11841.0 11930.5 12064.3 12236.8 8170.0 8360.2 8376.8 8665.7 8930.3 10487.7 11454.0 11707.0 11763.6 11830.8 06:18:05 INFO - PROCESS | 2874 | 06:18:05 INFO - PROCESS | 2874 | [#3] mootools.html Cycles:180 Average:5927.02 Median:2778.91 stddev:3348.95 (120.5%) stddev-sans-first:3341.52 06:18:05 INFO - PROCESS | 2874 | Values: 1459.8 1611.3 1615.5 1867.7 1979.2 8358.4 9008.3 9156.4 9177.0 9178.1 8986.9 9008.5 9112.5 9115.5 9119.5 2541.9 2570.7 2571.1 2571.9 2572.9 2471.9 2543.2 2545.5 2548.4 2553.3 2527.6 2562.3 2574.6 2575.5 2577.2 2514.7 2550.5 2552.7 2555.5 2558.6 2513.4 2534.5 2541.6 2542.2 2554.3 8943.7 9149.1 9203.2 9211.0 9251.0 5672.1 5748.3 5763.7 5794.8 5828.7 3576.8 3621.2 3683.9 3799.3 3817.3 1038.2 1045.1 1066.5 1073.1 1088.7 12480.3 12571.9 12680.1 12681.4 12716.6 4797.8 4813.6 4847.8 4852.8 4874.6 9820.9 9832.2 9851.8 9856.0 9862.0 5627.4 5628.4 5663.7 5680.5 5695.1 4626.3 4778.3 5101.2 5201.3 5208.2 3634.9 3920.3 3993.4 4091.7 4107.0 1239.4 1239.8 1242.7 1259.7 1261.3 918.5 925.4 952.5 970.6 975.6 6014.9 6113.7 6214.5 6238.2 6287.3 461.5 461.5 467.4 470.8 497.5 3917.5 4030.1 4053.8 4055.4 4110.8 11142.7 11666.4 11675.4 11706.2 11723.4 10292.6 10677.1 11148.2 11463.4 11590.2 8210.7 8835.0 8841.0 8967.6 8989.7 6009.9 6033.7 6055.7 6103.5 6148.2 9869.9 10004.6 10180.6 10374.1 10394.6 10349.2 10469.7 10538.0 10702.0 10704.3 7148.4 7335.3 7339.9 7867.3 8019.5 7739.3 8028.6 8360.7 8381.6 8689.9 7316.5 7365.4 7403.3 7416.7 7506.4 6549.7 7510.8 7619.8 7674.2 7687.8 7250.6 7280.2 7303.5 7340.5 7418.7 5060.3 5118.6 5150.5 5198.5 5226.7 5081.4 5098.9 5143.8 5284.4 5343.1 06:18:05 INFO - PROCESS | 2874 | 06:18:05 INFO - PROCESS | 2874 | [#4] prototype.html Cycles:180 Average:5873.04 Median:6694.82 stddev:1855.47 (27.7%) stddev-sans-first:1813.51 06:18:05 INFO - PROCESS | 2874 | Values: 334.6 336.5 343.7 349.8 351.6 6670.6 6707.9 6715.9 6720.6 6743.5 5327.5 6667.8 6683.7 6705.9 6719.7 4806.1 4909.1 4919.0 4971.8 5004.7 4923.8 4994.5 5006.4 5014.6 5022.6 4951.1 4956.1 4959.9 4968.5 4970.4 4749.9 4897.8 4907.2 4908.6 4923.5 3681.0 4170.1 4270.5 4280.1 4286.0 6005.7 6514.3 6525.6 6527.1 6527.3 4840.7 5362.7 5444.4 5917.0 5939.9 6905.6 7167.7 7172.8 7186.2 7187.4 4837.3 4839.8 4844.5 4858.0 4867.8 7468.2 7525.7 7553.1 7558.8 7568.9 4881.8 4904.1 4907.6 4919.6 4923.6 4986.8 4990.8 4993.0 4993.8 5004.5 4891.9 5287.1 5343.7 5696.6 5907.9 7176.0 7197.6 7199.6 7207.6 7243.1 1694.9 1737.5 1740.3 1743.8 1745.1 1083.2 1105.4 1112.0 1119.2 1121.7 6555.8 6722.3 6724.0 6736.9 6740.7 5939.9 6500.8 6964.7 7115.5 7395.7 6895.9 6941.2 7037.2 7050.4 7077.3 3933.4 3988.5 3992.0 3996.0 4002.0 7505.0 7741.2 7742.7 7830.7 7846.8 7630.1 7688.6 7743.3 7756.2 7767.2 7819.7 7837.0 7851.0 7851.9 7858.2 7471.5 7484.9 7485.9 7494.1 7527.8 7055.3 7326.6 7354.3 7354.6 7365.9 6330.6 7763.0 7794.0 7819.1 7827.3 4910.5 4969.9 4970.4 4980.9 4992.9 7428.4 7443.0 7444.8 7453.6 7470.8 5503.9 5861.4 6528.8 7201.6 7209.0 7129.2 7165.2 7192.8 7194.7 7204.4 7004.8 7006.7 7022.2 7025.1 7025.8 6940.6 7162.7 7176.0 7180.8 7182.9 6789.5 6945.2 7098.4 7118.8 7138.1 06:18:05 INFO - PROCESS | 2874 | 06:18:05 INFO - PROCESS | 2874 | [#5] yui.html Cycles:180 Average:18664.36 Median:49170.88 stddev:25947.37 (52.8%) stddev-sans-first:25985.14 06:18:05 INFO - PROCESS | 2874 | Values: 710.8 717.9 756.8 808.6 823.1 15745.7 15931.4 15988.9 16030.0 16060.5 13298.5 14483.9 14577.3 16365.9 16559.7 769.2 793.2 960.6 988.9 991.0 973.3 982.7 985.8 987.8 988.8 807.7 826.9 1035.8 1036.2 1042.9 995.6 1022.0 1023.0 1023.0 1024.8 760.8 761.5 763.1 763.1 763.4 15349.5 15439.6 15441.0 15459.6 15470.4 13061.8 13358.3 13394.6 13432.3 13645.5 10306.7 10479.0 10528.6 10807.8 10855.8 3607.3 3626.1 3638.7 3675.1 3771.4 72299.6 85333.0 85485.6 87494.0 88575.6 9961.5 9991.9 10017.2 10141.5 10715.3 22901.4 22952.4 23462.8 23462.9 23489.8 7676.2 7720.3 7816.9 7852.2 7953.3 4003.5 4086.2 4186.2 4280.7 4289.4 3864.0 3912.6 3915.0 3926.4 3937.4 651.3 693.5 721.2 723.0 754.0 539.2 542.2 556.5 560.6 575.4 8122.4 8423.5 8425.9 8597.1 8619.9 550.6 578.6 583.2 588.6 638.2 3973.8 4008.3 4084.0 4086.8 4253.3 85302.6 89862.7 90668.5 92701.0 96001.5 74386.6 78785.0 79034.0 80148.6 80351.6 70681.6 70699.6 70931.0 71111.0 72379.3 6917.6 7787.8 7968.9 8094.7 8232.8 48804.8 49537.0 49863.0 50447.2 50906.0 65648.7 69025.0 69516.0 70944.3 70957.6 10144.1 10205.3 10210.6 10701.0 10848.9 11571.7 11646.9 11802.1 12040.2 12252.8 11708.8 11825.2 11870.9 11921.1 12256.6 11395.2 11552.5 11775.3 11822.2 11914.0 10710.1 11412.5 11477.1 11712.7 12100.3 9768.0 9787.5 10190.1 10244.8 10485.6 9742.4 9921.2 9977.2 10007.4 10051.3 06:18:05 INFO - PROCESS | 2874 | -------- Summary: end -------- 06:18:05 INFO - PROCESS | 2874 | 06:18:05 INFO - TEST-INFO | 2874: exit 0 06:18:05 INFO - TEST-OK | dromaeo_css | took 1113530ms 06:18:05 INFO - TEST-START | kraken 06:18:05 INFO - operating with platform_type : mac_ 06:18:05 INFO - Initialising browser for kraken test... 06:18:05 INFO - TEST-INFO | started process 2877 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/tmpco9ZB4/profile http://localhost:52185/getInfo.html) 06:18:08 INFO - PROCESS | 2877 | __metrics Screen width/height:1600/1200 06:18:08 INFO - PROCESS | 2877 | colorDepth:24 06:18:08 INFO - PROCESS | 2877 | Browser inner width/height: 1024/689 06:18:08 INFO - PROCESS | 2877 | __metrics 06:18:08 INFO - PROCESS | 2877 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:18:08 ERROR - PROCESS | 2877 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:18:08 INFO - TEST-INFO | 2877: exit 0 06:18:08 INFO - Browser initialized. 06:18:08 INFO - Running cycle 1/1 for kraken test... 06:18:08 INFO - TEST-INFO | started process 2880 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/tmpco9ZB4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:18:20 INFO - PROCESS | 2880 | RSS: Main: 161185792 06:18:20 INFO - PROCESS | 2880 | 06:18:23 INFO - PROCESS | 2880 | Cycle 1(1): loaded http://localhost:52185/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52185/tests/kraken/driver.html?testName=audio-beat-detection) 06:18:24 INFO - PROCESS | 2880 | RSS: Main: 224178176 06:18:24 INFO - PROCESS | 2880 | 06:18:26 INFO - PROCESS | 2880 | Cycle 1(1): loaded http://localhost:52185/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52185/tests/kraken/driver.html?testName=audio-dft) 06:18:27 INFO - PROCESS | 2880 | RSS: Main: 240738304 06:18:27 INFO - PROCESS | 2880 | 06:18:30 INFO - PROCESS | 2880 | Cycle 1(1): loaded http://localhost:52185/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52185/tests/kraken/driver.html?testName=audio-fft) 06:18:31 INFO - PROCESS | 2880 | RSS: Main: 324771840 06:18:31 INFO - PROCESS | 2880 | 06:18:33 INFO - PROCESS | 2880 | Cycle 1(1): loaded http://localhost:52185/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52185/tests/kraken/driver.html?testName=audio-oscillator) 06:18:34 INFO - PROCESS | 2880 | RSS: Main: 230289408 06:18:34 INFO - PROCESS | 2880 | 06:18:36 INFO - PROCESS | 2880 | Cycle 1(1): loaded http://localhost:52185/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52185/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:18:36 INFO - PROCESS | 2880 | RSS: Main: 232153088 06:18:36 INFO - PROCESS | 2880 | 06:18:39 INFO - PROCESS | 2880 | Cycle 1(1): loaded http://localhost:52185/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52185/tests/kraken/driver.html?testName=imaging-darkroom) 06:18:40 INFO - PROCESS | 2880 | RSS: Main: 270487552 06:18:40 INFO - PROCESS | 2880 | 06:18:43 INFO - PROCESS | 2880 | Cycle 1(1): loaded http://localhost:52185/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52185/tests/kraken/driver.html?testName=imaging-desaturate) 06:18:43 INFO - PROCESS | 2880 | RSS: Main: 271081472 06:18:43 INFO - PROCESS | 2880 | 06:18:46 INFO - PROCESS | 2880 | Cycle 1(1): loaded http://localhost:52185/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52185/tests/kraken/driver.html?testName=json-parse-financial) 06:18:47 INFO - PROCESS | 2880 | RSS: Main: 268533760 06:18:47 INFO - PROCESS | 2880 | 06:18:48 INFO - PROCESS | 2880 | Cycle 1(1): loaded http://localhost:52185/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52185/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:18:49 INFO - PROCESS | 2880 | RSS: Main: 260427776 06:18:49 INFO - PROCESS | 2880 | 06:18:51 INFO - PROCESS | 2880 | Cycle 1(1): loaded http://localhost:52185/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52185/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:18:51 INFO - PROCESS | 2880 | RSS: Main: 267735040 06:18:51 INFO - PROCESS | 2880 | 06:18:54 INFO - PROCESS | 2880 | Cycle 1(1): loaded http://localhost:52185/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52185/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:18:54 INFO - PROCESS | 2880 | RSS: Main: 270684160 06:18:54 INFO - PROCESS | 2880 | 06:18:57 INFO - PROCESS | 2880 | Cycle 1(1): loaded http://localhost:52185/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52185/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:18:58 INFO - PROCESS | 2880 | RSS: Main: 278351872 06:18:58 INFO - PROCESS | 2880 | 06:19:01 INFO - PROCESS | 2880 | Cycle 1(1): loaded http://localhost:52185/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52185/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:19:01 INFO - PROCESS | 2880 | RSS: Main: 274554880 06:19:01 INFO - PROCESS | 2880 | 06:19:03 INFO - PROCESS | 2880 | Cycle 1(1): loaded http://localhost:52185/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52185/tests/kraken/driver.html?testName=ai-astar) 06:19:03 INFO - PROCESS | 2880 | RSS: Main: 335654912 06:19:03 INFO - PROCESS | 2880 | 06:19:03 INFO - PROCESS | 2880 | __start_tp_report 06:19:03 INFO - PROCESS | 2880 | _x_x_mozilla_page_load 06:19:03 INFO - PROCESS | 2880 | _x_x_mozilla_page_load_details 06:19:03 INFO - PROCESS | 2880 | |i|pagename|runs| 06:19:03 INFO - PROCESS | 2880 | |0;ai-astar;113;114;122;112;112;112;113;113;112;133 06:19:03 INFO - PROCESS | 2880 | |1;audio-beat-detection;189;147;145;167;112;142;117;157;192;145 06:19:03 INFO - PROCESS | 2880 | |2;audio-dft;188;187;190;186;187;188;185;188;190;187 06:19:03 INFO - PROCESS | 2880 | |3;audio-fft;71;79;77;170;91;81;80;62;134;54 06:19:03 INFO - PROCESS | 2880 | |4;audio-oscillator;94;93;149;78;78;79;125;102;113;168 06:19:03 INFO - PROCESS | 2880 | |5;imaging-gaussian-blur;89;86;88;85;88;84;88;85;87;84 06:19:03 INFO - PROCESS | 2880 | |6;imaging-darkroom;93;94;94;94;94;106;124;135;148;92 06:19:03 INFO - PROCESS | 2880 | |7;imaging-desaturate;84;85;87;84;87;84;86;85;84;89 06:19:03 INFO - PROCESS | 2880 | |8;json-parse-financial;59;63;62;62;65;62;63;78;57;56 06:19:03 INFO - PROCESS | 2880 | |9;json-stringify-tinderbox;61;64;64;68;70;77;69;66;66;66 06:19:03 INFO - PROCESS | 2880 | |10;stanford-crypto-aes;78;104;103;104;68;76;101;64;96;99 06:19:03 INFO - PROCESS | 2880 | |11;stanford-crypto-ccm;128;126;128;129;145;141;126;137;162;170 06:19:03 INFO - PROCESS | 2880 | |12;stanford-crypto-pbkdf2;169;168;159;160;159;214;212;161;171;164 06:19:03 INFO - PROCESS | 2880 | |13;stanford-crypto-sha256-iterative;66;68;68;67;66;76;67;65;66;66 06:19:03 INFO - PROCESS | 2880 | __end_tp_report 06:19:03 INFO - PROCESS | 2880 | __start_cc_report 06:19:03 INFO - PROCESS | 2880 | _x_x_mozilla_cycle_collect,1981 06:19:03 INFO - PROCESS | 2880 | __end_cc_report 06:19:03 INFO - PROCESS | 2880 | __startTimestamp1467033543749__endTimestamp 06:19:03 INFO - PROCESS | 2880 | 06:19:03 INFO - PROCESS | 2880 | ------- Summary: start ------- 06:19:03 INFO - PROCESS | 2880 | Number of tests: 14 06:19:03 INFO - PROCESS | 2880 | 06:19:03 INFO - PROCESS | 2880 | [#0] ai-astar Cycles:10 Average:115.60 Median:113.00 stddev:6.82 (6.0%) stddev-sans-first:7.17 06:19:03 INFO - PROCESS | 2880 | Values: 113.0 114.0 122.0 112.0 112.0 112.0 113.0 113.0 112.0 133.0 06:19:03 INFO - PROCESS | 2880 | 06:19:03 INFO - PROCESS | 2880 | [#1] audio-beat-detection Cycles:10 Average:151.30 Median:152.00 stddev:26.38 (17.4%) stddev-sans-first:24.19 06:19:03 INFO - PROCESS | 2880 | Values: 189.0 147.0 145.0 167.0 112.0 142.0 117.0 157.0 192.0 145.0 06:19:03 INFO - PROCESS | 2880 | 06:19:03 INFO - PROCESS | 2880 | [#2] audio-dft Cycles:10 Average:187.60 Median:188.00 stddev:1.58 (0.8%) stddev-sans-first:1.67 06:19:03 INFO - PROCESS | 2880 | Values: 188.0 187.0 190.0 186.0 187.0 188.0 185.0 188.0 190.0 187.0 06:19:03 INFO - PROCESS | 2880 | 06:19:03 INFO - PROCESS | 2880 | [#3] audio-fft Cycles:10 Average:89.90 Median:78.00 stddev:35.35 (45.3%) stddev-sans-first:36.83 06:19:03 INFO - PROCESS | 2880 | Values: 71.0 79.0 77.0 170.0 91.0 81.0 80.0 62.0 134.0 54.0 06:19:03 INFO - PROCESS | 2880 | 06:19:03 INFO - PROCESS | 2880 | [#4] audio-oscillator Cycles:10 Average:107.90 Median:78.00 stddev:31.08 (39.8%) stddev-sans-first:32.55 06:19:03 INFO - PROCESS | 2880 | Values: 94.0 93.0 149.0 78.0 78.0 79.0 125.0 102.0 113.0 168.0 06:19:03 INFO - PROCESS | 2880 | 06:19:03 INFO - PROCESS | 2880 | [#5] imaging-gaussian-blur Cycles:10 Average:86.40 Median:87.50 stddev:1.84 (2.1%) stddev-sans-first:1.69 06:19:03 INFO - PROCESS | 2880 | Values: 89.0 86.0 88.0 85.0 88.0 84.0 88.0 85.0 87.0 84.0 06:19:03 INFO - PROCESS | 2880 | 06:19:03 INFO - PROCESS | 2880 | [#6] imaging-darkroom Cycles:10 Average:107.40 Median:93.50 stddev:20.68 (22.1%) stddev-sans-first:21.27 06:19:03 INFO - PROCESS | 2880 | Values: 93.0 94.0 94.0 94.0 94.0 106.0 124.0 135.0 148.0 92.0 06:19:03 INFO - PROCESS | 2880 | 06:19:03 INFO - PROCESS | 2880 | [#7] imaging-desaturate Cycles:10 Average:85.50 Median:85.50 stddev:1.72 (2.0%) stddev-sans-first:1.73 06:19:03 INFO - PROCESS | 2880 | Values: 84.0 85.0 87.0 84.0 87.0 84.0 86.0 85.0 84.0 89.0 06:19:03 INFO - PROCESS | 2880 | 06:19:03 INFO - PROCESS | 2880 | [#8] json-parse-financial Cycles:10 Average:62.70 Median:62.50 stddev:6.07 (9.7%) stddev-sans-first:6.29 06:19:03 INFO - PROCESS | 2880 | Values: 59.0 63.0 62.0 62.0 65.0 62.0 63.0 78.0 57.0 56.0 06:19:03 INFO - PROCESS | 2880 | 06:19:03 INFO - PROCESS | 2880 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:67.00 stddev:4.36 (6.5%) stddev-sans-first:4.02 06:19:03 INFO - PROCESS | 2880 | Values: 61.0 64.0 64.0 68.0 70.0 77.0 69.0 66.0 66.0 66.0 06:19:03 INFO - PROCESS | 2880 | 06:19:03 INFO - PROCESS | 2880 | [#10] stanford-crypto-aes Cycles:10 Average:89.30 Median:72.00 stddev:15.97 (22.2%) stddev-sans-first:16.40 06:19:03 INFO - PROCESS | 2880 | Values: 78.0 104.0 103.0 104.0 68.0 76.0 101.0 64.0 96.0 99.0 06:19:03 INFO - PROCESS | 2880 | 06:19:03 INFO - PROCESS | 2880 | [#11] stanford-crypto-ccm Cycles:10 Average:139.20 Median:139.00 stddev:15.68 (11.3%) stddev-sans-first:16.10 06:19:03 INFO - PROCESS | 2880 | Values: 128.0 126.0 128.0 129.0 145.0 141.0 126.0 137.0 162.0 170.0 06:19:03 INFO - PROCESS | 2880 | 06:19:03 INFO - PROCESS | 2880 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.70 Median:168.50 stddev:21.16 (12.6%) stddev-sans-first:22.37 06:19:03 INFO - PROCESS | 2880 | Values: 169.0 168.0 159.0 160.0 159.0 214.0 212.0 161.0 171.0 164.0 06:19:03 INFO - PROCESS | 2880 | 06:19:03 INFO - PROCESS | 2880 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.00 stddev:3.14 (4.7%) stddev-sans-first:3.28 06:19:03 INFO - PROCESS | 2880 | Values: 66.0 68.0 68.0 67.0 66.0 76.0 67.0 65.0 66.0 66.0 06:19:03 INFO - PROCESS | 2880 | -------- Summary: end -------- 06:19:03 INFO - PROCESS | 2880 | 06:19:04 INFO - TEST-INFO | 2880: exit 0 06:19:04 INFO - TEST-OK | kraken | took 58570ms 06:19:04 INFO - SUITE-END | took 1172s 06:19:04 INFO - Completed test suite (00:19:32) 06:19:04 INFO - javascript benchmark 06:19:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3464.2551851351964, 3554.786712797234, 3567.250877315763, 3578.999999999998, 3631.0559254593813, 5922.555808314372, 5935.910961335583, 5948.340733874543, 5961.165436838841, 6027.276726792786, 5950.821475355736, 5971.1043343498495, 5987.610805297652, 5991.370906054867, 6009.338972713009, 5213.635045546814, 5312.123499622558, 5350.0, 5401.135818269077, 5432.348118225818, 5385.919211211835, 5423.0, 5448.073827449323, 5449.3188351456065, 5449.754761035743, 4435.62297204738, 5411.83764487064, 5431.809886653968, 5463.071277882749, 5490.725463726818, 5442.074847275952, 5466.289382380305, 5470.753816078286, 5482.506574408282, 5502.58730595203, 5206.453322401169, 5263.421023687391, 5363.490468405495, 5374.059539580597, 5394.163904594794, 5753.827385178452, 5782.479576838105, 5837.066069428871, 5874.265716785402, 5877.882442351129, 6204.534236125292, 6237.095621134956, 6259.530535209832, 6269.7178626961895, 6277.089821975834, 6219.502439804804, 6237.220347456568, 6302.338254483259, 6307.8738425231695, 6352.078948552434, 6043.576949613529, 6046.153538504657, 6063.242094738158, 6067.605605635664, 6069.332373439007, 6396.264429590564, 6406.231252249667, 6416.165898433173, 6422.45409140219, 6448.0, 6104.519788040277, 6204.534659900525, 6273.309935907047, 6278.780242691575, 6291.370862913764, 6308.0, 6338.524610654219, 6338.809835704937, 6352.65060421672, 6359.872802543923, 6203.410675985774, 6276.623402595859, 6277.0, 6280.874382512324, 6288.868003759276, 6191.25704915413, 6236.0, 6251.593646412968, 6256.624602523863, 6272.5922815016875, 5035.420926593415, 5075.97462012695, 5076.974615126901, 5080.491950804964, 5120.769565369567, 4552.7495987720995, 4554.3851580036935, 4556.407667003335, 4574.336721175411, 4592.747398893093, 5048.72232027242, 5894.115882617556, 5995.160677505153, 6018.067199584071, 6030.18592490017, 6248.687565621701, 6255.78104766331, 6285.654289014148, 6293.2762732285455, 6300.401461861115, 4929.7781599828095, 5905.645661260252, 5907.675077870673, 5945.970270148708, 5956.940430595639, 5392.5416339611575, 5437.13005919051, 5460.399356070829, 5493.890122197614, 5503.614746967673, 6389.456896163878, 6395.776147834804, 6446.0, 6457.6771161442675, 6463.838404039937, 6268.686565671607, 6283.308836027942, 6285.151504546828, 6286.905696414466, 6293.3391993841815, 6245.469135123383, 6477.1579694639395, 6484.221893372825, 6502.869942601216, 6515.02274658786, 5354.143337066206, 6213.285472170758, 6273.780417685359, 6295.118683384421, 6296.842578935563, 6222.533310001678, 6289.716962736779, 6292.182016337847, 6292.4966002720585, 6308.873822523616, 6279.937200628118, 6296.842578935563, 6297.622142671455, 6313.621182729051, 6328.7152078157515, 5102.387713474407, 6040.486558642565, 6178.289496707756, 6255.562110652393, 6271.686415679289, 6141.884937092248, 6162.983107787165, 6168.383161683796, 6185.948388774009, 6188.040853667689, 6276.529260305404, 6285.779997700059, 6287.182666253358, 6289.559730818799, 6310.463610592968, 5986.281646202484, 6133.754649813957, 6140.62695141751, 6202.782902598387, 6210.223722034746], "value": 5826.932073253229, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.053347175914, 545.4845171313108, 565.7425871228592, 587.9651812809456, 598.3836648252302, 30035.0, 33168.33663326735, 38551.03622409441, 39470.01324966877, 39525.0, 39378.01554961127, 39862.0, 39887.60112398875, 39889.202215955665, 39892.800535997354, 9561.856572151406, 9779.70660880171, 9783.608655653801, 9789.55946982384, 9802.264830137732, 9080.501717216652, 11766.941165294162, 12040.879591204064, 12043.578474753385, 12048.337341446217, 11628.476718547643, 11696.181267311249, 11705.59030433935, 11720.648380548597, 11734.53061877524, 11699.766004679901, 11826.94086529566, 11830.290182589073, 11847.289162650268, 11848.40757962107, 11515.712107197303, 11627.476763545661, 11635.185537012412, 11644.126690498246, 11644.475998580085, 41089.0, 41687.957801054916, 41707.0, 41739.37390939138, 41837.58162418367, 3099.7600959616107, 3181.7454603631654, 3483.4252348362743, 3775.244951009809, 3801.4107813288983, 28148.296292592644, 29253.0, 29372.292533763644, 29978.400431991457, 30389.24026899323, 2202.4714068623575, 2814.6481689788775, 2824.2515733330683, 2859.4567032263803, 2971.52455607104, 424835.0, 430763.0, 431813.0, 431904.99999999686, 432202.0, 37590.62409375926, 38014.61985380166, 38140.42789358162, 64139.35860641427, 64632.35367646357, 36181.63818361835, 36538.0, 36571.0, 36613.633863661555, 36617.90146295616, 15918.681626367408, 16079.919600402158, 16089.839101608834, 16122.516324510283, 16132.354705811871, 11523.539058437736, 12847.0, 12945.223286602833, 13604.04771665974, 13674.17954922688, 8431.873521897054, 8453.957730211432, 8454.196851299239, 8530.232279094911, 8538.70114545988, 3434.9828250858586, 3467.6879080882336, 3469.9479507807405, 3473.565804274466, 3518.5425894633536, 888.9688860889838, 983.5131609853025, 1024.9180065594735, 1116.7543140509074, 1125.1729978465821, 25531.61702574463, 27439.725602744118, 30032.94884679026, 30283.848580757396, 30606.38787224243, 996.8006398720285, 1101.895319944604, 1131.8415421840948, 1160.4893846707591, 1209.9939500302619, 15450.304736286895, 15780.210989450481, 15845.52463426099, 16172.272247748879, 16323.347066117221, 621040.0, 624895.0, 627100.0, 629115.0, 632471.0, 51766.74116629393, 62500.687496563136, 62679.0, 62685.37314626796, 62695.373046269866, 1397.1128333508093, 1553.1535313254528, 1553.5184092931227, 1566.9294881730577, 1595.2103708664285, 29180.27049323784, 30620.77516899388, 30864.845675772376, 31022.42398543332, 31138.22154446157, 49959.75020124876, 49965.75017124891, 50471.74764126303, 50512.74743626258, 50615.746921265156, 455612.0, 455722.0, 456959.0, 458281.0, 458437.0, 24395.26814195577, 27254.454910901273, 27607.0, 27948.0, 27958.580621291105, 42508.78745606252, 43816.0, 44399.33400998923, 44477.555224447344, 45049.87375315512, 35872.820635896656, 36437.08907277339, 36889.63110368862, 37440.6255937448, 38926.80536597299, 37239.069023274635, 37246.255074898894, 37960.430593540565, 38049.42925856059, 38334.808325959304, 37973.05067373338, 38593.614063859, 39392.0, 40122.39816402698, 40194.799026004686, 31245.84377078191, 33494.66505335013, 33550.83224583959, 33589.328213436085, 33693.49459758057, 24722.011119555016, 25640.17958024653, 26724.866375668775, 26952.865235673697, 26981.0], "value": 18940.78966786787, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.0964354311659, 406.74578388507183, 407.1389012239115, 411.3397996216073, 416.9700838927847, 15633.843661563382, 21056.684149737746, 21670.808105554188, 21756.02097905596, 21779.673304900418, 21567.352979410603, 21883.67174492384, 23152.30543083706, 23197.30408087756, 23226.0, 5785.132230165477, 5901.291844978608, 6099.0, 6100.69496525172, 6101.237345331833, 5999.160117583542, 6139.9869021611385, 6153.569250152491, 6153.938460615382, 6155.138280640714, 5934.88130237395, 6181.474574661159, 6189.6286222826775, 6196.535259855506, 6208.0, 5954.851128721773, 6053.999999999978, 6129.601575897553, 6142.3550527194675, 6155.815325540241, 6058.666773327465, 6076.756929722806, 6095.451409373133, 6101.0, 6106.114613381079, 12185.45165467556, 14186.858131418658, 14209.928950355285, 14247.073940193854, 14391.568252952427, 2257.559775843711, 2400.8559486430695, 2489.7012358516913, 2571.97121151539, 2894.7394734473787, 8317.41778075535, 10041.297109202358, 10672.252942294042, 11622.593209237637, 14846.960712750111, 1772.4328214971215, 1811.0673003403258, 1836.9632607347778, 1856.0626883423784, 1886.3303527247904, 72533.63733181353, 73791.63104184499, 73948.63025684837, 75998.0, 76071.23928760752, 10285.588576456857, 11325.451773351095, 11755.177137600456, 11766.705832354088, 11868.525258989544, 14372.0, 14812.333444995002, 14819.259037048105, 15290.311935962909, 15715.607109822346, 8179.018517777905, 8571.871421928676, 9248.861267081, 9291.0, 9323.25413966881, 8926.642934282685, 8974.685885993958, 8989.46063236208, 9173.128552787475, 9305.53472326381, 4809.422869255712, 4932.926006109911, 4936.950630493649, 4939.802407903716, 4968.90062198754, 1778.0952564820316, 1951.3365455745115, 2030.4517780199265, 2034.5727397246449, 2045.498852781078, 920.8342498350361, 953.0897992417225, 959.6593209410559, 982.1062832822098, 1044.8693913260843, 17346.392876249272, 19797.505062373555, 19944.501387465138, 20836.27073052436, 20992.580148396948, 993.5628323537765, 1005.2410430125209, 1014.1886490807325, 1043.0039312456586, 1096.5504143301368, 9441.0, 10993.505292261867, 11455.484503197376, 11457.656270311903, 11485.483153258123, 588394.0, 593224.0, 622451.0, 632031.0, 650156.0, 124139.0, 128153.3592332051, 128741.0, 132279.33860330636, 134399.0, 974.1768205866032, 984.950752462374, 985.5959056786683, 986.329296078659, 1025.0979138358346, 18345.724814128065, 18454.984975826457, 18462.81537184611, 18636.906815465834, 18967.90516047411, 53649.463505364445, 54824.725876370365, 55100.72449637726, 56995.0, 57094.71452642876, 73885.63057184679, 74475.0, 77505.0, 78021.60989195018, 80409.59795200986, 8331.33349332064, 8353.20644538768, 8431.325493960347, 8497.192766687402, 8709.608067636846, 8484.40609157353, 12187.878121218675, 12679.746405072032, 12919.741605167656, 13020.47918083266, 8888.555572221234, 9359.438433694, 10494.265401421828, 11751.942325190774, 11935.283882967049, 11473.426328683365, 11489.770204596029, 11581.478833452684, 11689.766204675689, 11890.16768826174, 11610.76778464443, 11841.0, 11930.463129159036, 12064.276143431422, 12236.75526489483, 8170.0, 8360.205780450848, 8376.790580235544, 8665.740027799176, 8930.285577153942, 10487.737806554896, 11454.026407755435, 11707.0, 11763.588274410355, 11830.822537662114], "value": 9586.010256408095, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1459.8467160948107, 1611.347404301258, 1615.4991952494727, 1867.729179269006, 1979.2083166733314, 8358.37312201585, 9008.279337652988, 9156.404833685805, 9177.03641117683, 9178.082191780819, 8986.910130898688, 9008.54957252138, 9112.453252804837, 9115.453072815635, 9119.452832830035, 2541.949161016774, 2570.652961850145, 2571.125817222144, 2571.8842652080607, 2572.922812315624, 2471.9258422247362, 2543.186180422266, 2545.478176973725, 2548.4011257354505, 2553.310606136342, 2527.633493143493, 2562.269753120361, 2574.6266791315247, 2575.5492788761985, 2577.226831950417, 2514.735952724956, 2550.4644024754825, 2552.6681531400986, 2555.4889022195543, 2558.616207568861, 2513.40934880303, 2534.4677617700304, 2541.6314634378095, 2542.186500319898, 2554.3231043773417, 8943.731688049369, 9149.085091490864, 9203.217726493256, 9210.953945230298, 9250.953745231298, 5672.149177623348, 5748.310202775652, 5763.740631671543, 5794.826155215308, 5828.679422631753, 3576.7853928764357, 3621.167131559756, 3683.889483315505, 3799.297130030953, 3817.3319669058083, 1038.2109596706482, 1045.122097438148, 1066.4987455895794, 1073.0932362154044, 1088.7060493666745, 12480.313582752944, 12571.874281257253, 12680.112392132554, 12681.429335679824, 12716.618501444971, 4797.771821326372, 4813.638977076734, 4847.80608775645, 4852.80588776445, 4874.634402419832, 9820.919698833122, 9832.164266037467, 9851.753706157404, 9856.0, 9861.950690246504, 5627.409122042127, 5628.352739435018, 5663.66018038919, 5680.5455563554815, 5695.088785794253, 4626.282926146453, 4778.259369797687, 5101.158308879068, 5201.349831271091, 5208.166693329049, 3634.890953271406, 3920.3335432976464, 3993.4409182714444, 4091.7135800494275, 4107.014316564003, 1239.3679223596032, 1239.7954337534206, 1242.6644805902356, 1259.7354555543438, 1261.2621616354536, 918.5177781664546, 925.3707478914403, 952.5427794658602, 970.5680971967548, 975.6390135649855, 6014.909776353358, 6113.663748493876, 6214.471769899519, 6238.157848690369, 6287.339829317947, 461.47622448520497, 461.4831388844448, 467.4437419470819, 470.8163816111719, 497.50746760707364, 3917.490726205632, 4030.1335212928775, 4053.8175782089875, 4055.4322394864744, 4110.815013324348, 11142.665720028412, 11666.358350290815, 11675.35785531804, 11706.239094458833, 11723.41382930867, 10292.639757608447, 10677.145828333714, 11148.163887708455, 11463.426828658701, 11590.188686791844, 8210.671573137128, 8835.028146903964, 8841.0, 8967.596458159398, 8989.730308090768, 6009.939900600938, 6033.698315084141, 6055.727492262947, 6103.542234332354, 6148.200733904742, 9869.851952220866, 10004.649837255662, 10180.643677471253, 10374.066334029672, 10394.636187733393, 10349.223808214263, 10469.738256543647, 10538.0, 10702.0, 10704.30422022566, 7148.392386647193, 7335.266473352622, 7339.889901651586, 7867.331276841533, 8019.478733882279, 7739.264769846855, 8028.558429286445, 8360.749177524684, 8381.58092095405, 8689.913100869164, 7316.524425912298, 7365.373943214887, 7403.296686814744, 7416.740414085697, 7506.43701722384, 6549.7380104795275, 7510.812229694083, 7619.771406857803, 7674.2325767425045, 7687.846243075219, 7250.637468126678, 7280.162781280221, 7303.452241081834, 7340.522866013692, 7418.66616002292, 5060.3168572242275, 5118.616103792156, 5150.4592017837585, 5198.532132108128, 5226.686398816083, 5081.415637201769, 5098.875629991834, 5143.8456846294675, 5284.418713941386, 5343.0916744154365], "value": 4686.0596751423645, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.585114458072, 336.549024307428, 343.7095654172225, 349.83208060131153, 351.6097132183278, 6670.566413183145, 6707.932920670792, 6715.899261511076, 6720.580590987241, 6743.4942379321565, 5327.46725327468, 6667.833304167399, 6683.69923353449, 6705.932940670604, 6719.6640167991645, 4806.086843499733, 4909.091818013661, 4918.950810491903, 4971.825986090487, 5004.674696144757, 4923.82766603169, 4994.525520075587, 5006.424261209952, 5014.598832093424, 5022.573081288095, 4951.133551628469, 4956.083124621957, 4959.876003099916, 4968.503149685039, 4970.353853998975, 4749.857504274877, 4897.828575999859, 4907.2393778964315, 4908.607311415079, 4923.458419573844, 3681.0, 4170.082581831992, 4270.487541495009, 4280.101178752466, 4286.0, 6005.669688167149, 6514.348565143495, 6525.641089740062, 6527.118838956728, 6527.281998980108, 4840.685355451885, 5362.651427657229, 5444.40111587725, 5916.970415147896, 5939.881202375971, 6905.620190889499, 7167.74912878052, 7172.784816455514, 7186.1735900371605, 7187.425005999507, 4837.250226214942, 4839.782209800567, 4844.5155484451625, 4857.975710121462, 4867.756612169377, 7468.178500364956, 7525.698972041112, 7553.055868016498, 7558.811029724246, 7568.924310756932, 4881.829135980294, 4904.068227036852, 4907.631927605444, 4919.557239848431, 4923.556879880756, 4986.750662466862, 4990.800367985313, 4993.0, 4993.7503124843615, 5004.549590536869, 4891.926621100686, 5287.07476191665, 5343.679379237258, 5696.572757043238, 5907.881842363128, 7176.0, 7197.568145911262, 7199.604021778852, 7207.603581802946, 7243.0946131733535, 1694.9067801271049, 1737.4700716281654, 1740.2516917725247, 1743.808181100078, 1745.1012728444862, 1083.1659622090947, 1105.364415461097, 1112.0214211493833, 1119.171812858479, 1121.7027487715761, 6555.770548030796, 6722.29415911332, 6724.0, 6736.8989465158065, 6740.696668649923, 5939.940600594025, 6500.829850626933, 6964.686589103502, 7115.466340024519, 7395.741149059757, 6895.896561551581, 6941.236463988957, 7037.190723066913, 7050.365467107985, 7077.256888026683, 3933.350997085506, 3988.541317748496, 3991.980040099781, 3995.9810248386475, 4002.0195052212393, 7504.962475187698, 7741.225877412327, 7742.651580678883, 7830.725924592612, 7846.764597061983, 7630.122535908442, 7688.577128257888, 7743.341815945595, 7756.224377562198, 7767.2232776723, 7819.726309579138, 7837.020372453443, 7850.960745196352, 7851.882221766678, 7858.214178582096, 7471.514351567131, 7484.850302994018, 7485.88771168422, 7494.063242094739, 7527.849443011219, 7055.2944705529035, 7326.560406375635, 7354.338109570164, 7354.558726476428, 7365.926340736738, 6330.620162790247, 7763.029621297338, 7793.961030194812, 7819.0617125945255, 7827.295543401121, 4910.459849416633, 4969.925451118308, 4970.353853998957, 4980.900381992412, 4992.8751781205765, 7428.368588670023, 7442.96278518604, 7444.776656700307, 7453.590052547162, 7470.813229669302, 5503.9174412383045, 5861.35525092231, 6528.824811533779, 7201.603911784902, 7209.0, 7129.215786263403, 7165.24764899678, 7192.784216473514, 7194.712211511481, 7204.423646108404, 7004.789856304319, 7006.719731210898, 7022.2275549688475, 7025.051618031501, 7025.789226323219, 6940.583564986117, 7162.713491460283, 7176.0, 7180.820479488055, 7182.928170718435, 6789.490788191004, 6945.236024037251, 7098.396636285767, 7118.750843720445, 7138.107736532934], "value": 5260.078989057685, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.8080818179092, 717.9030830837837, 756.8183635927376, 808.6361137488132, 823.0534884882383, 15745.685086298266, 15931.44239951602, 15988.920055399736, 16030.0, 16060.518184454455, 13298.468061277561, 14483.927580362084, 14577.34401951912, 16365.918170409132, 16559.66880662389, 769.1846642558877, 793.1750978981852, 960.6109525642127, 988.8516722491612, 990.9603615855357, 973.265184785486, 982.7051884434677, 985.7584891701543, 987.7975015121918, 988.7972965542046, 807.6527093349857, 826.8842362069315, 1035.8394448860402, 1036.2435422141841, 1042.854000439939, 995.6465454763563, 1021.9744506387362, 1022.974425639365, 1022.9897701022969, 1024.7899180667946, 760.8288135169598, 761.4936067515096, 763.091920614467, 763.133843088099, 763.3702195688523, 15349.539513814603, 15439.61400964985, 15440.996335238173, 15459.613509662237, 15470.381184752596, 13061.804072938914, 13358.265295408748, 13394.598162055154, 13432.328383580782, 13645.522406715718, 10306.690799276033, 10479.0, 10528.631497897537, 10807.783844323149, 10855.837162442569, 3607.332643460968, 3626.075350785533, 3638.745287829853, 3675.117971686776, 3771.396576547739, 72299.55400892005, 85333.0, 85485.57257213673, 87494.0, 88575.55712221462, 9961.50192490387, 9991.850122248172, 10017.198624110053, 10141.492925353703, 10715.303505272132, 22901.427464313525, 22952.4261893454, 23462.7653723464, 23462.882685586465, 23489.765102348756, 7676.232376762279, 7720.343770779435, 7816.937358438262, 7852.175521570267, 7953.323967462715, 4003.499562554681, 4086.203190377907, 4186.204621121977, 4280.6789490788315, 4289.420928174656, 3864.0, 3912.56961734209, 3914.9804250978564, 3926.411038344214, 3937.370020796659, 651.3453978751419, 693.5110746923407, 721.1886627544013, 723.0383589825519, 753.997183745617, 539.1804457224996, 542.2327406719447, 556.5074908705825, 560.5515587530041, 575.4331982996829, 8122.350211983027, 8423.536705481258, 8425.873611895826, 8597.054324024351, 8619.870701939475, 550.6365798572923, 578.5834199376442, 583.2184872271177, 588.6026931821003, 638.1767519899278, 3973.8013099344917, 4008.2584721825974, 4084.016915219218, 4086.7956602169775, 4253.255680255943, 85302.61671216162, 89862.65206021914, 90668.54665726628, 92701.0, 96001.5199923996, 74386.62806685932, 78785.0, 79034.0, 80148.59925700334, 80351.59824200842, 70681.58636827132, 70699.64650176819, 70931.0, 71111.0, 72379.27620723726, 6917.619530925847, 7787.844243115219, 7968.92031079705, 8094.716684915999, 8232.8173374613, 48804.75597622131, 49537.0, 49863.0, 50447.24329134992, 50906.0, 65648.6717566409, 69025.0, 69515.95726064012, 70944.29055709377, 70957.6452117736, 10144.087032167141, 10205.285630005828, 10210.642627508001, 10701.0, 10848.945755271488, 11571.710707232387, 11646.88353116458, 11802.114841386758, 12040.157188996685, 12252.816207756712, 11708.824367634323, 11825.231359961575, 11870.881291186977, 11921.105917056082, 12256.632301030982, 11395.202335836411, 11552.480138393961, 11775.293482391084, 11822.231554949245, 11913.987311078656, 10710.143188545053, 11412.543498259976, 11477.139214558774, 11712.70718232051, 12100.273983561014, 9768.0, 9787.46168960714, 10190.082892539707, 10244.846327304947, 10485.633002844865, 9742.415455072718, 9921.15670168015, 9977.20436758351, 10007.427309569335, 10051.346662466916], "value": 7135.251983151256, "unit": "score"}], "name": "dromaeo_css", "value": 7555.906129124132, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 122.0, 112.0, 112.0, 112.0, 113.0, 113.0, 112.0, 133.0], "value": 115.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 147.0, 145.0, 167.0, 112.0, 142.0, 117.0, 157.0, 192.0, 145.0], "value": 151.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 187.0, 190.0, 186.0, 187.0, 188.0, 185.0, 188.0, 190.0, 187.0], "value": 187.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 79.0, 77.0, 170.0, 91.0, 81.0, 80.0, 62.0, 134.0, 54.0], "value": 89.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 149.0, 78.0, 78.0, 79.0, 125.0, 102.0, 113.0, 168.0], "value": 107.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 88.0, 85.0, 88.0, 84.0, 88.0, 85.0, 87.0, 84.0], "value": 86.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 94.0, 94.0, 106.0, 124.0, 135.0, 148.0, 92.0], "value": 107.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 87.0, 84.0, 87.0, 84.0, 86.0, 85.0, 84.0, 89.0], "value": 85.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 63.0, 62.0, 62.0, 65.0, 62.0, 63.0, 78.0, 57.0, 56.0], "value": 62.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 64.0, 64.0, 68.0, 70.0, 77.0, 69.0, 66.0, 66.0, 66.0], "value": 67.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 104.0, 103.0, 104.0, 68.0, 76.0, 101.0, 64.0, 96.0, 99.0], "value": 89.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 126.0, 128.0, 129.0, 145.0, 141.0, 126.0, 137.0, 162.0, 170.0], "value": 139.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 168.0, 159.0, 160.0, 159.0, 214.0, 212.0, 161.0, 171.0, 164.0], "value": 173.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 68.0, 67.0, 66.0, 76.0, 67.0, 65.0, 66.0, 66.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1531.1, "alertThreshold": 2.0}]} 06:19:04 INFO - Return code: 0 06:19:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:19:05 ERROR - # TBPL SUCCESS # 06:19:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:19:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:19:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:19:05 INFO - 2016-06-27 06:19:05.053 screenresolution[2884:29648] starting screenresolution argv=screenresolution get 06:19:05 INFO - 2016-06-27 06:19:05.056 screenresolution[2884:29648] Display 0: 1600x1200x32@60 06:19:05 INFO - 2016-06-27 06:19:05.062 screenresolution[2885:29651] starting screenresolution argv=screenresolution list 06:19:05 INFO - Available Modes on Display 0 06:19:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:19:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:19:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:19:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:19:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:19:05 INFO - Intel Iris: 06:19:05 INFO - Chipset Model: Intel Iris 06:19:05 INFO - Type: GPU 06:19:05 INFO - Bus: Built-In 06:19:05 INFO - VRAM (Dynamic, Max): 1536 MB 06:19:05 INFO - Vendor: Intel (0x8086) 06:19:05 INFO - Device ID: 0x0a2e 06:19:05 INFO - Revision ID: 0x0009 06:19:05 INFO - Displays: 06:19:05 INFO - Display: 06:19:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:19:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:19:05 INFO - Display Serial Number: 1600x1200 60 06:19:05 INFO - Main Display: Yes 06:19:05 INFO - Mirror: Off 06:19:05 INFO - Online: Yes 06:19:05 INFO - Rotation: Supported 06:19:05 INFO - Return code: 0 06:19:05 INFO - Running post-action listener: _resource_record_post_action 06:19:05 INFO - Running post-run listener: _resource_record_post_run 06:19:06 INFO - Total resource usage - Wall time: 1196s; CPU: 53.0%; Read bytes: 245760; Write bytes: 495624704; Read time: 3; Write time: 1576 06:19:06 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 194632192; Write bytes: 194650112; Read time: 17640; Write time: 363 06:19:06 INFO - run-tests - Wall time: 1175s; CPU: 52.0%; Read bytes: 245760; Write bytes: 296446976; Read time: 3; Write time: 1170 06:19:06 INFO - Running post-run listener: _upload_blobber_files 06:19:06 INFO - Blob upload gear active. 06:19:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:19:06 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:19:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:19:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:19:06 INFO - (blobuploader) - INFO - Open directory for files ... 06:19:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:19:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:19:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:19:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:19:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:19:07 INFO - (blobuploader) - INFO - Done attempting. 06:19:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:19:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:19:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:19:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:19:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:19:08 INFO - (blobuploader) - INFO - Done attempting. 06:19:08 INFO - (blobuploader) - INFO - Iteration through files over. 06:19:08 INFO - Return code: 0 06:19:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:19:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:19:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/730276ec9c7627c571ece637f15f74b382f4ae4ba4da4cbbcd72454cee7ea1544893dd31a57b96d846c199f81a29c5fdfc2675a98246e4b6d7c9c676a3a08b1d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/97a6a7d872e412207582175e755991b4de60dfea27b6b51d9f66e3da5711f98f68ed2296f1cc8d44571c1db8f1aff3e0163edeb23a10b8f041faa6507302f6ff"} 06:19:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:19:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:19:08 INFO - Contents: 06:19:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/730276ec9c7627c571ece637f15f74b382f4ae4ba4da4cbbcd72454cee7ea1544893dd31a57b96d846c199f81a29c5fdfc2675a98246e4b6d7c9c676a3a08b1d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/97a6a7d872e412207582175e755991b4de60dfea27b6b51d9f66e3da5711f98f68ed2296f1cc8d44571c1db8f1aff3e0163edeb23a10b8f041faa6507302f6ff"} 06:19:08 INFO - Running post-run listener: copy_logs_to_upload_dir 06:19:08 INFO - Copying logs to upload dir... 06:19:08 INFO - mkdir: /builds/slave/test/build/upload/logs 06:19:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.466521 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-06-27 06:19:08.481413) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 06:19:08.484453) ========= 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.HTWEtY2qoM/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.neMTPKGDz4/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/730276ec9c7627c571ece637f15f74b382f4ae4ba4da4cbbcd72454cee7ea1544893dd31a57b96d846c199f81a29c5fdfc2675a98246e4b6d7c9c676a3a08b1d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/97a6a7d872e412207582175e755991b4de60dfea27b6b51d9f66e3da5711f98f68ed2296f1cc8d44571c1db8f1aff3e0163edeb23a10b8f041faa6507302f6ff"} 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.011355 build_url: 'https://queue.taskcluster.net/v1/task/BtGTOhxQTu-sRUUi3HVwTA/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/730276ec9c7627c571ece637f15f74b382f4ae4ba4da4cbbcd72454cee7ea1544893dd31a57b96d846c199f81a29c5fdfc2675a98246e4b6d7c9c676a3a08b1d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/97a6a7d872e412207582175e755991b4de60dfea27b6b51d9f66e3da5711f98f68ed2296f1cc8d44571c1db8f1aff3e0163edeb23a10b8f041faa6507302f6ff"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 06:19:08.521480) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:19:08.522262) ========= 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.HTWEtY2qoM/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.neMTPKGDz4/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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.005293 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:19:08.573882) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 06:19:08.574266) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 06:19:08.574618) ========= ========= Total master_lag: 0.67 =========