builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0354 starttime: 1465219065.61 results: success (0) buildid: 20160602140837 builduid: 893fdbbbce3544769bc98c5128e2bb0b revision: 6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 06:17:45.607659) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 06:17:45.608001) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 06:17:45.608279) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 06:17:45.685435) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:17:45.685679) ========= 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.s0czvilzXl/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.WXo3TGynn8/Listeners TMPDIR=/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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-06 06:17:45-- 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% 30.0M=0s 2016-06-06 06:17:45 (30.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.079227 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:17:45.792183) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:17:45.792500) ========= 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.s0czvilzXl/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.WXo3TGynn8/Listeners TMPDIR=/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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.026027 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:17:45.850267) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-06-06 06:17:45.850578) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea --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 6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.s0czvilzXl/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.WXo3TGynn8/Listeners TMPDIR=/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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-06 06:17:45,932 truncating revision to first 12 chars 2016-06-06 06:17:45,932 Setting DEBUG logging. 2016-06-06 06:17:45,932 attempt 1/10 2016-06-06 06:17:45,932 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/6e2399cf03e2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 06:17:47,848 unpacking tar archive at: mozilla-beta-6e2399cf03e2/testing/mozharness/ program finished with exit code 0 elapsedTime=2.198205 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-06-06 06:17:48.073427) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 06:17:48.074189) ========= script_repo_revision: 6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 06:17:48.075140) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 06:17:48.075845) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 06:17:48.096002) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-06-06 06:17:48.096693) ========= /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.s0czvilzXl/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.WXo3TGynn8/Listeners TMPDIR=/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 06:17:48 INFO - MultiFileLogger online at 20160606 06:17:48 in /builds/slave/test 06:17:48 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 06:17:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:17:48 INFO - {'append_to_log': False, 06:17:48 INFO - 'base_work_dir': '/builds/slave/test', 06:17:48 INFO - 'blob_upload_branch': 'Mozilla-Beta', 06:17:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:17:48 INFO - 'branch': 'Mozilla-Beta', 06:17:48 INFO - 'buildbot_json_path': 'buildprops.json', 06:17:48 INFO - 'config_files': ('talos/mac_config.py',), 06:17:48 INFO - 'default_actions': ('clobber', 06:17:48 INFO - 'read-buildbot-config', 06:17:48 INFO - 'download-and-extract', 06:17:48 INFO - 'populate-webroot', 06:17:48 INFO - 'create-virtualenv', 06:17:48 INFO - 'install', 06:17:48 INFO - 'run-tests'), 06:17:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:17:48 INFO - 'download_minidump_stackwalk': True, 06:17:48 INFO - 'download_symbols': 'ondemand', 06:17:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:17:48 INFO - 'tooltool.py': '/tools/tooltool.py', 06:17:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:17:48 INFO - '/tools/misc-python/virtualenv.py')}, 06:17:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:17:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:17:48 INFO - 'installer_path': 'installer.exe', 06:17:48 INFO - 'log_level': 'info', 06:17:48 INFO - 'log_name': 'talos', 06:17:48 INFO - 'log_to_console': True, 06:17:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:17:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:17:48 INFO - 'opt_config_files': (), 06:17:48 INFO - 'pip_index': False, 06:17:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:17:48 INFO - 'cmd': ('bash', 06:17:48 INFO - '-c', 06:17:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:17:48 INFO - 'enabled': True, 06:17:48 INFO - 'halt_on_failure': False, 06:17:48 INFO - 'name': 'check_screen_resolution'},), 06:17:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:17:48 INFO - 'cmd': ('bash', 06:17:48 INFO - '-c', 06:17:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:17:48 INFO - 'enabled': True, 06:17:48 INFO - 'halt_on_failure': False, 06:17:48 INFO - 'name': 'check_screen_resolution'},), 06:17:48 INFO - 'run_cmd_checks_enabled': True, 06:17:48 INFO - 'sps_profile': False, 06:17:48 INFO - 'sps_profile_interval': 0, 06:17:48 INFO - 'suite': 'dromaeojs', 06:17:48 INFO - 'system_bits': '32', 06:17:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:17:48 INFO - 'title': 't-yosemite-r7-0354', 06:17:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:17:48 INFO - 'use_talos_json': True, 06:17:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:17:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:17:48 INFO - 'work_dir': 'build'} 06:17:48 INFO - ##### 06:17:48 INFO - ##### Running clobber step. 06:17:48 INFO - ##### 06:17:48 INFO - Running pre-action listener: _resource_record_pre_action 06:17:48 INFO - Running main action method: clobber 06:17:48 INFO - rmtree: /builds/slave/test/build 06:17:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:17:50 INFO - Running post-action listener: _resource_record_post_action 06:17:50 INFO - ##### 06:17:50 INFO - ##### Running read-buildbot-config step. 06:17:50 INFO - ##### 06:17:50 INFO - Running pre-action listener: _resource_record_pre_action 06:17:50 INFO - Running main action method: read_buildbot_config 06:17:50 INFO - Using buildbot properties: 06:17:50 INFO - { 06:17:50 INFO - "project": "", 06:17:50 INFO - "product": "firefox", 06:17:50 INFO - "script_repo_revision": "production", 06:17:50 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 06:17:50 INFO - "repository": "", 06:17:50 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 06:17:50 INFO - "buildid": "20160602140837", 06:17:50 INFO - "pgo_build": "False", 06:17:50 INFO - "basedir": "/builds/slave/test", 06:17:50 INFO - "buildnumber": 4, 06:17:50 INFO - "slavename": "t-yosemite-r7-0354", 06:17:50 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 06:17:50 INFO - "platform": "yosemite_r7", 06:17:50 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 06:17:50 INFO - "branch": "mozilla-beta", 06:17:50 INFO - "repo_path": "releases/mozilla-beta", 06:17:50 INFO - "revision": "6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea", 06:17:50 INFO - "stage_platform": "macosx64", 06:17:50 INFO - "builduid": "893fdbbbce3544769bc98c5128e2bb0b", 06:17:50 INFO - "slavebuilddir": "test" 06:17:50 INFO - } 06:17:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 06:17:50 INFO - Running post-action listener: _resource_record_post_action 06:17:50 INFO - ##### 06:17:50 INFO - ##### Running download-and-extract step. 06:17:50 INFO - ##### 06:17:50 INFO - Running pre-action listener: _resource_record_pre_action 06:17:50 INFO - Running main action method: download_and_extract 06:17:50 INFO - mkdir: /builds/slave/test/build/tests 06:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:17:50 INFO - https://queue.taskcluster.net/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 06:17:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 06:17:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 06:17:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 06:17:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json'}, attempt #1 06:17:51 INFO - Downloaded 1241 bytes. 06:17:51 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 06:17:51 INFO - Using the following test package requirements: 06:17:51 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 06:17:51 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 06:17:51 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 06:17:51 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 06:17:51 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 06:17:51 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 06:17:51 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 06:17:51 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 06:17:51 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 06:17:51 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 06:17:51 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 06:17:51 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 06:17:51 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 06:17:51 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 06:17:51 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 06:17:51 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 06:17:51 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 06:17:51 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 06:17:51 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 06:17:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:17:51 INFO - https://queue.taskcluster.net/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:17:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 06:17:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 06:17:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 06:17:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 06:17:53 INFO - Downloaded 17816944 bytes. 06:17:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:17:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:17:56 INFO - Return code: 0 06:17:56 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip', u'firefox-47.0.en-US.mac.talos.tests.zip'] for test suite category: talos 06:17:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:17:56 INFO - https://queue.taskcluster.net/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:17:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 06:17:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 06:17:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 06:17:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 06:18:05 INFO - Downloaded 17816944 bytes. 06:18:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:18:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:18:09 INFO - Return code: 0 06:18:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:09 INFO - https://queue.taskcluster.net/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:18:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 06:18:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 06:18:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip 06:18:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip'}, attempt #1 06:18:10 INFO - Downloaded 10845194 bytes. 06:18:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:18:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 06:18:10 INFO - Return code: 0 06:18:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:10 INFO - https://queue.taskcluster.net/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 06:18:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 06:18:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 06:18:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 06:18:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg'}, attempt #1 06:18:12 INFO - Downloaded 88466458 bytes. 06:18:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 06:18:12 INFO - mkdir: /builds/slave/test/properties 06:18:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:18:12 INFO - Writing to file /builds/slave/test/properties/build_url 06:18:12 INFO - Contents: 06:18:12 INFO - build_url:https://queue.taskcluster.net/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 06:18:13 INFO - Running post-action listener: _resource_record_post_action 06:18:13 INFO - Running post-action listener: set_extra_try_arguments 06:18:13 INFO - ##### 06:18:13 INFO - ##### Running populate-webroot step. 06:18:13 INFO - ##### 06:18:13 INFO - Running pre-action listener: _resource_record_pre_action 06:18:13 INFO - Running main action method: populate_webroot 06:18:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:18:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:18:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:18:13 INFO - '--tppagecycles', 06:18:13 INFO - '7'], 06:18:13 INFO - 'tests': ['tsvgm']}}, 06:18:13 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:18:13 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:18:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:18:13 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 06:18:13 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:18:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:18:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:18:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:14 INFO - 'talos_options': ['--e10s'], 06:18:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:18:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:14 INFO - 'tests': ['damp', 'tps']}, 06:18:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:14 INFO - 'talos_options': ['--e10s'], 06:18:14 INFO - 'tests': ['damp', 'tps']}, 06:18:14 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:18:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:18:14 INFO - 'other': {'tests': ['a11yr', 06:18:14 INFO - 'ts_paint', 06:18:14 INFO - 'tpaint', 06:18:14 INFO - 'sessionrestore', 06:18:14 INFO - 'sessionrestore_no_auto_restore', 06:18:14 INFO - 'tabpaint']}, 06:18:14 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:18:14 INFO - 'tests': ['a11yr', 06:18:14 INFO - 'ts_paint', 06:18:14 INFO - 'tpaint', 06:18:14 INFO - 'sessionrestore', 06:18:14 INFO - 'sessionrestore_no_auto_restore', 06:18:14 INFO - 'tabpaint']}, 06:18:14 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:18:14 INFO - 'tests': ['a11yr', 06:18:14 INFO - 'ts_paint', 06:18:14 INFO - 'tpaint', 06:18:14 INFO - 'sessionrestore', 06:18:14 INFO - 'sessionrestore_no_auto_restore', 06:18:14 INFO - 'tabpaint']}, 06:18:14 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:18:14 INFO - 'tests': ['a11yr', 06:18:14 INFO - 'ts_paint', 06:18:14 INFO - 'tpaint', 06:18:14 INFO - 'sessionrestore', 06:18:14 INFO - 'sessionrestore_no_auto_restore', 06:18:14 INFO - 'tabpaint']}, 06:18:14 INFO - 'other_l64': {'tests': ['a11yr', 06:18:14 INFO - 'ts_paint', 06:18:14 INFO - 'tpaint', 06:18:14 INFO - 'sessionrestore', 06:18:14 INFO - 'sessionrestore_no_auto_restore', 06:18:14 INFO - 'tabpaint']}, 06:18:14 INFO - 'other_nol64': {'tests': ['a11yr', 06:18:14 INFO - 'ts_paint', 06:18:14 INFO - 'tpaint', 06:18:14 INFO - 'sessionrestore', 06:18:14 INFO - 'sessionrestore_no_auto_restore', 06:18:14 INFO - 'tabpaint']}, 06:18:14 INFO - 'svgr': {'tests': ['tsvgx', 06:18:14 INFO - 'tsvgr_opacity', 06:18:14 INFO - 'tart', 06:18:14 INFO - 'tscrollx', 06:18:14 INFO - 'cart']}, 06:18:14 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:18:14 INFO - 'tests': ['tsvgx', 06:18:14 INFO - 'tsvgr_opacity', 06:18:14 INFO - 'tart', 06:18:14 INFO - 'tscrollx', 06:18:14 INFO - 'cart']}, 06:18:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:14 INFO - 'tests': ['tp5o']}, 06:18:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:14 INFO - 'talos_options': ['--e10s'], 06:18:14 INFO - 'tests': ['tp5o']}, 06:18:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:14 INFO - 'talos_options': ['--xperf_path', 06:18:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:18:14 INFO - 'tests': ['tp5n']}, 06:18:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:14 INFO - 'talos_options': ['--e10s', 06:18:14 INFO - '--xperf_path', 06:18:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:18:14 INFO - 'tests': ['tp5n']}}, 06:18:14 INFO - 'talos.zip': {'path': '', 06:18:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:18:14 INFO - Running post-action listener: _resource_record_post_action 06:18:14 INFO - ##### 06:18:14 INFO - ##### Running create-virtualenv step. 06:18:14 INFO - ##### 06:18:14 INFO - Running pre-action listener: _resource_record_pre_action 06:18:14 INFO - Running main action method: create_virtualenv 06:18:14 INFO - Creating virtualenv /builds/slave/test/build/venv 06:18:14 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:18:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:18:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:18:14 INFO - Using real prefix '/tools/python27' 06:18:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:18:14 INFO - Installing distribute.............................................................................................................................................................................................done. 06:18:17 INFO - Installing pip.................done. 06:18:17 INFO - Return code: 0 06:18:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:18:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103e0ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e154c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83c2db0f00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cb2d30>, '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 0x103b16db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103ca9b20>, '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.s0czvilzXl/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.WXo3TGynn8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:18:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:18:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:18:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s0czvilzXl/Render', 06:18:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:18:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:18:17 INFO - 'HOME': '/Users/cltbld', 06:18:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:18:17 INFO - 'LOGNAME': 'cltbld', 06:18:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:17 INFO - 'MOZ_NO_REMOTE': '1', 06:18:17 INFO - 'NO_EM_RESTART': '1', 06:18:17 INFO - 'PAGER': '/bin/cat', 06:18:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:18:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:17 INFO - 'PWD': '/builds/slave/test', 06:18:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:18:17 INFO - 'SHELL': '/bin/bash', 06:18:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WXo3TGynn8/Listeners', 06:18:17 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 06:18:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:18:17 INFO - 'USER': 'cltbld', 06:18:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:18:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:18:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:17 INFO - 'XPC_FLAGS': '0x0', 06:18:17 INFO - 'XPC_SERVICE_NAME': '0', 06:18:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:18:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:18 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:18:18 INFO - Cleaning up... 06:18:18 INFO - Return code: 0 06:18:18 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:18:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103e0ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e154c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83c2db0f00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cb2d30>, '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 0x103b16db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103ca9b20>, '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.s0czvilzXl/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.WXo3TGynn8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:18:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 06:18:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:18:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s0czvilzXl/Render', 06:18:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:18:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:18:18 INFO - 'HOME': '/Users/cltbld', 06:18:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:18:18 INFO - 'LOGNAME': 'cltbld', 06:18:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:18 INFO - 'MOZ_NO_REMOTE': '1', 06:18:18 INFO - 'NO_EM_RESTART': '1', 06:18:18 INFO - 'PAGER': '/bin/cat', 06:18:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:18:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:18 INFO - 'PWD': '/builds/slave/test', 06:18:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:18:18 INFO - 'SHELL': '/bin/bash', 06:18:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WXo3TGynn8/Listeners', 06:18:18 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 06:18:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:18:18 INFO - 'USER': 'cltbld', 06:18:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:18:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:18:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:18 INFO - 'XPC_FLAGS': '0x0', 06:18:18 INFO - 'XPC_SERVICE_NAME': '0', 06:18:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:18:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:18 INFO - Downloading/unpacking psutil>=0.7.1 06:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:18:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:18:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:18:21 INFO - Installing collected packages: psutil 06:18:21 INFO - Running setup.py install for psutil 06:18:21 INFO - building 'psutil._psutil_osx' extension 06:18:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 06:18:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 06:18:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 06:18:21 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 06:18:22 INFO - building 'psutil._psutil_posix' extension 06:18:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 06:18:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:18:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:18:22 INFO - ^ 06:18:22 INFO - 1 warning generated. 06:18:22 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 06:18:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:18:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:18:22 INFO - Successfully installed psutil 06:18:22 INFO - Cleaning up... 06:18:22 INFO - Return code: 0 06:18:22 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:18:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103e0ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e154c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83c2db0f00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cb2d30>, '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 0x103b16db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103ca9b20>, '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.s0czvilzXl/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.WXo3TGynn8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:18:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 06:18:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:18:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s0czvilzXl/Render', 06:18:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:18:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:18:22 INFO - 'HOME': '/Users/cltbld', 06:18:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:18:22 INFO - 'LOGNAME': 'cltbld', 06:18:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:22 INFO - 'MOZ_NO_REMOTE': '1', 06:18:22 INFO - 'NO_EM_RESTART': '1', 06:18:22 INFO - 'PAGER': '/bin/cat', 06:18:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:18:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:22 INFO - 'PWD': '/builds/slave/test', 06:18:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:18:22 INFO - 'SHELL': '/bin/bash', 06:18:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WXo3TGynn8/Listeners', 06:18:22 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 06:18:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:18:22 INFO - 'USER': 'cltbld', 06:18:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:18:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:18:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:22 INFO - 'XPC_FLAGS': '0x0', 06:18:22 INFO - 'XPC_SERVICE_NAME': '0', 06:18:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:18:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:18:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:18:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:18:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:18:25 INFO - Installing collected packages: mozsystemmonitor 06:18:25 INFO - Running setup.py install for mozsystemmonitor 06:18:25 INFO - Successfully installed mozsystemmonitor 06:18:25 INFO - Cleaning up... 06:18:25 INFO - Return code: 0 06:18:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:18: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')]} 06:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18: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')]} 06:18:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103e0ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e154c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83c2db0f00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cb2d30>, '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 0x103b16db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103ca9b20>, '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.s0czvilzXl/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.WXo3TGynn8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:18:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:18:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:18:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s0czvilzXl/Render', 06:18:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:18:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:18:25 INFO - 'HOME': '/Users/cltbld', 06:18:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:18:25 INFO - 'LOGNAME': 'cltbld', 06:18:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:25 INFO - 'MOZ_NO_REMOTE': '1', 06:18:25 INFO - 'NO_EM_RESTART': '1', 06:18:25 INFO - 'PAGER': '/bin/cat', 06:18:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:18:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:25 INFO - 'PWD': '/builds/slave/test', 06:18:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:18:25 INFO - 'SHELL': '/bin/bash', 06:18:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WXo3TGynn8/Listeners', 06:18:25 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 06:18:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:18:25 INFO - 'USER': 'cltbld', 06:18:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:18:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:18:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:25 INFO - 'XPC_FLAGS': '0x0', 06:18:25 INFO - 'XPC_SERVICE_NAME': '0', 06:18:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:18:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:25 INFO - Downloading/unpacking blobuploader==1.2.4 06:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:28 INFO - Downloading blobuploader-1.2.4.tar.gz 06:18:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:18:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:18:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:29 INFO - Downloading docopt-0.6.1.tar.gz 06:18:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:18:29 INFO - Installing collected packages: blobuploader, requests, docopt 06:18:29 INFO - Running setup.py install for blobuploader 06:18:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:18:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:18:29 INFO - Running setup.py install for requests 06:18:30 INFO - Running setup.py install for docopt 06:18:30 INFO - Successfully installed blobuploader requests docopt 06:18:30 INFO - Cleaning up... 06:18:30 INFO - Return code: 0 06:18:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103e0ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e154c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83c2db0f00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cb2d30>, '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 0x103b16db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103ca9b20>, '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.s0czvilzXl/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.WXo3TGynn8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:18:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:18:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:18:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s0czvilzXl/Render', 06:18:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:18:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:18:30 INFO - 'HOME': '/Users/cltbld', 06:18:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:18:30 INFO - 'LOGNAME': 'cltbld', 06:18:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:30 INFO - 'MOZ_NO_REMOTE': '1', 06:18:30 INFO - 'NO_EM_RESTART': '1', 06:18:30 INFO - 'PAGER': '/bin/cat', 06:18:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:18:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:30 INFO - 'PWD': '/builds/slave/test', 06:18:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:18:30 INFO - 'SHELL': '/bin/bash', 06:18:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WXo3TGynn8/Listeners', 06:18:30 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 06:18:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:18:30 INFO - 'USER': 'cltbld', 06:18:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:18:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:18:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:30 INFO - 'XPC_FLAGS': '0x0', 06:18:30 INFO - 'XPC_SERVICE_NAME': '0', 06:18:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:18:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:18:30 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-zOqhr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:18:30 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-Ae8stD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:18:30 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-n_PycE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:18:30 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-rVy2q1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:18:30 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-KW3pr_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:18:31 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-pDf2b1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:18:31 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-jt1dIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:18:31 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-68U8l1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:18:31 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-Ttxibr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:18:31 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-gBcHQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:18:31 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-fSUyWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:18:31 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-Q5Oalp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:18:31 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-njkadR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:18:31 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-7Q0YsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:18:31 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-yHeXaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:18:32 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-LxZs2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:18:32 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-iEyLjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:18:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:18:32 INFO - Running setup.py install for manifestparser 06:18:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:18:32 INFO - Running setup.py install for mozcrash 06:18:32 INFO - Running setup.py install for mozdebug 06:18:32 INFO - Running setup.py install for mozdevice 06:18:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:18:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:18:32 INFO - Running setup.py install for mozfile 06:18:33 INFO - Running setup.py install for mozhttpd 06:18:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:18:33 INFO - Running setup.py install for mozinfo 06:18:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:18:33 INFO - Running setup.py install for mozInstall 06:18:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:18:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:18:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:18:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:18:33 INFO - Running setup.py install for mozleak 06:18:33 INFO - Running setup.py install for mozlog 06:18:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:18:33 INFO - Running setup.py install for moznetwork 06:18:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:18:33 INFO - Running setup.py install for mozprocess 06:18:34 INFO - Running setup.py install for mozprofile 06:18:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:18:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:18:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:18:34 INFO - Running setup.py install for mozrunner 06:18:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:18:34 INFO - Running setup.py install for mozscreenshot 06:18:34 INFO - Running setup.py install for moztest 06:18:34 INFO - Running setup.py install for mozversion 06:18:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:18:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:18:34 INFO - Cleaning up... 06:18:34 INFO - Return code: 0 06:18:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:18:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:34 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 0x103e0ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e154c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83c2db0f00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cb2d30>, '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 0x103b16db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103ca9b20>, '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.s0czvilzXl/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.WXo3TGynn8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:18:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:18:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:18:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s0czvilzXl/Render', 06:18:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:18:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:18:34 INFO - 'HOME': '/Users/cltbld', 06:18:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:18:34 INFO - 'LOGNAME': 'cltbld', 06:18:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:34 INFO - 'MOZ_NO_REMOTE': '1', 06:18:34 INFO - 'NO_EM_RESTART': '1', 06:18:34 INFO - 'PAGER': '/bin/cat', 06:18:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:18:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:34 INFO - 'PWD': '/builds/slave/test', 06:18:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:18:34 INFO - 'SHELL': '/bin/bash', 06:18:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WXo3TGynn8/Listeners', 06:18:34 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 06:18:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:18:34 INFO - 'USER': 'cltbld', 06:18:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:18:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:18:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:34 INFO - 'XPC_FLAGS': '0x0', 06:18:34 INFO - 'XPC_SERVICE_NAME': '0', 06:18:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:18:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:18:35 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-M0SneB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:18:35 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-MJfxt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:18:35 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-jFsOHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:18:35 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-dCwW6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:18:35 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-hmdR9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:18:35 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-vRyorZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:18:35 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-pHOgRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:18:35 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-5qa0bH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:18:35 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-FWAToo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:18:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:18:36 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-saQ7JT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:18:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:18:36 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-5DJ9wz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:18:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:18:36 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-i3Jsjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:18:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:18:36 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-Wq7ELI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:18:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:18:36 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-FSFFig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:18:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:18:36 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-zoq3AD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:18:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:18:36 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-hk8CN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:18:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:18:36 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-Jomtnv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:18:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:18:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:18:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:18:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:18:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:18:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:18:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:39 INFO - Downloading blessings-1.6.tar.gz 06:18:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:18:39 INFO - Installing collected packages: blessings 06:18:39 INFO - Running setup.py install for blessings 06:18:39 INFO - Successfully installed blessings 06:18:39 INFO - Cleaning up... 06:18:40 INFO - Return code: 0 06:18:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:18:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:18:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:18:40 INFO - Reading from file tmpfile_stdout 06:18:40 INFO - Current package versions: 06:18:40 INFO - blessings == 1.6 06:18:40 INFO - blobuploader == 1.2.4 06:18:40 INFO - docopt == 0.6.1 06:18:40 INFO - manifestparser == 1.1 06:18:40 INFO - mozInstall == 1.12 06:18:40 INFO - mozcrash == 0.17 06:18:40 INFO - mozdebug == 0.1 06:18:40 INFO - mozdevice == 0.48 06:18:40 INFO - mozfile == 1.2 06:18:40 INFO - mozhttpd == 0.7 06:18:40 INFO - mozinfo == 0.9 06:18:40 INFO - mozleak == 0.1 06:18:40 INFO - mozlog == 3.1 06:18:40 INFO - moznetwork == 0.27 06:18:40 INFO - mozprocess == 0.22 06:18:40 INFO - mozprofile == 0.28 06:18:40 INFO - mozrunner == 6.11 06:18:40 INFO - mozscreenshot == 0.1 06:18:40 INFO - mozsystemmonitor == 0.0 06:18:40 INFO - moztest == 0.7 06:18:40 INFO - mozversion == 1.4 06:18:40 INFO - psutil == 3.1.1 06:18:40 INFO - requests == 1.2.3 06:18:40 INFO - wsgiref == 0.1.2 06:18:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:18:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103e0ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e154c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83c2db0f00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cb2d30>, '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 0x103b16db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103ca9b20>, '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.s0czvilzXl/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.WXo3TGynn8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:18:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:18:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:18:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s0czvilzXl/Render', 06:18:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:18:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:18:40 INFO - 'HOME': '/Users/cltbld', 06:18:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:18:40 INFO - 'LOGNAME': 'cltbld', 06:18:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:40 INFO - 'MOZ_NO_REMOTE': '1', 06:18:40 INFO - 'NO_EM_RESTART': '1', 06:18:40 INFO - 'PAGER': '/bin/cat', 06:18:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:18:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:40 INFO - 'PWD': '/builds/slave/test', 06:18:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:18:40 INFO - 'SHELL': '/bin/bash', 06:18:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WXo3TGynn8/Listeners', 06:18:40 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 06:18:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:18:40 INFO - 'USER': 'cltbld', 06:18:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:18:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:18:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:40 INFO - 'XPC_FLAGS': '0x0', 06:18:40 INFO - 'XPC_SERVICE_NAME': '0', 06:18:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:18:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:18:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:18:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:18:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:18:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:18:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:18:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:18:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:18:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:18:40 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:18:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:18:40 INFO - Cleaning up... 06:18:40 INFO - Return code: 0 06:18:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:18:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103e0ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e154c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83c2db0f00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cb2d30>, '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 0x103b16db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103ca9b20>, '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.s0czvilzXl/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.WXo3TGynn8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:18:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:18:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:18:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s0czvilzXl/Render', 06:18:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:18:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:18:40 INFO - 'HOME': '/Users/cltbld', 06:18:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:18:40 INFO - 'LOGNAME': 'cltbld', 06:18:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:40 INFO - 'MOZ_NO_REMOTE': '1', 06:18:40 INFO - 'NO_EM_RESTART': '1', 06:18:40 INFO - 'PAGER': '/bin/cat', 06:18:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:18:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:40 INFO - 'PWD': '/builds/slave/test', 06:18:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:18:40 INFO - 'SHELL': '/bin/bash', 06:18:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WXo3TGynn8/Listeners', 06:18:40 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 06:18:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:18:40 INFO - 'USER': 'cltbld', 06:18:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:18:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:18:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:40 INFO - 'XPC_FLAGS': '0x0', 06:18:40 INFO - 'XPC_SERVICE_NAME': '0', 06:18:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:18:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:40 INFO - Downloading/unpacking jsonschema 06:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:18:43 INFO - Downloading/unpacking functools32 (from jsonschema) 06:18:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:43 INFO - Downloading functools32-3.2.3-2.tar.gz 06:18:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:18:43 INFO - warning: no files found matching '*.txt' 06:18:43 INFO - no previously-included directories found matching 'build' 06:18:43 INFO - no previously-included directories found matching 'dist' 06:18:43 INFO - no previously-included directories found matching '.git*' 06:18:43 INFO - Installing collected packages: jsonschema, functools32 06:18:43 INFO - Running setup.py install for functools32 06:18:44 INFO - warning: no files found matching '*.txt' 06:18:44 INFO - no previously-included directories found matching 'build' 06:18:44 INFO - no previously-included directories found matching 'dist' 06:18:44 INFO - no previously-included directories found matching '.git*' 06:18:44 INFO - Successfully installed jsonschema functools32 06:18:44 INFO - Cleaning up... 06:18:44 INFO - Return code: 0 06:18:44 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:18: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')]} 06:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18: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')]} 06:18:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103e0ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e154c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83c2db0f00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cb2d30>, '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 0x103b16db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103ca9b20>, '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.s0czvilzXl/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.WXo3TGynn8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:18:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 06:18:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 06:18:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s0czvilzXl/Render', 06:18:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:18:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:18:44 INFO - 'HOME': '/Users/cltbld', 06:18:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:18:44 INFO - 'LOGNAME': 'cltbld', 06:18:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:44 INFO - 'MOZ_NO_REMOTE': '1', 06:18:44 INFO - 'NO_EM_RESTART': '1', 06:18:44 INFO - 'PAGER': '/bin/cat', 06:18:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:18:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:18:44 INFO - 'PWD': '/builds/slave/test', 06:18:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:18:44 INFO - 'SHELL': '/bin/bash', 06:18:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WXo3TGynn8/Listeners', 06:18:44 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 06:18:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:18:44 INFO - 'USER': 'cltbld', 06:18:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:18:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:18:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:44 INFO - 'XPC_FLAGS': '0x0', 06:18:44 INFO - 'XPC_SERVICE_NAME': '0', 06:18:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:18:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:44 INFO - Downloading/unpacking flake8 06:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:18:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:18:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:18:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:18:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:18:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:18:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:18:48 INFO - no previously-included directories found matching 'docs/_build' 06:18:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:18:48 INFO - Running setup.py install for pep8 06:18:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:18:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:18:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:18:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:18:48 INFO - no previously-included directories found matching 'docs/_build' 06:18:48 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:18:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:18:48 INFO - Cleaning up... 06:18:48 INFO - Return code: 0 06:18:48 INFO - Running post-action listener: _resource_record_post_action 06:18:48 INFO - Running post-action listener: _start_resource_monitoring 06:18:48 INFO - Starting resource monitoring. 06:18:48 INFO - ##### 06:18:48 INFO - ##### Running install step. 06:18:48 INFO - ##### 06:18:48 INFO - Running pre-action listener: _resource_record_pre_action 06:18:48 INFO - Running main action method: install 06:18:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:18:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:18:48 INFO - Reading from file tmpfile_stdout 06:18:48 INFO - Detecting whether we're running mozinstall >=1.0... 06:18:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:18:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:18:48 INFO - Reading from file tmpfile_stdout 06:18:48 INFO - Output received: 06:18:48 INFO - Usage: mozinstall [options] installer 06:18:48 INFO - Options: 06:18:48 INFO - -h, --help show this help message and exit 06:18:48 INFO - -d DEST, --destination=DEST 06:18:48 INFO - Directory to install application into. [default: 06:18:48 INFO - "/builds/slave/test"] 06:18:48 INFO - --app=APP Application being installed. [default: firefox] 06:18:48 INFO - mkdir: /builds/slave/test/build/application 06:18:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:18:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.mac.dmg --destination /builds/slave/test/build/application 06:19:11 INFO - Reading from file tmpfile_stdout 06:19:11 INFO - Output received: 06:19:11 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 06:19:11 INFO - Running post-action listener: _resource_record_post_action 06:19:11 INFO - ##### 06:19:11 INFO - ##### Running run-tests step. 06:19:11 INFO - ##### 06:19:11 INFO - Running pre-action listener: _resource_record_pre_action 06:19:11 INFO - Running main action method: run_tests 06:19:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:19:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:19:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:19:11 INFO - 2016-06-06 06:19:11.247 screenresolution[1648:7764] starting screenresolution argv=screenresolution get 06:19:11 INFO - 2016-06-06 06:19:11.250 screenresolution[1648:7764] Display 0: 1600x1200x32@60 06:19:11 INFO - 2016-06-06 06:19:11.256 screenresolution[1649:7767] starting screenresolution argv=screenresolution list 06:19:11 INFO - Available Modes on Display 0 06:19:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:19:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:19:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:19:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:19:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:19:11 INFO - Intel Iris: 06:19:11 INFO - Chipset Model: Intel Iris 06:19:11 INFO - Type: GPU 06:19:11 INFO - Bus: Built-In 06:19:11 INFO - VRAM (Dynamic, Max): 1536 MB 06:19:11 INFO - Vendor: Intel (0x8086) 06:19:11 INFO - Device ID: 0x0a2e 06:19:11 INFO - Revision ID: 0x0009 06:19:11 INFO - Displays: 06:19:11 INFO - Display: 06:19:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:19:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:19:11 INFO - Display Serial Number: 1600x1200 60 06:19:11 INFO - Main Display: Yes 06:19:11 INFO - Mirror: Off 06:19:11 INFO - Online: Yes 06:19:11 INFO - Rotation: Supported 06:19:11 INFO - Return code: 0 06:19:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:19:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:19:11 INFO - Python 2.7.3 06:19:11 INFO - Return code: 0 06:19:11 INFO - grabbing minidump binary from tooltool 06:19:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:19:11 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cb2d30>, '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 0x103b16db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103ca9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:19:11 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:19:11 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 06:19:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:19:11 INFO - Return code: 0 06:19:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:19:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:19:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:19:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:19:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:19:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:19:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:19:12 INFO - Return code: 0 06:19:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0354', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:19:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0354 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:19:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s0czvilzXl/Render', 06:19:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:19:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:19:12 INFO - 'HOME': '/Users/cltbld', 06:19:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:19:12 INFO - 'LOGNAME': 'cltbld', 06:19:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:19:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:19:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:12 INFO - 'MOZ_NO_REMOTE': '1', 06:19:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:19:12 INFO - 'NO_EM_RESTART': '1', 06:19:12 INFO - 'PAGER': '/bin/cat', 06:19:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:19:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:12 INFO - 'PWD': '/builds/slave/test', 06:19:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:19:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:19:12 INFO - 'SHELL': '/bin/bash', 06:19:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WXo3TGynn8/Listeners', 06:19:12 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 06:19:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:19:12 INFO - 'USER': 'cltbld', 06:19:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:19:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:19:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:12 INFO - 'XPC_FLAGS': '0x0', 06:19:12 INFO - 'XPC_SERVICE_NAME': '0', 06:19:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:19:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0354', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:19:12 INFO - mozversion application_buildid: 20160602140837 06:19:12 INFO - mozversion application_changeset: 6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea 06:19:12 INFO - mozversion application_display_name: Firefox 06:19:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:19:12 INFO - mozversion application_name: Firefox 06:19:12 INFO - mozversion application_remotingname: firefox 06:19:12 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 06:19:12 INFO - mozversion application_vendor: Mozilla 06:19:12 INFO - mozversion application_version: 47.0 06:19:12 INFO - mozversion platform_buildid: 20160602140837 06:19:12 INFO - mozversion platform_changeset: 6e2399cf03e2f260740f6a0fc3f1fd0bc53b78ea 06:19:12 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 06:19:12 INFO - mozversion platform_version: 47.0 06:19:12 INFO - using testdate: 1465219152 06:19:13 INFO - actual date: 1465219152 06:19:13 INFO - starting webserver on 'localhost:49276' 06:19:13 INFO - SUITE-START | Running 2 tests 06:19:13 INFO - TEST-START | dromaeo_css 06:19:13 INFO - operating with platform_type : mac_ 06:19:13 INFO - Initialising browser for dromaeo_css test... 06:19:13 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/tmpJEovV0/profile http://localhost:49276/getInfo.html) 06:19:15 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 06:19:15 INFO - PROCESS | 1667 | colorDepth:24 06:19:15 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 06:19:15 INFO - PROCESS | 1667 | __metrics 06:19:15 INFO - PROCESS | 1667 | 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:19:15 INFO - PROCESS | 1667 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:19:15 INFO - TEST-INFO | 1667: exit 0 06:19:15 INFO - Browser initialized. 06:19:15 INFO - Running cycle 1/1 for dromaeo_css test... 06:19:15 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/tmpJEovV0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:19:27 INFO - PROCESS | 1670 | RSS: Main: 157097984 06:19:27 INFO - PROCESS | 1670 | 06:20:18 INFO - PROCESS | 1670 | 1465219218469 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:22:28 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 06:22:29 INFO - PROCESS | 1670 | RSS: Main: 271499264 06:22:29 INFO - PROCESS | 1670 | 06:25:32 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 06:25:32 INFO - PROCESS | 1670 | RSS: Main: 290271232 06:25:32 INFO - PROCESS | 1670 | 06:28:34 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 06:28:35 INFO - PROCESS | 1670 | RSS: Main: 297979904 06:28:35 INFO - PROCESS | 1670 | 06:31:37 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 06:31:37 INFO - PROCESS | 1670 | RSS: Main: 255217664 06:31:37 INFO - PROCESS | 1670 | 06:34:40 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 06:34:41 INFO - PROCESS | 1670 | RSS: Main: 255102976 06:34:41 INFO - PROCESS | 1670 | 06:37:43 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 06:37:44 INFO - PROCESS | 1670 | RSS: Main: 304283648 06:37:44 INFO - PROCESS | 1670 | 06:37:44 INFO - PROCESS | 1670 | __start_tp_report 06:37:44 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 06:37:44 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 06:37:44 INFO - PROCESS | 1670 | |i|pagename|runs| 06:37:44 INFO - PROCESS | 1670 | |0;dojo.html;3572.8213589320535;3639.3085313790393;3643.3624115779717;3653.689436397906;3716.7769933803957;5897.616654917433;5913.970430147849;5914.526837852972;5925.31858836234;5965.343812180657;5881.588288819784;5926.140709597106;5943;5954.285485741706;5956.791512297071;5182.455842136578;5267.657602255851;5298.947010529903;5338.466153384669;5382.138857782756;5378.058839703056;5400.972995135019;5405.486478784509;5411.188321751749;5432.538234250093;5326.201069839516;5362.249285100089;5389.164679474668;5394.433584473632;5403.7027963462;5379.569634429236;5381.4349493303225;5406.675599464025;5410.675359478444;5478.123500239983;5173.146430838907;5347.1177255752755;5354.330708661418;5354.384245811742;5364.624476286662;5764.913526297109;5784;5808.3030036395485;5837.50381217597;5867.559933005042;6149.600275982047;6270.811875643738;6286.559940804145;6288.465480434169;6289.748410063592;6195.1946246988055;6243.157173781572;6259.937400625981;6277.811665650038;6328;6064.454199122056;6098.14625952367;6116.755329786848;6116.877662446726;6124.554539337585;6275.3724627537795;6358.395952384516;6399.520035997226;6462.030695395634;6473.093766872642;6203.96898015507;6305.905411418832;6321.778737744157;6330.8417289567205;6337.904931426032;6298.905516417258;6306.432421082125;6316.399942005502;6318.147050148263;6349.238091429058;6243.282022567372;6252.531060170505;6282.528810339243;6333.461655759312;6371.55399122057;6329.620222786648;6331.715072821734;6341;6350.968245158745;6364.236291645032;5054.267131265946;5086.643934924594;5087.211482220262;5090.949090509048;5110.897782044412;4427.933580996288;4460.397846290709;4573.611243044312;4612.584867361954;4616.376789133424;6114.753609057711;6117.341459150268;6130.877382452326;6132.233136608343;6140.3552626974415;6297.811065668037;6318.083877837687;6322.936770632235;6324.3991820776955;6336.334684858116;5901.911471327933;5964.343922168558;5985.431384018511;6087.786927457518;6089.147519347295;5542;5549.861253468614;5555.472230138131;5566.443355664401;5573.60984731073;5064.645474816801;5340.359156901197;6488.026795980641;6488.15653964991;6491.610503369813;6254.343293954252;6261.5616906816085;6315.926292530373;6320.08358787964;6321.778737744157;5467.699276539669;6401.22496258995;6472.741090356521;6473.514486413444;6532;6287.905681414691;6335.524835637253;6338.714757835816;6343.651099189589;6359.459445947146;6186.257649081959;6225.968870155621;6226.252849657889;6280.7487700491465;6290.49676025926;5225.7387130642555;6182.814515564541;6253.1245625613365;6260.499160067275;6294.024426213944;6265.216847894013;6275.52933529978;6289.654069026247;6292.150559674568;6316.526260530571;6021.307549631673;6107.480864126599;6116.518381401602;6175.814725558241;6181.443670069715;6280.528960328085;6291.245050593958;6311.526635502264;6311.936880631135;6318.304986451579;6177.7837775677635;6213.502919766317;6220.7511699533325;6236.501079913687;6238.844028899314 06:37:44 INFO - PROCESS | 1670 | |1;ext.html;440.73555866480115;560.5039540007092;604.5435696049482;608.2488127162953;644.4457766320965;32068.67931320689;32505.837470812672;32527.349453010927;32644.836775816148;32684.836575817146;43994.12011759763;44347.77826110865;44420.77789611056;44421.7778911105;44474.77762611183;9783.461909594987;9997.650082247123;10007.799844003115;10024.348417352885;10036.949815250913;9831.557579908922;9999.600015999351;10003.549840257207;10013.94993025034;10014.998500149999;9940.254480913924;10127;10162;10175.287729858914;10179.694609161737;10044.648437304695;10132.898671013269;10134.493275336277;10140.442275674797;10152.593896244141;9788.461634610094;9913.454759988197;9919.851202231972;9928.751781205456;9945.055219754111;42871.57128428707;43143.35284970728;43174.56825431737;43185.92035199114;43451;2812.142296599536;3217.9678203217904;3360.31113621707;3419.1623052352084;3798.2593394288124;30055.133363135108;30105.096847094403;30280.242993925327;30280.394392112034;30353.93761218347;2747;2764.405652784661;2772.7643150332246;2804.705505921869;2818.6476690413697;491358;500651.4967425176;501177;501290;502155;50889.982200355786;77856.61071694718;78886.6055669718;78913.2108678906;78949;51611.22583161256;51786.22320665193;51930.961380772176;51940;51976;17612.647747044986;17637.118144092743;17817.732734009;17823.821761782474;17838;13976.51082212138;14121.152730836182;14127.081739687093;14133.71732565343;14152.787708184385;12995.870041299466;16131.435399760952;16178.919105404397;16217.270222840001;16227.269772860249;6849.691763870638;6972.721091156297;6974.302569743087;6995.825104372431;7019.9112390548;1003.2776400991274;1024.5850430575629;1056.9312994655322;1089.515165751249;1123.3879383085298;30053.69946300509;30680.38639227203;30720;31291.061268161535;31321.06036818899;1122.2817396866012;1144.742432952579;1158.8145896656495;1218.342095268545;1227.5703503773607;15712.371505139896;15753;15849;16001.519954401387;16044.839551604568;527982;542660.286698564;546070;548491;548832;51216.487835121174;62590.374096259366;63150;63235.05147422793;63310.68344658247;1378.951736689211;1483.1546018769197;1498.1161114942236;1526.4428483603626;1532.1573134776052;29647.85176074192;30793.69206307998;31233.219169520944;31367.21581960469;31660;51430.74284628553;51711;51918.48081519137;51920.480795191565;51998.70003249949;362519;368972;369410;369566;370125;30842.691573084878;34481.96554103381;35153;36060.27879442449;36146.73486427962;42971.78514107409;43178;43965;44188;44677.77661111674;34585.30829383348;35483.46774798328;36519;36690.63309366872;37011.81494092512;35591.82204088963;35702.642973569935;35794.64205357913;36627.816860915525;36667.63332366642;36635;36753.81623091974;39447.60552394554;39981.80009099936;40790.79604601958;31352.21619459532;33049.669503304656;33252.83373583117;33445;33500.32999340048;25598.61602075933;26042.73957260403;26123.477530448905;26290.605640915783;26318.736812632396 06:37:44 INFO - PROCESS | 1670 | |2;jquery.html;371.9665230129288;372.7875111186624;379.56160634467165;383.02329060894726;388.23905145914006;13556.389962451689;20686.069126889288;21107.894460527714;21870.23454179104;21920.342389728296;19307.613847723038;22172.11311547536;22230.666540001912;22567.54864902701;22594;5700.429957004298;5889.263842019747;6030.457258846703;6057.969710151465;6063.484603808682;5725.971370143165;5903.380145084747;5914.201582786333;5919.585629005971;5921.88156236875;5523.088690366085;5901.17383566301;5905.261842269716;5907.911381329283;5910.320313163977;5315.697654074757;5743.282089738804;5807.448292412235;5860.912086318666;5895.528357731371;5153.484651534854;5154.871128221787;5158.92261616076;5166.147585648364;5182.637215394924;13092.149010314395;13661.316934153252;13679.658008549766;13680.65798355039;13682.179069255877;2242.990654205598;2474.3319303788057;2630.447606002742;2836.262571731344;2852.115844088339;9911.950440247825;10030.548625311878;10120.038596333337;10125.240606954509;10404.739881502946;1668.099226417733;1694.2545280076727;1712.332190445727;1762.409592786418;1778.4220128458303;87919.56040219821;99893;107871;108142.99999999921;111479.88520114857;11385.829212561819;11495.080393568494;11532.654020379403;11549.942250288863;11655.125865560118;14400.927995359956;14450.494232702014;14457.85542144565;14497.855021449861;14507.782383264259;8910.955445222862;8918.598663060178;8951.283897288202;8956;9096.81806363869;9194.954025229965;9214.401063930824;9224.815503689888;9300.720978370524;9336.852523919537;4543.863684089482;4544;4565.109803588269;4567.862964111082;4590.563896429834;1860.9720854187199;1914.2197756086694;1936.4190742777391;1948.6882098864114;1951.7267582538457;809.4859764049871;891.6567121658209;917.6512925088557;942.4816351007056;963.3882484622316;19611.117499712545;20172.79827201709;20402.69395959062;20444.897775511028;20575.897120514303;973.7468258252763;1002.7142264454595;1036.1555332404066;1045.8849526552074;1065.6003998500562;11000.559977600966;11394.772104558027;11403.372814495282;11423.314601123793;11427.428628568538;661664.6916765482;662979;677786;679914;679977;80640;110639;111391;119715;127073.36463317809;1009.6819501856892;1067.781104873499;1118.552578968403;1127.9266847654876;1133.8604702274326;13239.669008274484;14939.925300373428;18153.909230453763;19224.423267302005;19303.613927721646;48663.27005094856;50360.74819626025;50734.49265507298;52036.69908252324;52253.47746522486;72844.54310913858;73209.6339518299;73337.26662733304;74675;75274.87087693579;7801.687932482864;8213.3429325655;8231.876521852297;8285.792855178668;8362.414630975773;9505.334626576074;10615.469226538797;13284.667883302995;13288.933555332162;13656.180629162282;11527.711807204552;11633.476493557979;11697.883021169679;11772.52909883595;11952.58165964187;11151.275167114112;11400.543978241109;11421.543138274375;11668.88331116712;11793.29240245588;11697.824532632187;11797.88202117968;12142.696432588902;12187.26876387384;12190.51237950472;8165.387595930448;8214.424990250625;8274.958625206835;8372.623231954698;8543.316534677087;10655.733606659896;11214.887851121384;11227.38249396291;11611.593594224161;11856.17006809515 06:37:44 INFO - PROCESS | 1670 | |3;mootools.html;1438.7985682004519;1514.7652113922345;1670.7076261654208;1976.1107501624272;2140.3899888531773;8330.20863018014;8913.732588022362;9080;9101.544922753868;9111.134442227994;8846.911530884689;9103.271738260939;9106.362554621179;9107.908920910806;9110.635574577025;2529.5826188678893;2550.923472295834;2559.872006399682;2560.4879024195234;2564.871456559117;2498.850068995857;2569.8329608575477;2574.639550462927;2578.6776652918384;2578.6905571331467;2078.864873783207;2545.2109845947816;2559;2573.562494375961;2576.3945472813875;2529.190658989124;2547.0448581781834;2562.9102981395654;2574.17626359565;2577.1237779155176;2525.065725681491;2554.4124851284123;2560.423904621464;2565.191964531167;2576.1112416216374;9091.81816363669;9140.45157290558;9154.084591540859;9169.541522923828;9173.220276276525;5546.972265138689;5745.339285982123;5754.97122514389;5755.4244575542525;5756.251687280626;3693.445983102529;3750.7562008469636;3812.618738126193;3834.2906562286066;3835.060410199491;1053.525913338993;1075.6934273732027;1076.2842709598108;1091.307020042279;1111.2998810749257;12550.372481375894;12580.182288151242;12583.559575414909;12598.874011259953;12606.810897836449;4980.12847751642;5004.424491183488;5058.671186372874;5066.442691303953;5103.744812759347;10425;10436.37381757097;10436.895631043744;10448.05967462932;10449.634262800766;5662.858428539237;5664.150377443417;5717.799877004285;5717.971410142923;5724.084146536534;4616.815327386867;4703.0123674028155;4719.2921061841;4773.570378665937;5170.663906846118;2948.3513627002026;3265.6734326567152;3787.4886890270013;3892.4161375793856;4073.9388909166387;1344.536135033412;1352.9255890926092;1360.857110003455;1366.0847232354347;1366.1393322206945;1439.8272207335187;1443.8483959184343;1449.1160392160773;1454.647038576071;1473.3885437543513;8507.319414446829;8559.614817333235;8569.314454843598;8570.914290857012;8593.140685931481;1239.1821397877359;1252.1485389934749;1253.7367152897993;1274.6877015131352;1277.3932382118605;6358.268799088071;6390.744370225232;6472.190976127984;6477.514186436036;6498.707558159894;10830.458477076114;10974.012338889539;11000.449977501094;11158.274712143684;11188.776224475465;10975.615853445252;11036.668899933014;11171.944140279247;11174.27367221128;11182.32906025641;8276.8344633107;8486.19381158789;8512.531810750468;8538;8626.051134375213;8130.87803682957;8145.592720364077;8198.180181981992;8201.507909525448;8218.21926916942;9671;9721.416714997124;9910.851337230091;9941.950290248502;10128.493575321352;10036.598536058476;10131.696049118538;10150.187984961038;10156.933521980085;10254.53854576531;6944.756933507303;7693.115291741297;7705.768826935201;7772.339351154989;7777.688892444239;7932.286094251545;8329.750107496784;8537.274331681876;8562.957185214284;8595.968483781986;7482.850342993219;7526.887096693445;7581.924180758122;7669.194734553015;7692.153863075169;7343.926560734538;7368.115826100902;7449.6275186241555;7474.887876681963;7485.625718714152;7866.960665196638;7958.920410795818;7971.920280797118;7972.681092756225;7977.880331794911;7131.928680713334;7143.214246432992;7228.674709638184;7238.312360325761;7238.746643867439;7293.890591641023;7376.188619251985;7386.446016548673;7386.96306518464;7389.96305018493 06:37:44 INFO - PROCESS | 1670 | |4;prototype.html;278.2681547529996;339.0709456090312;339.30611898667223;340.94544872820353;343.81262212094407;5754.280714910641;5756.568257380697;6651.401373876351;6716.932830671692;6736.191657001154;6603.768868089618;6618.635975021371;6635.170603674541;6651.733930642768;6669.833254168649;4779.713217206961;4892.975535122319;4894.853154405374;4913.115639184945;4981.178105612578;4045.352743561031;4885.853424397274;4911.950880491203;4916.237983112624;5002.52476014778;4917.72952487613;4918.336024636664;4929.260610908356;4935.679180853251;4943.307936888838;4922.286268491067;4943.505649435064;4948.480409556981;4949.529794669501;4951.529604687567;4095.201435720036;4161.188568229197;4242.893927651833;4248.065425606362;4249.957500424987;5075.51782580658;5385.0037743017665;5424.942136283426;6048.637081775108;6111.54163437744;5820.068788993741;5823.068309070571;5828.795992140254;5831.708414579254;5839.299284085894;7076.964615176943;7088.574685518885;7096;7102.289771022908;7106.893396599055;4761.785719642625;4763.428388593391;4765.809367625291;4766.571008609207;4768.666193366465;5848;7582.658780354842;7639.350655194371;7657.578833164173;7662.770116896446;4676.462206846256;4753.33453316536;4762.333273341735;4762.78567464458;4777.187878060738;4835.685680430761;4848.660593758403;4848.660593758474;4851.054044461367;4860.684055536379;5746.224259724883;5749.3963133871175;5751.194832723422;5758.107493338539;5762.4525670061275;5627.662340259598;5874.500667443315;5921.822345329647;7256.310650488195;7273.563586184846;1655.4785242648527;1664.9084300363354;1680.252287731972;1683.040666819901;1686.1232159277108;1044.102072217892;1049.4962418039383;1065.3554599467366;1068.4817863336275;1070.5129166229347;6657.434118100015;6795.286494917962;6797.524173307821;6804.55770374924;6804.863902721918;7386.0767404074495;7443.627818609048;7457.888131678029;7468.887966680504;7603.4297427693145;6871.484638652121;6884.208316043619;6902.896456553156;6915.170179578483;6921.792346229621;3958.3666613342302;4010.7393019453643;4013.3578627419474;4016.2971479990883;4022.9798851005557;7651.732189373345;7904.644291006918;7906.288434040964;7958.2041795821115;7962.601869906482;7753.340966017839;7792.493487923267;7796.181400952932;7800.985871836625;7817.218278172251;5834.562407819346;7659.234076592407;7888;7895.644695988694;7905.604719764104;6091.4822240108315;7535.133459651991;7546.320831125225;7546.849063018819;7558.1686014539455;7091.82270443243;7360.96319518399;7399.926000739923;7409.222031686595;7434.070741157356;6301.590396624205;7843.333316668147;7851.016613686763;7863.449558530848;7929.286364227017;4748.240281554935;4754.809807607657;4762.857114286577;4774.880627984328;4780.737059461624;7468.439867009887;7492.662830172546;7499.437542184467;7518.173000969999;7522.736704215326;6907.205671347659;7228.168760592599;7235.963820180866;7237.855242895007;7274.381677557467;7148.177959534512;7188.8921666174;7191.71233150689;7205.423566114803;7207.639618018973;7031.191412987368;7037.401820845285;7037.964810175917;7041.155061392666;7043.788686339418;5762.510186634183;6946.409555187865;7191.712331506681;7195.136583609791;7208.207097219407;5573.795067835929;6361.491080713625;7056.647167641495;7071.646417679199;7078.398336141486 06:37:44 INFO - PROCESS | 1670 | |5;yui.html;716.6237725194272;749.8800191969286;767.8656235158846;782.4835608498393;809.7732634862239;15408.30662620182;15505.898820235956;15719.37122515098;15719.37122515101;15748.291326890288;14620.780688289684;14696.706065878676;14719.852801471981;14731.48439804607;14735.778963315559;799.5282783157936;809.2393150438598;813.5728742410223;944.409743910058;965.884093908732;808.2806302390877;811.5333683132193;956.5121787888157;984.7882705218377;994.0159242350094;1033.5245786938017;1036.2797855490437;1036.8289232276666;1037.6108959140322;1041.1930753665895;1021.2851004297022;1021.5556233038652;1022.2435397805607;1022.5296363672719;1022.9897701022969;617.102116420607;748.5957582905224;764.2281295891135;764.3655765714444;766.6665000724703;15426.691466170725;15489.5353139406;15530.223488825513;15531.223438828127;15536.223188840513;13189.868101319056;13225.140365876186;13520.797188042186;13533.255670938095;13611.795823062663;10466.947665261625;10548.156147508182;10745.462726863625;10946.39794811285;11122;3658.378075727133;3708.9443658345144;3724.5344331958504;3737.177820879402;3741.8877433677035;69157.65421172912;70128.29871701269;70215.64892175558;70697.64651176763;70702.58594828074;9245.583948722324;9768.36505627132;10045.648402305884;10075.899241007643;10137.189024877993;22063.227787027376;22242.88878555597;22262;22468.88765556162;22527.873606319947;7746.806329841799;7776.377889768805;8029.397795165386;8033.839323213503;8186.672533098728;4073.103917138284;4152.875413737593;4206.158768246363;4247.3628955656895;4402.955970440319;3700.2784457031157;3742.8502859885843;3762.3039737648623;3776.5090538229856;3779.962200378016;668.4919461209515;670.8524124692657;672.0691841799144;683.7846078485261;686.7733647896182;561.7556362982034;593.7817031688174;611.3794498583941;612.7640858269598;626.5739297277895;8140.430169888169;8313.763731889894;8373.037100733372;8447.413354102344;8462.026866910384;535.234614501267;544.9754761035763;582.7843697831829;585.7364186116265;618.0852338538988;3805.257974694963;3879.8254078566533;3893.3381325174787;4059.6752259819145;4151.958480415157;92762;95314;96141.0385896146;96331.51834240784;96564.51717741367;79475.60262198652;80890;82932.58533707293;83807.5809620948;84036.57981710053;74380.04959603219;74459;74979.62510187524;75364;75614.62192689002;6703.66481675924;7502.662380192795;7568.886466702894;7605.961970190335;7701.730439434593;51323;52356;52800;53149.7342513285;53609.19586206132;46221;70777.23056923618;71995;72249.27750722636;72845;9654.227661787181;9783.045300141386;9970;10021.899781002097;10458.006489383497;10783.95638084883;10966.561337546409;11072;11266.83099753488;11360.829587556029;10463.581456741646;10529.78940421172;10658.73353166177;11418.486168122288;11477.942610286895;10386.636467723594;10426.947865260625;10499.790004200026;10687.625933092304;11413.714657133638;10186.643467478603;10212.387256764618;10249.282550221413;10357.9482102589;11075.224734268524;8809.163129502687;9104.408213466368;9138.497382644018;9169.77075573116;9463.148316651259;8691.782705432415;8889.354526496516;8937.150970657776;8991.55042247898;9033.232175264913 06:37:44 INFO - PROCESS | 1670 | __end_tp_report 06:37:44 INFO - PROCESS | 1670 | __start_cc_report 06:37:44 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,1011 06:37:44 INFO - PROCESS | 1670 | __end_cc_report 06:37:44 INFO - PROCESS | 1670 | __startTimestamp1465220264029__endTimestamp 06:37:44 INFO - PROCESS | 1670 | 06:37:44 INFO - PROCESS | 1670 | ------- Summary: start ------- 06:37:44 INFO - PROCESS | 1670 | Number of tests: 6 06:37:44 INFO - PROCESS | 1670 | 06:37:44 INFO - PROCESS | 1670 | [#0] dojo.html Cycles:165 Average:5882.18 Median:6149.60 stddev:617.95 (10.0%) stddev-sans-first:592.70 06:37:44 INFO - PROCESS | 1670 | Values: 3572.8 3639.3 3643.4 3653.7 3716.8 5897.6 5914.0 5914.5 5925.3 5965.3 5881.6 5926.1 5943.0 5954.3 5956.8 5182.5 5267.7 5298.9 5338.5 5382.1 5378.1 5401.0 5405.5 5411.2 5432.5 5326.2 5362.2 5389.2 5394.4 5403.7 5379.6 5381.4 5406.7 5410.7 5478.1 5173.1 5347.1 5354.3 5354.4 5364.6 5764.9 5784.0 5808.3 5837.5 5867.6 6149.6 6270.8 6286.6 6288.5 6289.7 6195.2 6243.2 6259.9 6277.8 6328.0 6064.5 6098.1 6116.8 6116.9 6124.6 6275.4 6358.4 6399.5 6462.0 6473.1 6204.0 6305.9 6321.8 6330.8 6337.9 6298.9 6306.4 6316.4 6318.1 6349.2 6243.3 6252.5 6282.5 6333.5 6371.6 6329.6 6331.7 6341.0 6351.0 6364.2 5054.3 5086.6 5087.2 5090.9 5110.9 4427.9 4460.4 4573.6 4612.6 4616.4 6114.8 6117.3 6130.9 6132.2 6140.4 6297.8 6318.1 6322.9 6324.4 6336.3 5901.9 5964.3 5985.4 6087.8 6089.1 5542.0 5549.9 5555.5 5566.4 5573.6 5064.6 5340.4 6488.0 6488.2 6491.6 6254.3 6261.6 6315.9 6320.1 6321.8 5467.7 6401.2 6472.7 6473.5 6532.0 6287.9 6335.5 6338.7 6343.7 6359.5 6186.3 6226.0 6226.3 6280.7 6290.5 5225.7 6182.8 6253.1 6260.5 6294.0 6265.2 6275.5 6289.7 6292.2 6316.5 6021.3 6107.5 6116.5 6175.8 6181.4 6280.5 6291.2 6311.5 6311.9 6318.3 6177.8 6213.5 6220.8 6236.5 6238.8 06:37:44 INFO - PROCESS | 1670 | 06:37:44 INFO - PROCESS | 1670 | [#1] ext.html Cycles:180 Average:62181.61 Median:34533.64 stddev:126533.37 (366.4%) stddev-sans-first:126803.42 06:37:44 INFO - PROCESS | 1670 | Values: 440.7 560.5 604.5 608.2 644.4 32068.7 32505.8 32527.3 32644.8 32684.8 43994.1 44347.8 44420.8 44421.8 44474.8 9783.5 9997.7 10007.8 10024.3 10036.9 9831.6 9999.6 10003.5 10013.9 10015.0 9940.3 10127.0 10162.0 10175.3 10179.7 10044.6 10132.9 10134.5 10140.4 10152.6 9788.5 9913.5 9919.9 9928.8 9945.1 42871.6 43143.4 43174.6 43185.9 43451.0 2812.1 3218.0 3360.3 3419.2 3798.3 30055.1 30105.1 30280.2 30280.4 30353.9 2747.0 2764.4 2772.8 2804.7 2818.6 491358.0 500651.5 501177.0 501290.0 502155.0 50890.0 77856.6 78886.6 78913.2 78949.0 51611.2 51786.2 51931.0 51940.0 51976.0 17612.6 17637.1 17817.7 17823.8 17838.0 13976.5 14121.2 14127.1 14133.7 14152.8 12995.9 16131.4 16178.9 16217.3 16227.3 6849.7 6972.7 6974.3 6995.8 7019.9 1003.3 1024.6 1056.9 1089.5 1123.4 30053.7 30680.4 30720.0 31291.1 31321.1 1122.3 1144.7 1158.8 1218.3 1227.6 15712.4 15753.0 15849.0 16001.5 16044.8 527982.0 542660.3 546070.0 548491.0 548832.0 51216.5 62590.4 63150.0 63235.1 63310.7 1379.0 1483.2 1498.1 1526.4 1532.2 29647.9 30793.7 31233.2 31367.2 31660.0 51430.7 51711.0 51918.5 51920.5 51998.7 362519.0 368972.0 369410.0 369566.0 370125.0 30842.7 34482.0 35153.0 36060.3 36146.7 42971.8 43178.0 43965.0 44188.0 44677.8 34585.3 35483.5 36519.0 36690.6 37011.8 35591.8 35702.6 35794.6 36627.8 36667.6 36635.0 36753.8 39447.6 39981.8 40790.8 31352.2 33049.7 33252.8 33445.0 33500.3 25598.6 26042.7 26123.5 26290.6 26318.7 06:37:44 INFO - PROCESS | 1670 | 06:37:44 INFO - PROCESS | 1670 | [#2] jquery.html Cycles:180 Average:35721.35 Median:22201.39 stddev:110980.13 (499.9%) stddev-sans-first:111259.72 06:37:44 INFO - PROCESS | 1670 | Values: 372.0 372.8 379.6 383.0 388.2 13556.4 20686.1 21107.9 21870.2 21920.3 19307.6 22172.1 22230.7 22567.5 22594.0 5700.4 5889.3 6030.5 6058.0 6063.5 5726.0 5903.4 5914.2 5919.6 5921.9 5523.1 5901.2 5905.3 5907.9 5910.3 5315.7 5743.3 5807.4 5860.9 5895.5 5153.5 5154.9 5158.9 5166.1 5182.6 13092.1 13661.3 13679.7 13680.7 13682.2 2243.0 2474.3 2630.4 2836.3 2852.1 9912.0 10030.5 10120.0 10125.2 10404.7 1668.1 1694.3 1712.3 1762.4 1778.4 87919.6 99893.0 107871.0 108143.0 111479.9 11385.8 11495.1 11532.7 11549.9 11655.1 14400.9 14450.5 14457.9 14497.9 14507.8 8911.0 8918.6 8951.3 8956.0 9096.8 9195.0 9214.4 9224.8 9300.7 9336.9 4543.9 4544.0 4565.1 4567.9 4590.6 1861.0 1914.2 1936.4 1948.7 1951.7 809.5 891.7 917.7 942.5 963.4 19611.1 20172.8 20402.7 20444.9 20575.9 973.7 1002.7 1036.2 1045.9 1065.6 11000.6 11394.8 11403.4 11423.3 11427.4 661664.7 662979.0 677786.0 679914.0 679977.0 80640.0 110639.0 111391.0 119715.0 127073.4 1009.7 1067.8 1118.6 1127.9 1133.9 13239.7 14939.9 18153.9 19224.4 19303.6 48663.3 50360.7 50734.5 52036.7 52253.5 72844.5 73209.6 73337.3 74675.0 75274.9 7801.7 8213.3 8231.9 8285.8 8362.4 9505.3 10615.5 13284.7 13288.9 13656.2 11527.7 11633.5 11697.9 11772.5 11952.6 11151.3 11400.5 11421.5 11668.9 11793.3 11697.8 11797.9 12142.7 12187.3 12190.5 8165.4 8214.4 8275.0 8372.6 8543.3 10655.7 11214.9 11227.4 11611.6 11856.2 06:37:44 INFO - PROCESS | 1670 | 06:37:44 INFO - PROCESS | 1670 | [#3] mootools.html Cycles:180 Average:6268.78 Median:4992.28 stddev:3300.99 (66.1%) stddev-sans-first:3290.29 06:37:44 INFO - PROCESS | 1670 | Values: 1438.8 1514.8 1670.7 1976.1 2140.4 8330.2 8913.7 9080.0 9101.5 9111.1 8846.9 9103.3 9106.4 9107.9 9110.6 2529.6 2550.9 2559.9 2560.5 2564.9 2498.9 2569.8 2574.6 2578.7 2578.7 2078.9 2545.2 2559.0 2573.6 2576.4 2529.2 2547.0 2562.9 2574.2 2577.1 2525.1 2554.4 2560.4 2565.2 2576.1 9091.8 9140.5 9154.1 9169.5 9173.2 5547.0 5745.3 5755.0 5755.4 5756.3 3693.4 3750.8 3812.6 3834.3 3835.1 1053.5 1075.7 1076.3 1091.3 1111.3 12550.4 12580.2 12583.6 12598.9 12606.8 4980.1 5004.4 5058.7 5066.4 5103.7 10425.0 10436.4 10436.9 10448.1 10449.6 5662.9 5664.2 5717.8 5718.0 5724.1 4616.8 4703.0 4719.3 4773.6 5170.7 2948.4 3265.7 3787.5 3892.4 4073.9 1344.5 1352.9 1360.9 1366.1 1366.1 1439.8 1443.8 1449.1 1454.6 1473.4 8507.3 8559.6 8569.3 8570.9 8593.1 1239.2 1252.1 1253.7 1274.7 1277.4 6358.3 6390.7 6472.2 6477.5 6498.7 10830.5 10974.0 11000.4 11158.3 11188.8 10975.6 11036.7 11171.9 11174.3 11182.3 8276.8 8486.2 8512.5 8538.0 8626.1 8130.9 8145.6 8198.2 8201.5 8218.2 9671.0 9721.4 9910.9 9942.0 10128.5 10036.6 10131.7 10150.2 10156.9 10254.5 6944.8 7693.1 7705.8 7772.3 7777.7 7932.3 8329.8 8537.3 8563.0 8596.0 7482.9 7526.9 7581.9 7669.2 7692.2 7343.9 7368.1 7449.6 7474.9 7485.6 7867.0 7958.9 7971.9 7972.7 7977.9 7131.9 7143.2 7228.7 7238.3 7238.7 7293.9 7376.2 7386.4 7387.0 7390.0 06:37:44 INFO - PROCESS | 1670 | 06:37:44 INFO - PROCESS | 1670 | [#4] prototype.html Cycles:180 Average:5822.61 Median:6331.54 stddev:1870.04 (29.5%) stddev-sans-first:1828.40 06:37:44 INFO - PROCESS | 1670 | Values: 278.3 339.1 339.3 340.9 343.8 5754.3 5756.6 6651.4 6716.9 6736.2 6603.8 6618.6 6635.2 6651.7 6669.8 4779.7 4893.0 4894.9 4913.1 4981.2 4045.4 4885.9 4912.0 4916.2 5002.5 4917.7 4918.3 4929.3 4935.7 4943.3 4922.3 4943.5 4948.5 4949.5 4951.5 4095.2 4161.2 4242.9 4248.1 4250.0 5075.5 5385.0 5424.9 6048.6 6111.5 5820.1 5823.1 5828.8 5831.7 5839.3 7077.0 7088.6 7096.0 7102.3 7106.9 4761.8 4763.4 4765.8 4766.6 4768.7 5848.0 7582.7 7639.4 7657.6 7662.8 4676.5 4753.3 4762.3 4762.8 4777.2 4835.7 4848.7 4848.7 4851.1 4860.7 5746.2 5749.4 5751.2 5758.1 5762.5 5627.7 5874.5 5921.8 7256.3 7273.6 1655.5 1664.9 1680.3 1683.0 1686.1 1044.1 1049.5 1065.4 1068.5 1070.5 6657.4 6795.3 6797.5 6804.6 6804.9 7386.1 7443.6 7457.9 7468.9 7603.4 6871.5 6884.2 6902.9 6915.2 6921.8 3958.4 4010.7 4013.4 4016.3 4023.0 7651.7 7904.6 7906.3 7958.2 7962.6 7753.3 7792.5 7796.2 7801.0 7817.2 5834.6 7659.2 7888.0 7895.6 7905.6 6091.5 7535.1 7546.3 7546.8 7558.2 7091.8 7361.0 7399.9 7409.2 7434.1 6301.6 7843.3 7851.0 7863.4 7929.3 4748.2 4754.8 4762.9 4774.9 4780.7 7468.4 7492.7 7499.4 7518.2 7522.7 6907.2 7228.2 7236.0 7237.9 7274.4 7148.2 7188.9 7191.7 7205.4 7207.6 7031.2 7037.4 7038.0 7041.2 7043.8 5762.5 6946.4 7191.7 7195.1 7208.2 5573.8 6361.5 7056.6 7071.6 7078.4 06:37:44 INFO - PROCESS | 1670 | 06:37:44 INFO - PROCESS | 1670 | [#5] yui.html Cycles:180 Average:18391.57 Median:27072.22 stddev:25977.00 (96.0%) stddev-sans-first:26015.97 06:37:44 INFO - PROCESS | 1670 | Values: 716.6 749.9 767.9 782.5 809.8 15408.3 15505.9 15719.4 15719.4 15748.3 14620.8 14696.7 14719.9 14731.5 14735.8 799.5 809.2 813.6 944.4 965.9 808.3 811.5 956.5 984.8 994.0 1033.5 1036.3 1036.8 1037.6 1041.2 1021.3 1021.6 1022.2 1022.5 1023.0 617.1 748.6 764.2 764.4 766.7 15426.7 15489.5 15530.2 15531.2 15536.2 13189.9 13225.1 13520.8 13533.3 13611.8 10466.9 10548.2 10745.5 10946.4 11122.0 3658.4 3708.9 3724.5 3737.2 3741.9 69157.7 70128.3 70215.6 70697.6 70702.6 9245.6 9768.4 10045.6 10075.9 10137.2 22063.2 22242.9 22262.0 22468.9 22527.9 7746.8 7776.4 8029.4 8033.8 8186.7 4073.1 4152.9 4206.2 4247.4 4403.0 3700.3 3742.9 3762.3 3776.5 3780.0 668.5 670.9 672.1 683.8 686.8 561.8 593.8 611.4 612.8 626.6 8140.4 8313.8 8373.0 8447.4 8462.0 535.2 545.0 582.8 585.7 618.1 3805.3 3879.8 3893.3 4059.7 4152.0 92762.0 95314.0 96141.0 96331.5 96564.5 79475.6 80890.0 82932.6 83807.6 84036.6 74380.0 74459.0 74979.6 75364.0 75614.6 6703.7 7502.7 7568.9 7606.0 7701.7 51323.0 52356.0 52800.0 53149.7 53609.2 46221.0 70777.2 71995.0 72249.3 72845.0 9654.2 9783.0 9970.0 10021.9 10458.0 10784.0 10966.6 11072.0 11266.8 11360.8 10463.6 10529.8 10658.7 11418.5 11477.9 10386.6 10426.9 10499.8 10687.6 11413.7 10186.6 10212.4 10249.3 10357.9 11075.2 8809.2 9104.4 9138.5 9169.8 9463.1 8691.8 8889.4 8937.2 8991.6 9033.2 06:37:44 INFO - PROCESS | 1670 | -------- Summary: end -------- 06:37:44 INFO - PROCESS | 1670 | 06:37:44 INFO - TEST-INFO | 1670: exit 0 06:37:44 INFO - TEST-OK | dromaeo_css | took 1111532ms 06:37:44 INFO - TEST-START | kraken 06:37:44 INFO - operating with platform_type : mac_ 06:37:44 INFO - Initialising browser for kraken test... 06:37:44 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/tmpQeqlDR/profile http://localhost:49276/getInfo.html) 06:37:46 INFO - PROCESS | 1677 | __metrics Screen width/height:1600/1200 06:37:46 INFO - PROCESS | 1677 | colorDepth:24 06:37:46 INFO - PROCESS | 1677 | Browser inner width/height: 1024/689 06:37:46 INFO - PROCESS | 1677 | __metrics 06:37:46 INFO - PROCESS | 1677 | 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:37:46 INFO - PROCESS | 1677 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:37:47 INFO - TEST-INFO | 1677: exit 0 06:37:47 INFO - Browser initialized. 06:37:47 INFO - Running cycle 1/1 for kraken test... 06:37:47 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/tmpQeqlDR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:37:59 INFO - PROCESS | 1680 | RSS: Main: 156884992 06:37:59 INFO - PROCESS | 1680 | 06:38:02 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 06:38:02 INFO - PROCESS | 1680 | RSS: Main: 218525696 06:38:02 INFO - PROCESS | 1680 | 06:38:05 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 06:38:05 INFO - PROCESS | 1680 | RSS: Main: 228966400 06:38:05 INFO - PROCESS | 1680 | 06:38:08 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 06:38:09 INFO - PROCESS | 1680 | RSS: Main: 219463680 06:38:09 INFO - PROCESS | 1680 | 06:38:11 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 06:38:12 INFO - PROCESS | 1680 | RSS: Main: 221622272 06:38:12 INFO - PROCESS | 1680 | 06:38:14 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:38:14 INFO - PROCESS | 1680 | RSS: Main: 221487104 06:38:14 INFO - PROCESS | 1680 | 06:38:17 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 06:38:18 INFO - PROCESS | 1680 | RSS: Main: 221335552 06:38:18 INFO - PROCESS | 1680 | 06:38:20 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 06:38:21 INFO - PROCESS | 1680 | RSS: Main: 221773824 06:38:21 INFO - PROCESS | 1680 | 06:38:24 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 06:38:24 INFO - PROCESS | 1680 | RSS: Main: 221863936 06:38:24 INFO - PROCESS | 1680 | 06:38:26 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:38:26 INFO - PROCESS | 1680 | RSS: Main: 255815680 06:38:26 INFO - PROCESS | 1680 | 06:38:28 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:38:29 INFO - PROCESS | 1680 | RSS: Main: 256716800 06:38:29 INFO - PROCESS | 1680 | 06:38:31 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:38:31 INFO - PROCESS | 1680 | RSS: Main: 261738496 06:38:31 INFO - PROCESS | 1680 | 06:38:34 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:38:35 INFO - PROCESS | 1680 | RSS: Main: 263110656 06:38:35 INFO - PROCESS | 1680 | 06:38:37 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:38:38 INFO - PROCESS | 1680 | RSS: Main: 263106560 06:38:38 INFO - PROCESS | 1680 | 06:38:39 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 06:38:40 INFO - PROCESS | 1680 | RSS: Main: 326287360 06:38:40 INFO - PROCESS | 1680 | 06:38:40 INFO - PROCESS | 1680 | __start_tp_report 06:38:40 INFO - PROCESS | 1680 | _x_x_mozilla_page_load 06:38:40 INFO - PROCESS | 1680 | _x_x_mozilla_page_load_details 06:38:40 INFO - PROCESS | 1680 | |i|pagename|runs| 06:38:40 INFO - PROCESS | 1680 | |0;ai-astar;113;111;111;111;111;112;131;110;110;110 06:38:40 INFO - PROCESS | 1680 | |1;audio-beat-detection;154;126;135;156;133;140;119;150;150;118 06:38:40 INFO - PROCESS | 1680 | |2;audio-dft;185;183;184;184;183;185;183;183;184;181 06:38:40 INFO - PROCESS | 1680 | |3;audio-fft;69;79;74;115;54;77;75;81;150;81 06:38:40 INFO - PROCESS | 1680 | |4;audio-oscillator;89;89;135;77;80;78;119;75;79;120 06:38:40 INFO - PROCESS | 1680 | |5;imaging-gaussian-blur;87;85;88;85;86;83;88;84;87;84 06:38:40 INFO - PROCESS | 1680 | |6;imaging-darkroom;93;94;93;93;93;93;93;92;94;92 06:38:40 INFO - PROCESS | 1680 | |7;imaging-desaturate;87;84;84;84;86;84;83;85;86;86 06:38:40 INFO - PROCESS | 1680 | |8;json-parse-financial;53;56;59;58;57;56;58;58;69;54 06:38:40 INFO - PROCESS | 1680 | |9;json-stringify-tinderbox;63;61;67;77;68;67;66;65;65;66 06:38:40 INFO - PROCESS | 1680 | |10;stanford-crypto-aes;80;82;79;81;80;79;79;80;81;84 06:38:40 INFO - PROCESS | 1680 | |11;stanford-crypto-ccm;121;127;129;123;129;116;109;117;120;136 06:38:40 INFO - PROCESS | 1680 | |12;stanford-crypto-pbkdf2;167;120;150;167;153;133;134;133;133;133 06:38:40 INFO - PROCESS | 1680 | |13;stanford-crypto-sha256-iterative;66;65;65;66;64;66;65;65;64;64 06:38:40 INFO - PROCESS | 1680 | __end_tp_report 06:38:40 INFO - PROCESS | 1680 | __start_cc_report 06:38:40 INFO - PROCESS | 1680 | _x_x_mozilla_cycle_collect,1180 06:38:40 INFO - PROCESS | 1680 | __end_cc_report 06:38:40 INFO - PROCESS | 1680 | __startTimestamp1465220320102__endTimestamp 06:38:40 INFO - PROCESS | 1680 | 06:38:40 INFO - PROCESS | 1680 | ------- Summary: start ------- 06:38:40 INFO - PROCESS | 1680 | Number of tests: 14 06:38:40 INFO - PROCESS | 1680 | 06:38:40 INFO - PROCESS | 1680 | [#0] ai-astar Cycles:10 Average:113.00 Median:111.00 stddev:6.39 (5.8%) stddev-sans-first:6.78 06:38:40 INFO - PROCESS | 1680 | Values: 113.0 111.0 111.0 111.0 111.0 112.0 131.0 110.0 110.0 110.0 06:38:40 INFO - PROCESS | 1680 | 06:38:40 INFO - PROCESS | 1680 | [#1] audio-beat-detection Cycles:10 Average:138.10 Median:145.00 stddev:14.18 (9.8%) stddev-sans-first:13.83 06:38:40 INFO - PROCESS | 1680 | Values: 154.0 126.0 135.0 156.0 133.0 140.0 119.0 150.0 150.0 118.0 06:38:40 INFO - PROCESS | 1680 | 06:38:40 INFO - PROCESS | 1680 | [#2] audio-dft Cycles:10 Average:183.50 Median:184.00 stddev:1.18 (0.6%) stddev-sans-first:1.12 06:38:40 INFO - PROCESS | 1680 | Values: 185.0 183.0 184.0 184.0 183.0 185.0 183.0 183.0 184.0 181.0 06:38:40 INFO - PROCESS | 1680 | 06:38:40 INFO - PROCESS | 1680 | [#3] audio-fft Cycles:10 Average:85.50 Median:76.00 stddev:27.27 (35.9%) stddev-sans-first:28.26 06:38:40 INFO - PROCESS | 1680 | Values: 69.0 79.0 74.0 115.0 54.0 77.0 75.0 81.0 150.0 81.0 06:38:40 INFO - PROCESS | 1680 | 06:38:40 INFO - PROCESS | 1680 | [#4] audio-oscillator Cycles:10 Average:94.10 Median:78.50 stddev:22.01 (28.0%) stddev-sans-first:23.26 06:38:40 INFO - PROCESS | 1680 | Values: 89.0 89.0 135.0 77.0 80.0 78.0 119.0 75.0 79.0 120.0 06:38:40 INFO - PROCESS | 1680 | 06:38:40 INFO - PROCESS | 1680 | [#5] imaging-gaussian-blur Cycles:10 Average:85.70 Median:86.50 stddev:1.77 (2.0%) stddev-sans-first:1.81 06:38:40 INFO - PROCESS | 1680 | Values: 87.0 85.0 88.0 85.0 86.0 83.0 88.0 84.0 87.0 84.0 06:38:40 INFO - PROCESS | 1680 | 06:38:40 INFO - PROCESS | 1680 | [#6] imaging-darkroom Cycles:10 Average:93.00 Median:93.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 06:38:40 INFO - PROCESS | 1680 | Values: 93.0 94.0 93.0 93.0 93.0 93.0 93.0 92.0 94.0 92.0 06:38:40 INFO - PROCESS | 1680 | 06:38:40 INFO - PROCESS | 1680 | [#7] imaging-desaturate Cycles:10 Average:84.90 Median:85.50 stddev:1.29 (1.5%) stddev-sans-first:1.12 06:38:40 INFO - PROCESS | 1680 | Values: 87.0 84.0 84.0 84.0 86.0 84.0 83.0 85.0 86.0 86.0 06:38:40 INFO - PROCESS | 1680 | 06:38:40 INFO - PROCESS | 1680 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:58.00 stddev:4.37 (7.5%) stddev-sans-first:4.27 06:38:40 INFO - PROCESS | 1680 | Values: 53.0 56.0 59.0 58.0 57.0 56.0 58.0 58.0 69.0 54.0 06:38:40 INFO - PROCESS | 1680 | 06:38:40 INFO - PROCESS | 1680 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:66.50 stddev:4.22 (6.4%) stddev-sans-first:4.28 06:38:40 INFO - PROCESS | 1680 | Values: 63.0 61.0 67.0 77.0 68.0 67.0 66.0 65.0 65.0 66.0 06:38:40 INFO - PROCESS | 1680 | 06:38:40 INFO - PROCESS | 1680 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:80.50 stddev:1.58 (2.0%) stddev-sans-first:1.67 06:38:40 INFO - PROCESS | 1680 | Values: 80.0 82.0 79.0 81.0 80.0 79.0 79.0 80.0 81.0 84.0 06:38:40 INFO - PROCESS | 1680 | 06:38:40 INFO - PROCESS | 1680 | [#11] stanford-crypto-ccm Cycles:10 Average:122.70 Median:125.00 stddev:7.82 (6.3%) stddev-sans-first:8.27 06:38:40 INFO - PROCESS | 1680 | Values: 121.0 127.0 129.0 123.0 129.0 116.0 109.0 117.0 120.0 136.0 06:38:40 INFO - PROCESS | 1680 | 06:38:40 INFO - PROCESS | 1680 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.30 Median:142.00 stddev:16.01 (11.3%) stddev-sans-first:14.27 06:38:40 INFO - PROCESS | 1680 | Values: 167.0 120.0 150.0 167.0 153.0 133.0 134.0 133.0 133.0 133.0 06:38:40 INFO - PROCESS | 1680 | 06:38:40 INFO - PROCESS | 1680 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.00 stddev:0.82 (1.3%) stddev-sans-first:0.78 06:38:40 INFO - PROCESS | 1680 | Values: 66.0 65.0 65.0 66.0 64.0 66.0 65.0 65.0 64.0 64.0 06:38:40 INFO - PROCESS | 1680 | -------- Summary: end -------- 06:38:40 INFO - PROCESS | 1680 | 06:38:40 INFO - TEST-INFO | 1680: exit 0 06:38:40 INFO - TEST-OK | kraken | took 56296ms 06:38:40 INFO - SUITE-END | took 1167s 06:38:41 INFO - Completed test suite (00:19:28) 06:38:41 INFO - javascript benchmark 06:38:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3572.8213589320535, 3639.3085313790393, 3643.3624115779717, 3653.689436397906, 3716.7769933803957, 5897.616654917433, 5913.970430147849, 5914.526837852972, 5925.31858836234, 5965.343812180657, 5881.588288819784, 5926.140709597106, 5943.0, 5954.285485741706, 5956.791512297071, 5182.455842136578, 5267.657602255851, 5298.947010529903, 5338.466153384669, 5382.138857782756, 5378.058839703056, 5400.972995135019, 5405.486478784509, 5411.188321751749, 5432.538234250093, 5326.201069839516, 5362.249285100089, 5389.164679474668, 5394.433584473632, 5403.7027963462, 5379.569634429236, 5381.4349493303225, 5406.675599464025, 5410.675359478444, 5478.123500239983, 5173.146430838907, 5347.1177255752755, 5354.330708661418, 5354.384245811742, 5364.624476286662, 5764.913526297109, 5784.0, 5808.3030036395485, 5837.50381217597, 5867.559933005042, 6149.600275982047, 6270.811875643738, 6286.559940804145, 6288.465480434169, 6289.748410063592, 6195.1946246988055, 6243.157173781572, 6259.937400625981, 6277.811665650038, 6328.0, 6064.454199122056, 6098.14625952367, 6116.755329786848, 6116.877662446726, 6124.554539337585, 6275.3724627537795, 6358.395952384516, 6399.520035997226, 6462.030695395634, 6473.093766872642, 6203.96898015507, 6305.905411418832, 6321.778737744157, 6330.8417289567205, 6337.904931426032, 6298.905516417258, 6306.432421082125, 6316.399942005502, 6318.147050148263, 6349.238091429058, 6243.282022567372, 6252.531060170505, 6282.528810339243, 6333.461655759312, 6371.55399122057, 6329.620222786648, 6331.715072821734, 6341.0, 6350.968245158745, 6364.236291645032, 5054.267131265946, 5086.643934924594, 5087.211482220262, 5090.949090509048, 5110.897782044412, 4427.933580996288, 4460.397846290709, 4573.611243044312, 4612.584867361954, 4616.376789133424, 6114.753609057711, 6117.341459150268, 6130.877382452326, 6132.233136608343, 6140.3552626974415, 6297.811065668037, 6318.083877837687, 6322.936770632235, 6324.3991820776955, 6336.334684858116, 5901.911471327933, 5964.343922168558, 5985.431384018511, 6087.786927457518, 6089.147519347295, 5542.0, 5549.861253468614, 5555.472230138131, 5566.443355664401, 5573.60984731073, 5064.645474816801, 5340.359156901197, 6488.026795980641, 6488.15653964991, 6491.610503369813, 6254.343293954252, 6261.5616906816085, 6315.926292530373, 6320.08358787964, 6321.778737744157, 5467.699276539669, 6401.22496258995, 6472.741090356521, 6473.514486413444, 6532.0, 6287.905681414691, 6335.524835637253, 6338.714757835816, 6343.651099189589, 6359.459445947146, 6186.257649081959, 6225.968870155621, 6226.252849657889, 6280.7487700491465, 6290.49676025926, 5225.7387130642555, 6182.814515564541, 6253.1245625613365, 6260.499160067275, 6294.024426213944, 6265.216847894013, 6275.52933529978, 6289.654069026247, 6292.150559674568, 6316.526260530571, 6021.307549631673, 6107.480864126599, 6116.518381401602, 6175.814725558241, 6181.443670069715, 6280.528960328085, 6291.245050593958, 6311.526635502264, 6311.936880631135, 6318.304986451579, 6177.7837775677635, 6213.502919766317, 6220.7511699533325, 6236.501079913687, 6238.844028899314], "unit": "score", "name": "dojo.html", "value": 5846.49786230109}, {"lowerIsBetter": false, "replicates": [440.73555866480115, 560.5039540007092, 604.5435696049482, 608.2488127162953, 644.4457766320965, 32068.67931320689, 32505.837470812672, 32527.349453010927, 32644.836775816148, 32684.836575817146, 43994.12011759763, 44347.77826110865, 44420.77789611056, 44421.7778911105, 44474.77762611183, 9783.461909594987, 9997.650082247123, 10007.799844003115, 10024.348417352885, 10036.949815250913, 9831.557579908922, 9999.600015999351, 10003.549840257207, 10013.94993025034, 10014.998500149999, 9940.254480913924, 10127.0, 10162.0, 10175.287729858914, 10179.694609161737, 10044.648437304695, 10132.898671013269, 10134.493275336277, 10140.442275674797, 10152.593896244141, 9788.461634610094, 9913.454759988197, 9919.851202231972, 9928.751781205456, 9945.055219754111, 42871.57128428707, 43143.35284970728, 43174.56825431737, 43185.92035199114, 43451.0, 2812.142296599536, 3217.9678203217904, 3360.31113621707, 3419.1623052352084, 3798.2593394288124, 30055.133363135108, 30105.096847094403, 30280.242993925327, 30280.394392112034, 30353.93761218347, 2747.0, 2764.405652784661, 2772.7643150332246, 2804.705505921869, 2818.6476690413697, 491358.0, 500651.4967425176, 501177.0, 501290.0, 502155.0, 50889.982200355786, 77856.61071694718, 78886.6055669718, 78913.2108678906, 78949.0, 51611.22583161256, 51786.22320665193, 51930.961380772176, 51940.0, 51976.0, 17612.647747044986, 17637.118144092743, 17817.732734009, 17823.821761782474, 17838.0, 13976.51082212138, 14121.152730836182, 14127.081739687093, 14133.71732565343, 14152.787708184385, 12995.870041299466, 16131.435399760952, 16178.919105404397, 16217.270222840001, 16227.269772860249, 6849.691763870638, 6972.721091156297, 6974.302569743087, 6995.825104372431, 7019.9112390548, 1003.2776400991274, 1024.5850430575629, 1056.9312994655322, 1089.515165751249, 1123.3879383085298, 30053.69946300509, 30680.38639227203, 30720.0, 31291.061268161535, 31321.06036818899, 1122.2817396866012, 1144.742432952579, 1158.8145896656495, 1218.342095268545, 1227.5703503773607, 15712.371505139896, 15753.0, 15849.0, 16001.519954401387, 16044.839551604568, 527982.0, 542660.286698564, 546070.0, 548491.0, 548832.0, 51216.487835121174, 62590.374096259366, 63150.0, 63235.05147422793, 63310.68344658247, 1378.951736689211, 1483.1546018769197, 1498.1161114942236, 1526.4428483603626, 1532.1573134776052, 29647.85176074192, 30793.69206307998, 31233.219169520944, 31367.21581960469, 31660.0, 51430.74284628553, 51711.0, 51918.48081519137, 51920.480795191565, 51998.70003249949, 362519.0, 368972.0, 369410.0, 369566.0, 370125.0, 30842.691573084878, 34481.96554103381, 35153.0, 36060.27879442449, 36146.73486427962, 42971.78514107409, 43178.0, 43965.0, 44188.0, 44677.77661111674, 34585.30829383348, 35483.46774798328, 36519.0, 36690.63309366872, 37011.81494092512, 35591.82204088963, 35702.642973569935, 35794.64205357913, 36627.816860915525, 36667.63332366642, 36635.0, 36753.81623091974, 39447.60552394554, 39981.80009099936, 40790.79604601958, 31352.21619459532, 33049.669503304656, 33252.83373583117, 33445.0, 33500.32999340048, 25598.61602075933, 26042.73957260403, 26123.477530448905, 26290.605640915783, 26318.736812632396], "unit": "score", "name": "ext.html", "value": 19916.4937381391}, {"lowerIsBetter": false, "replicates": [371.9665230129288, 372.7875111186624, 379.56160634467165, 383.02329060894726, 388.23905145914006, 13556.389962451689, 20686.069126889288, 21107.894460527714, 21870.23454179104, 21920.342389728296, 19307.613847723038, 22172.11311547536, 22230.666540001912, 22567.54864902701, 22594.0, 5700.429957004298, 5889.263842019747, 6030.457258846703, 6057.969710151465, 6063.484603808682, 5725.971370143165, 5903.380145084747, 5914.201582786333, 5919.585629005971, 5921.88156236875, 5523.088690366085, 5901.17383566301, 5905.261842269716, 5907.911381329283, 5910.320313163977, 5315.697654074757, 5743.282089738804, 5807.448292412235, 5860.912086318666, 5895.528357731371, 5153.484651534854, 5154.871128221787, 5158.92261616076, 5166.147585648364, 5182.637215394924, 13092.149010314395, 13661.316934153252, 13679.658008549766, 13680.65798355039, 13682.179069255877, 2242.990654205598, 2474.3319303788057, 2630.447606002742, 2836.262571731344, 2852.115844088339, 9911.950440247825, 10030.548625311878, 10120.038596333337, 10125.240606954509, 10404.739881502946, 1668.099226417733, 1694.2545280076727, 1712.332190445727, 1762.409592786418, 1778.4220128458303, 87919.56040219821, 99893.0, 107871.0, 108142.99999999921, 111479.88520114857, 11385.829212561819, 11495.080393568494, 11532.654020379403, 11549.942250288863, 11655.125865560118, 14400.927995359956, 14450.494232702014, 14457.85542144565, 14497.855021449861, 14507.782383264259, 8910.955445222862, 8918.598663060178, 8951.283897288202, 8956.0, 9096.81806363869, 9194.954025229965, 9214.401063930824, 9224.815503689888, 9300.720978370524, 9336.852523919537, 4543.863684089482, 4544.0, 4565.109803588269, 4567.862964111082, 4590.563896429834, 1860.9720854187199, 1914.2197756086694, 1936.4190742777391, 1948.6882098864114, 1951.7267582538457, 809.4859764049871, 891.6567121658209, 917.6512925088557, 942.4816351007056, 963.3882484622316, 19611.117499712545, 20172.79827201709, 20402.69395959062, 20444.897775511028, 20575.897120514303, 973.7468258252763, 1002.7142264454595, 1036.1555332404066, 1045.8849526552074, 1065.6003998500562, 11000.559977600966, 11394.772104558027, 11403.372814495282, 11423.314601123793, 11427.428628568538, 661664.6916765482, 662979.0, 677786.0, 679914.0, 679977.0, 80640.0, 110639.0, 111391.0, 119715.0, 127073.36463317809, 1009.6819501856892, 1067.781104873499, 1118.552578968403, 1127.9266847654876, 1133.8604702274326, 13239.669008274484, 14939.925300373428, 18153.909230453763, 19224.423267302005, 19303.613927721646, 48663.27005094856, 50360.74819626025, 50734.49265507298, 52036.69908252324, 52253.47746522486, 72844.54310913858, 73209.6339518299, 73337.26662733304, 74675.0, 75274.87087693579, 7801.687932482864, 8213.3429325655, 8231.876521852297, 8285.792855178668, 8362.414630975773, 9505.334626576074, 10615.469226538797, 13284.667883302995, 13288.933555332162, 13656.180629162282, 11527.711807204552, 11633.476493557979, 11697.883021169679, 11772.52909883595, 11952.58165964187, 11151.275167114112, 11400.543978241109, 11421.543138274375, 11668.88331116712, 11793.29240245588, 11697.824532632187, 11797.88202117968, 12142.696432588902, 12187.26876387384, 12190.51237950472, 8165.387595930448, 8214.424990250625, 8274.958625206835, 8372.623231954698, 8543.316534677087, 10655.733606659896, 11214.887851121384, 11227.38249396291, 11611.593594224161, 11856.17006809515], "unit": "score", "name": "jquery.html", "value": 9439.355997953384}, {"lowerIsBetter": false, "replicates": [1438.7985682004519, 1514.7652113922345, 1670.7076261654208, 1976.1107501624272, 2140.3899888531773, 8330.20863018014, 8913.732588022362, 9080.0, 9101.544922753868, 9111.134442227994, 8846.911530884689, 9103.271738260939, 9106.362554621179, 9107.908920910806, 9110.635574577025, 2529.5826188678893, 2550.923472295834, 2559.872006399682, 2560.4879024195234, 2564.871456559117, 2498.850068995857, 2569.8329608575477, 2574.639550462927, 2578.6776652918384, 2578.6905571331467, 2078.864873783207, 2545.2109845947816, 2559.0, 2573.562494375961, 2576.3945472813875, 2529.190658989124, 2547.0448581781834, 2562.9102981395654, 2574.17626359565, 2577.1237779155176, 2525.065725681491, 2554.4124851284123, 2560.423904621464, 2565.191964531167, 2576.1112416216374, 9091.81816363669, 9140.45157290558, 9154.084591540859, 9169.541522923828, 9173.220276276525, 5546.972265138689, 5745.339285982123, 5754.97122514389, 5755.4244575542525, 5756.251687280626, 3693.445983102529, 3750.7562008469636, 3812.618738126193, 3834.2906562286066, 3835.060410199491, 1053.525913338993, 1075.6934273732027, 1076.2842709598108, 1091.307020042279, 1111.2998810749257, 12550.372481375894, 12580.182288151242, 12583.559575414909, 12598.874011259953, 12606.810897836449, 4980.12847751642, 5004.424491183488, 5058.671186372874, 5066.442691303953, 5103.744812759347, 10425.0, 10436.37381757097, 10436.895631043744, 10448.05967462932, 10449.634262800766, 5662.858428539237, 5664.150377443417, 5717.799877004285, 5717.971410142923, 5724.084146536534, 4616.815327386867, 4703.0123674028155, 4719.2921061841, 4773.570378665937, 5170.663906846118, 2948.3513627002026, 3265.6734326567152, 3787.4886890270013, 3892.4161375793856, 4073.9388909166387, 1344.536135033412, 1352.9255890926092, 1360.857110003455, 1366.0847232354347, 1366.1393322206945, 1439.8272207335187, 1443.8483959184343, 1449.1160392160773, 1454.647038576071, 1473.3885437543513, 8507.319414446829, 8559.614817333235, 8569.314454843598, 8570.914290857012, 8593.140685931481, 1239.1821397877359, 1252.1485389934749, 1253.7367152897993, 1274.6877015131352, 1277.3932382118605, 6358.268799088071, 6390.744370225232, 6472.190976127984, 6477.514186436036, 6498.707558159894, 10830.458477076114, 10974.012338889539, 11000.449977501094, 11158.274712143684, 11188.776224475465, 10975.615853445252, 11036.668899933014, 11171.944140279247, 11174.27367221128, 11182.32906025641, 8276.8344633107, 8486.19381158789, 8512.531810750468, 8538.0, 8626.051134375213, 8130.87803682957, 8145.592720364077, 8198.180181981992, 8201.507909525448, 8218.21926916942, 9671.0, 9721.416714997124, 9910.851337230091, 9941.950290248502, 10128.493575321352, 10036.598536058476, 10131.696049118538, 10150.187984961038, 10156.933521980085, 10254.53854576531, 6944.756933507303, 7693.115291741297, 7705.768826935201, 7772.339351154989, 7777.688892444239, 7932.286094251545, 8329.750107496784, 8537.274331681876, 8562.957185214284, 8595.968483781986, 7482.850342993219, 7526.887096693445, 7581.924180758122, 7669.194734553015, 7692.153863075169, 7343.926560734538, 7368.115826100902, 7449.6275186241555, 7474.887876681963, 7485.625718714152, 7866.960665196638, 7958.920410795818, 7971.920280797118, 7972.681092756225, 7977.880331794911, 7131.928680713334, 7143.214246432992, 7228.674709638184, 7238.312360325761, 7238.746643867439, 7293.890591641023, 7376.188619251985, 7386.446016548673, 7386.96306518464, 7389.96305018493], "unit": "score", "name": "mootools.html", "value": 5129.50728170319}, {"lowerIsBetter": false, "replicates": [278.2681547529996, 339.0709456090312, 339.30611898667223, 340.94544872820353, 343.81262212094407, 5754.280714910641, 5756.568257380697, 6651.401373876351, 6716.932830671692, 6736.191657001154, 6603.768868089618, 6618.635975021371, 6635.170603674541, 6651.733930642768, 6669.833254168649, 4779.713217206961, 4892.975535122319, 4894.853154405374, 4913.115639184945, 4981.178105612578, 4045.352743561031, 4885.853424397274, 4911.950880491203, 4916.237983112624, 5002.52476014778, 4917.72952487613, 4918.336024636664, 4929.260610908356, 4935.679180853251, 4943.307936888838, 4922.286268491067, 4943.505649435064, 4948.480409556981, 4949.529794669501, 4951.529604687567, 4095.201435720036, 4161.188568229197, 4242.893927651833, 4248.065425606362, 4249.957500424987, 5075.51782580658, 5385.0037743017665, 5424.942136283426, 6048.637081775108, 6111.54163437744, 5820.068788993741, 5823.068309070571, 5828.795992140254, 5831.708414579254, 5839.299284085894, 7076.964615176943, 7088.574685518885, 7096.0, 7102.289771022908, 7106.893396599055, 4761.785719642625, 4763.428388593391, 4765.809367625291, 4766.571008609207, 4768.666193366465, 5848.0, 7582.658780354842, 7639.350655194371, 7657.578833164173, 7662.770116896446, 4676.462206846256, 4753.33453316536, 4762.333273341735, 4762.78567464458, 4777.187878060738, 4835.685680430761, 4848.660593758403, 4848.660593758474, 4851.054044461367, 4860.684055536379, 5746.224259724883, 5749.3963133871175, 5751.194832723422, 5758.107493338539, 5762.4525670061275, 5627.662340259598, 5874.500667443315, 5921.822345329647, 7256.310650488195, 7273.563586184846, 1655.4785242648527, 1664.9084300363354, 1680.252287731972, 1683.040666819901, 1686.1232159277108, 1044.102072217892, 1049.4962418039383, 1065.3554599467366, 1068.4817863336275, 1070.5129166229347, 6657.434118100015, 6795.286494917962, 6797.524173307821, 6804.55770374924, 6804.863902721918, 7386.0767404074495, 7443.627818609048, 7457.888131678029, 7468.887966680504, 7603.4297427693145, 6871.484638652121, 6884.208316043619, 6902.896456553156, 6915.170179578483, 6921.792346229621, 3958.3666613342302, 4010.7393019453643, 4013.3578627419474, 4016.2971479990883, 4022.9798851005557, 7651.732189373345, 7904.644291006918, 7906.288434040964, 7958.2041795821115, 7962.601869906482, 7753.340966017839, 7792.493487923267, 7796.181400952932, 7800.985871836625, 7817.218278172251, 5834.562407819346, 7659.234076592407, 7888.0, 7895.644695988694, 7905.604719764104, 6091.4822240108315, 7535.133459651991, 7546.320831125225, 7546.849063018819, 7558.1686014539455, 7091.82270443243, 7360.96319518399, 7399.926000739923, 7409.222031686595, 7434.070741157356, 6301.590396624205, 7843.333316668147, 7851.016613686763, 7863.449558530848, 7929.286364227017, 4748.240281554935, 4754.809807607657, 4762.857114286577, 4774.880627984328, 4780.737059461624, 7468.439867009887, 7492.662830172546, 7499.437542184467, 7518.173000969999, 7522.736704215326, 6907.205671347659, 7228.168760592599, 7235.963820180866, 7237.855242895007, 7274.381677557467, 7148.177959534512, 7188.8921666174, 7191.71233150689, 7205.423566114803, 7207.639618018973, 7031.191412987368, 7037.401820845285, 7037.964810175917, 7041.155061392666, 7043.788686339418, 5762.510186634183, 6946.409555187865, 7191.712331506681, 7195.136583609791, 7208.207097219407, 5573.795067835929, 6361.491080713625, 7056.647167641495, 7071.646417679199, 7078.398336141486], "unit": "score", "name": "prototype.html", "value": 5200.986067021277}, {"lowerIsBetter": false, "replicates": [716.6237725194272, 749.8800191969286, 767.8656235158846, 782.4835608498393, 809.7732634862239, 15408.30662620182, 15505.898820235956, 15719.37122515098, 15719.37122515101, 15748.291326890288, 14620.780688289684, 14696.706065878676, 14719.852801471981, 14731.48439804607, 14735.778963315559, 799.5282783157936, 809.2393150438598, 813.5728742410223, 944.409743910058, 965.884093908732, 808.2806302390877, 811.5333683132193, 956.5121787888157, 984.7882705218377, 994.0159242350094, 1033.5245786938017, 1036.2797855490437, 1036.8289232276666, 1037.6108959140322, 1041.1930753665895, 1021.2851004297022, 1021.5556233038652, 1022.2435397805607, 1022.5296363672719, 1022.9897701022969, 617.102116420607, 748.5957582905224, 764.2281295891135, 764.3655765714444, 766.6665000724703, 15426.691466170725, 15489.5353139406, 15530.223488825513, 15531.223438828127, 15536.223188840513, 13189.868101319056, 13225.140365876186, 13520.797188042186, 13533.255670938095, 13611.795823062663, 10466.947665261625, 10548.156147508182, 10745.462726863625, 10946.39794811285, 11122.0, 3658.378075727133, 3708.9443658345144, 3724.5344331958504, 3737.177820879402, 3741.8877433677035, 69157.65421172912, 70128.29871701269, 70215.64892175558, 70697.64651176763, 70702.58594828074, 9245.583948722324, 9768.36505627132, 10045.648402305884, 10075.899241007643, 10137.189024877993, 22063.227787027376, 22242.88878555597, 22262.0, 22468.88765556162, 22527.873606319947, 7746.806329841799, 7776.377889768805, 8029.397795165386, 8033.839323213503, 8186.672533098728, 4073.103917138284, 4152.875413737593, 4206.158768246363, 4247.3628955656895, 4402.955970440319, 3700.2784457031157, 3742.8502859885843, 3762.3039737648623, 3776.5090538229856, 3779.962200378016, 668.4919461209515, 670.8524124692657, 672.0691841799144, 683.7846078485261, 686.7733647896182, 561.7556362982034, 593.7817031688174, 611.3794498583941, 612.7640858269598, 626.5739297277895, 8140.430169888169, 8313.763731889894, 8373.037100733372, 8447.413354102344, 8462.026866910384, 535.234614501267, 544.9754761035763, 582.7843697831829, 585.7364186116265, 618.0852338538988, 3805.257974694963, 3879.8254078566533, 3893.3381325174787, 4059.6752259819145, 4151.958480415157, 92762.0, 95314.0, 96141.0385896146, 96331.51834240784, 96564.51717741367, 79475.60262198652, 80890.0, 82932.58533707293, 83807.5809620948, 84036.57981710053, 74380.04959603219, 74459.0, 74979.62510187524, 75364.0, 75614.62192689002, 6703.66481675924, 7502.662380192795, 7568.886466702894, 7605.961970190335, 7701.730439434593, 51323.0, 52356.0, 52800.0, 53149.7342513285, 53609.19586206132, 46221.0, 70777.23056923618, 71995.0, 72249.27750722636, 72845.0, 9654.227661787181, 9783.045300141386, 9970.0, 10021.899781002097, 10458.006489383497, 10783.95638084883, 10966.561337546409, 11072.0, 11266.83099753488, 11360.829587556029, 10463.581456741646, 10529.78940421172, 10658.73353166177, 11418.486168122288, 11477.942610286895, 10386.636467723594, 10426.947865260625, 10499.790004200026, 10687.625933092304, 11413.714657133638, 10186.643467478603, 10212.387256764618, 10249.282550221413, 10357.9482102589, 11075.224734268524, 8809.163129502687, 9104.408213466368, 9138.497382644018, 9169.77075573116, 9463.148316651259, 8691.782705432415, 8889.354526496516, 8937.150970657776, 8991.55042247898, 9033.232175264913], "unit": "score", "name": "yui.html", "value": 6969.768675045348}], "name": "dromaeo_css", "value": 7674.980853918441}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 111.0, 111.0, 111.0, 111.0, 112.0, 131.0, 110.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 113.0}, {"lowerIsBetter": true, "replicates": [154.0, 126.0, 135.0, 156.0, 133.0, 140.0, 119.0, 150.0, 150.0, 118.0], "unit": "score", "name": "audio-beat-detection", "value": 138.1}, {"lowerIsBetter": true, "replicates": [185.0, 183.0, 184.0, 184.0, 183.0, 185.0, 183.0, 183.0, 184.0, 181.0], "unit": "score", "name": "audio-dft", "value": 183.5}, {"lowerIsBetter": true, "replicates": [69.0, 79.0, 74.0, 115.0, 54.0, 77.0, 75.0, 81.0, 150.0, 81.0], "unit": "score", "name": "audio-fft", "value": 85.5}, {"lowerIsBetter": true, "replicates": [89.0, 89.0, 135.0, 77.0, 80.0, 78.0, 119.0, 75.0, 79.0, 120.0], "unit": "score", "name": "audio-oscillator", "value": 94.1}, {"lowerIsBetter": true, "replicates": [87.0, 85.0, 88.0, 85.0, 86.0, 83.0, 88.0, 84.0, 87.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 85.7}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 93.0, 93.0, 93.0, 93.0, 93.0, 92.0, 94.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 93.0}, {"lowerIsBetter": true, "replicates": [87.0, 84.0, 84.0, 84.0, 86.0, 84.0, 83.0, 85.0, 86.0, 86.0], "unit": "score", "name": "imaging-desaturate", "value": 84.9}, {"lowerIsBetter": true, "replicates": [53.0, 56.0, 59.0, 58.0, 57.0, 56.0, 58.0, 58.0, 69.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.8}, {"lowerIsBetter": true, "replicates": [63.0, 61.0, 67.0, 77.0, 68.0, 67.0, 66.0, 65.0, 65.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.5}, {"lowerIsBetter": true, "replicates": [80.0, 82.0, 79.0, 81.0, 80.0, 79.0, 79.0, 80.0, 81.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.5}, {"lowerIsBetter": true, "replicates": [121.0, 127.0, 129.0, 123.0, 129.0, 116.0, 109.0, 117.0, 120.0, 136.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.7}, {"lowerIsBetter": true, "replicates": [167.0, 120.0, 150.0, 167.0, 153.0, 133.0, 134.0, 133.0, 133.0, 133.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.3}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 65.0, 66.0, 64.0, 66.0, 65.0, 65.0, 64.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.0}], "name": "kraken", "value": 1412.6}]} 06:38:41 INFO - Return code: 0 06:38:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:38:41 INFO - # TBPL SUCCESS # 06:38:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:38:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:38:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:38:41 INFO - 2016-06-06 06:38:41.405 screenresolution[1684:10128] starting screenresolution argv=screenresolution get 06:38:41 INFO - 2016-06-06 06:38:41.407 screenresolution[1684:10128] Display 0: 1600x1200x32@60 06:38:41 INFO - 2016-06-06 06:38:41.413 screenresolution[1685:10131] starting screenresolution argv=screenresolution list 06:38:41 INFO - Available Modes on Display 0 06:38:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:38:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:38:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:38:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:38:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:38:41 INFO - Intel Iris: 06:38:41 INFO - Chipset Model: Intel Iris 06:38:41 INFO - Type: GPU 06:38:41 INFO - Bus: Built-In 06:38:41 INFO - VRAM (Dynamic, Max): 1536 MB 06:38:41 INFO - Vendor: Intel (0x8086) 06:38:41 INFO - Device ID: 0x0a2e 06:38:41 INFO - Revision ID: 0x0009 06:38:41 INFO - Displays: 06:38:41 INFO - Display: 06:38:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:38:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:38:41 INFO - Display Serial Number: 1600x1200 60 06:38:41 INFO - Main Display: Yes 06:38:41 INFO - Mirror: Off 06:38:41 INFO - Online: Yes 06:38:41 INFO - Rotation: Supported 06:38:41 INFO - Return code: 0 06:38:41 INFO - Running post-action listener: _resource_record_post_action 06:38:41 INFO - Running post-run listener: _resource_record_post_run 06:38:42 INFO - Total resource usage - Wall time: 1192s; CPU: 52.0%; Read bytes: 36869632; Write bytes: 508121088; Read time: 239; Write time: 1559 06:38:42 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 204052992; Write bytes: 198932480; Read time: 18083; Write time: 435 06:38:42 INFO - run-tests - Wall time: 1170s; CPU: 52.0%; Read bytes: 30580224; Write bytes: 299177984; Read time: 184; Write time: 1094 06:38:42 INFO - Running post-run listener: _upload_blobber_files 06:38:42 INFO - Blob upload gear active. 06:38:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:38:42 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:38:42 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:38:42 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:38:43 INFO - (blobuploader) - INFO - Open directory for files ... 06:38:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:38:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:38:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:38:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:38:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:38:44 INFO - (blobuploader) - INFO - Done attempting. 06:38:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:38:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:38:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:38:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:38:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:38:45 INFO - (blobuploader) - INFO - Done attempting. 06:38:45 INFO - (blobuploader) - INFO - Iteration through files over. 06:38:45 INFO - Return code: 0 06:38:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:38:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:38:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b0a8d3ad1e39400197948ecff48d65e798bc56483a0f837a2bca31a738b352bb6cdbc3bd11ee36f2bdf149cc3fcf9784b2a23917f1f854d0930877e83ad22a3e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/63b54245762b1c66d427bad853ee36dc3f0ff6344b835cb8f19090a6d4c769734e03a9b46dbf8a3bcd89391b7634e3ac724496209a1a326c209dfb1eec3e4c8e"} 06:38:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:38:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:38:45 INFO - Contents: 06:38:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b0a8d3ad1e39400197948ecff48d65e798bc56483a0f837a2bca31a738b352bb6cdbc3bd11ee36f2bdf149cc3fcf9784b2a23917f1f854d0930877e83ad22a3e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/63b54245762b1c66d427bad853ee36dc3f0ff6344b835cb8f19090a6d4c769734e03a9b46dbf8a3bcd89391b7634e3ac724496209a1a326c209dfb1eec3e4c8e"} 06:38:45 INFO - Running post-run listener: copy_logs_to_upload_dir 06:38:45 INFO - Copying logs to upload dir... 06:38:45 INFO - mkdir: /builds/slave/test/build/upload/logs 06:38:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.308049 ========= master_lag: 1.15 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-06-06 06:38:46.552852) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 06:38:46.557553) ========= 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.s0czvilzXl/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.WXo3TGynn8/Listeners TMPDIR=/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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/b0a8d3ad1e39400197948ecff48d65e798bc56483a0f837a2bca31a738b352bb6cdbc3bd11ee36f2bdf149cc3fcf9784b2a23917f1f854d0930877e83ad22a3e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/63b54245762b1c66d427bad853ee36dc3f0ff6344b835cb8f19090a6d4c769734e03a9b46dbf8a3bcd89391b7634e3ac724496209a1a326c209dfb1eec3e4c8e"} build_url:https://queue.taskcluster.net/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011206 build_url: 'https://queue.taskcluster.net/v1/task/CZf5QtG-QfWSsAQhoQbuHg/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b0a8d3ad1e39400197948ecff48d65e798bc56483a0f837a2bca31a738b352bb6cdbc3bd11ee36f2bdf149cc3fcf9784b2a23917f1f854d0930877e83ad22a3e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/63b54245762b1c66d427bad853ee36dc3f0ff6344b835cb8f19090a6d4c769734e03a9b46dbf8a3bcd89391b7634e3ac724496209a1a326c209dfb1eec3e4c8e"}' ========= master_lag: 0.06 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 06:38:46.625254) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:38:46.625580) ========= 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.s0czvilzXl/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.WXo3TGynn8/Listeners TMPDIR=/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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.005144 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:38:46.674705) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 06:38:46.674982) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 06:38:46.678321) ========= ========= Total master_lag: 1.33 =========