builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0159 starttime: 1467392283.74 results: success (0) buildid: 20160701074922 builduid: ad5179a2fa9c4befaf28b0702cae2bba revision: 4c7636b942946b1057c6f8fe5ae92377011a86bf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 09:58:03.739287) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 09:58:03.739648) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 09:58:03.739927) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 09:58:03.773713) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 09:58:03.773954) ========= 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.ddS2XBy0tE/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.uZ1zyuSAvl/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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-07-01 09:58:03-- 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% 13.3M=0.001s 2016-07-01 09:58:03 (13.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.129718 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 09:58:03.928425) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 09:58:03.928712) ========= 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.ddS2XBy0tE/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.uZ1zyuSAvl/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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.027237 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 09:58:03.979741) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-01 09:58:03.980425) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4c7636b942946b1057c6f8fe5ae92377011a86bf --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 4c7636b942946b1057c6f8fe5ae92377011a86bf --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ddS2XBy0tE/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.uZ1zyuSAvl/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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-07-01 09:58:04,056 truncating revision to first 12 chars 2016-07-01 09:58:04,057 Setting DEBUG logging. 2016-07-01 09:58:04,057 attempt 1/10 2016-07-01 09:58:04,057 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/4c7636b94294?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-01 09:58:05,171 unpacking tar archive at: mozilla-beta-4c7636b94294/testing/mozharness/ program finished with exit code 0 elapsedTime=1.385873 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-01 09:58:05.390390) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 09:58:05.390746) ========= script_repo_revision: 4c7636b942946b1057c6f8fe5ae92377011a86bf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 09:58:05.391199) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 09:58:05.391523) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 09:58:05.409953) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-07-01 09:58:05.410609) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ddS2XBy0tE/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.uZ1zyuSAvl/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 09:58:05 INFO - MultiFileLogger online at 20160701 09:58:05 in /builds/slave/test 09:58:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 09:58:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:58:05 INFO - {'append_to_log': False, 09:58:05 INFO - 'base_work_dir': '/builds/slave/test', 09:58:05 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:58:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:58:05 INFO - 'branch': 'Mozilla-Beta', 09:58:05 INFO - 'buildbot_json_path': 'buildprops.json', 09:58:05 INFO - 'config_files': ('talos/mac_config.py',), 09:58:05 INFO - 'default_actions': ('clobber', 09:58:05 INFO - 'read-buildbot-config', 09:58:05 INFO - 'download-and-extract', 09:58:05 INFO - 'populate-webroot', 09:58:05 INFO - 'create-virtualenv', 09:58:05 INFO - 'install', 09:58:05 INFO - 'run-tests'), 09:58:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:58:05 INFO - 'download_minidump_stackwalk': True, 09:58:05 INFO - 'download_symbols': 'ondemand', 09:58:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:58:05 INFO - 'tooltool.py': '/tools/tooltool.py', 09:58:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:58:05 INFO - '/tools/misc-python/virtualenv.py')}, 09:58:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:58:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:58:05 INFO - 'installer_path': 'installer.exe', 09:58:05 INFO - 'log_level': 'info', 09:58:05 INFO - 'log_name': 'talos', 09:58:05 INFO - 'log_to_console': True, 09:58:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:58:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:58:05 INFO - 'opt_config_files': (), 09:58:05 INFO - 'pip_index': False, 09:58:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:58:05 INFO - 'cmd': ('bash', 09:58:05 INFO - '-c', 09:58:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:58:05 INFO - 'enabled': True, 09:58:05 INFO - 'halt_on_failure': False, 09:58:05 INFO - 'name': 'check_screen_resolution'},), 09:58:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:58:05 INFO - 'cmd': ('bash', 09:58:05 INFO - '-c', 09:58:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:58:05 INFO - 'enabled': True, 09:58:05 INFO - 'halt_on_failure': False, 09:58:05 INFO - 'name': 'check_screen_resolution'},), 09:58:05 INFO - 'run_cmd_checks_enabled': True, 09:58:05 INFO - 'sps_profile': False, 09:58:05 INFO - 'sps_profile_interval': 0, 09:58:05 INFO - 'suite': 'dromaeojs-e10s', 09:58:05 INFO - 'system_bits': '32', 09:58:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:58:05 INFO - 'title': 't-yosemite-r7-0159', 09:58:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:58:05 INFO - 'use_talos_json': True, 09:58:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:58:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:58:05 INFO - 'work_dir': 'build'} 09:58:05 INFO - ##### 09:58:05 INFO - ##### Running clobber step. 09:58:05 INFO - ##### 09:58:05 INFO - Running pre-action listener: _resource_record_pre_action 09:58:05 INFO - Running main action method: clobber 09:58:05 INFO - rmtree: /builds/slave/test/build 09:58:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:58:08 INFO - Running post-action listener: _resource_record_post_action 09:58:08 INFO - ##### 09:58:08 INFO - ##### Running read-buildbot-config step. 09:58:08 INFO - ##### 09:58:08 INFO - Running pre-action listener: _resource_record_pre_action 09:58:08 INFO - Running main action method: read_buildbot_config 09:58:08 INFO - Using buildbot properties: 09:58:08 INFO - { 09:58:08 INFO - "project": "", 09:58:08 INFO - "product": "firefox", 09:58:08 INFO - "script_repo_revision": "production", 09:58:08 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 09:58:08 INFO - "repository": "", 09:58:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 09:58:08 INFO - "buildid": "20160701074922", 09:58:08 INFO - "pgo_build": "False", 09:58:08 INFO - "basedir": "/builds/slave/test", 09:58:08 INFO - "buildnumber": 50, 09:58:08 INFO - "slavename": "t-yosemite-r7-0159", 09:58:08 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 09:58:08 INFO - "platform": "yosemite_r7", 09:58:08 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 09:58:08 INFO - "branch": "mozilla-beta", 09:58:08 INFO - "repo_path": "releases/mozilla-beta", 09:58:08 INFO - "revision": "4c7636b942946b1057c6f8fe5ae92377011a86bf", 09:58:08 INFO - "stage_platform": "macosx64", 09:58:08 INFO - "builduid": "ad5179a2fa9c4befaf28b0702cae2bba", 09:58:08 INFO - "slavebuilddir": "test" 09:58:08 INFO - } 09:58:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/Jp7YfCxVTTO9uUnLtgbujQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 09:58:08 INFO - Running post-action listener: _resource_record_post_action 09:58:08 INFO - ##### 09:58:08 INFO - ##### Running download-and-extract step. 09:58:08 INFO - ##### 09:58:08 INFO - Running pre-action listener: _resource_record_pre_action 09:58:08 INFO - Running main action method: download_and_extract 09:58:08 INFO - mkdir: /builds/slave/test/build/tests 09:58:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:08 INFO - https://queue.taskcluster.net/v1/task/Jp7YfCxVTTO9uUnLtgbujQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 09:58:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jp7YfCxVTTO9uUnLtgbujQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 09:58:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jp7YfCxVTTO9uUnLtgbujQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 09:58:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jp7YfCxVTTO9uUnLtgbujQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 09:58:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jp7YfCxVTTO9uUnLtgbujQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 09:58:11 INFO - Downloaded 1165 bytes. 09:58:11 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 09:58:11 INFO - Using the following test package requirements: 09:58:11 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 09:58:11 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:58:11 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 09:58:11 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:58:11 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 09:58:11 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 09:58:11 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:58:11 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 09:58:11 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 09:58:11 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:58:11 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 09:58:11 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:58:11 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 09:58:11 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:58:11 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 09:58:11 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:58:11 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 09:58:11 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 09:58: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')]} 09:58:11 INFO - https://queue.taskcluster.net/v1/task/Jp7YfCxVTTO9uUnLtgbujQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:58:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jp7YfCxVTTO9uUnLtgbujQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 09:58:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jp7YfCxVTTO9uUnLtgbujQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 09:58:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jp7YfCxVTTO9uUnLtgbujQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 09:58:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jp7YfCxVTTO9uUnLtgbujQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 09:58:24 INFO - Downloaded 18351375 bytes. 09:58:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:58:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:58:27 INFO - Return code: 0 09:58:27 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 09:58:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:27 INFO - https://queue.taskcluster.net/v1/task/Jp7YfCxVTTO9uUnLtgbujQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:58:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jp7YfCxVTTO9uUnLtgbujQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 09:58:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jp7YfCxVTTO9uUnLtgbujQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 09:58:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jp7YfCxVTTO9uUnLtgbujQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 09:58:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jp7YfCxVTTO9uUnLtgbujQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 09:58:43 INFO - Downloaded 18351375 bytes. 09:58:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:58:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:58:46 INFO - Return code: 0 09:58:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:46 INFO - https://queue.taskcluster.net/v1/task/Jp7YfCxVTTO9uUnLtgbujQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:58:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jp7YfCxVTTO9uUnLtgbujQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 09:58:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jp7YfCxVTTO9uUnLtgbujQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 09:58:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jp7YfCxVTTO9uUnLtgbujQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 09:58:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jp7YfCxVTTO9uUnLtgbujQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 09:58:47 INFO - Downloaded 10840145 bytes. 09:58:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:58:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 09:58:48 INFO - Return code: 0 09:58:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:48 INFO - https://queue.taskcluster.net/v1/task/Jp7YfCxVTTO9uUnLtgbujQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 09:58:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jp7YfCxVTTO9uUnLtgbujQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 09:58:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jp7YfCxVTTO9uUnLtgbujQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 09:58:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jp7YfCxVTTO9uUnLtgbujQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 09:58:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jp7YfCxVTTO9uUnLtgbujQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 09:58:51 INFO - Downloaded 86195735 bytes. 09:58:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Jp7YfCxVTTO9uUnLtgbujQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 09:58:51 INFO - mkdir: /builds/slave/test/properties 09:58:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:58:51 INFO - Writing to file /builds/slave/test/properties/build_url 09:58:51 INFO - Contents: 09:58:51 INFO - build_url:https://queue.taskcluster.net/v1/task/Jp7YfCxVTTO9uUnLtgbujQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 09:58:52 INFO - Running post-action listener: _resource_record_post_action 09:58:52 INFO - Running post-action listener: set_extra_try_arguments 09:58:52 INFO - ##### 09:58:52 INFO - ##### Running populate-webroot step. 09:58:52 INFO - ##### 09:58:52 INFO - Running pre-action listener: _resource_record_pre_action 09:58:52 INFO - Running main action method: populate_webroot 09:58:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:58:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:58:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:58:52 INFO - '--tppagecycles', 09:58:52 INFO - '7'], 09:58:52 INFO - 'tests': ['tsvgm']}}, 09:58:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:58:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:58:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:58:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:58:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:58:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:58:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:52 INFO - 'talos_options': ['--disable-e10s'], 09:58:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:58:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:58:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:52 INFO - 'talos_options': ['--disable-e10s'], 09:58:52 INFO - 'tests': ['damp', 'tps']}, 09:58:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:52 INFO - 'tests': ['damp', 'tps']}, 09:58:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:58:52 INFO - 'tests': ['dromaeo_dom']}, 09:58:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:58:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:58:52 INFO - 'tests': ['a11yr', 09:58:52 INFO - 'ts_paint', 09:58:52 INFO - 'tpaint', 09:58:52 INFO - 'sessionrestore', 09:58:52 INFO - 'sessionrestore_no_auto_restore', 09:58:52 INFO - 'tabpaint']}, 09:58:52 INFO - 'other-e10s': {'tests': ['a11yr', 09:58:52 INFO - 'ts_paint', 09:58:52 INFO - 'tpaint', 09:58:52 INFO - 'sessionrestore', 09:58:52 INFO - 'sessionrestore_no_auto_restore', 09:58:52 INFO - 'tabpaint']}, 09:58:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:58:52 INFO - 'ts_paint', 09:58:52 INFO - 'tpaint', 09:58:52 INFO - 'sessionrestore', 09:58:52 INFO - 'sessionrestore_no_auto_restore', 09:58:52 INFO - 'tabpaint']}, 09:58:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:58:52 INFO - 'ts_paint', 09:58:52 INFO - 'tpaint', 09:58:52 INFO - 'sessionrestore', 09:58:52 INFO - 'sessionrestore_no_auto_restore', 09:58:52 INFO - 'tabpaint']}, 09:58:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:58:52 INFO - 'tests': ['a11yr', 09:58:52 INFO - 'ts_paint', 09:58:52 INFO - 'tpaint', 09:58:52 INFO - 'sessionrestore', 09:58:52 INFO - 'sessionrestore_no_auto_restore', 09:58:52 INFO - 'tabpaint']}, 09:58:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:58:52 INFO - 'tests': ['a11yr', 09:58:52 INFO - 'ts_paint', 09:58:52 INFO - 'tpaint', 09:58:52 INFO - 'sessionrestore', 09:58:52 INFO - 'sessionrestore_no_auto_restore', 09:58:52 INFO - 'tabpaint']}, 09:58:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:58:52 INFO - 'tests': ['tsvgx', 09:58:52 INFO - 'tsvgr_opacity', 09:58:52 INFO - 'tart', 09:58:52 INFO - 'tscrollx', 09:58:52 INFO - 'cart']}, 09:58:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:58:52 INFO - 'tsvgr_opacity', 09:58:52 INFO - 'tart', 09:58:52 INFO - 'tscrollx', 09:58:52 INFO - 'cart']}, 09:58:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:52 INFO - 'talos_options': ['--disable-e10s'], 09:58:52 INFO - 'tests': ['tp5o']}, 09:58:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:52 INFO - 'tests': ['tp5o']}, 09:58:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:52 INFO - 'talos_options': ['--disable-e10s', 09:58:52 INFO - '--xperf_path', 09:58:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:58:52 INFO - 'tests': ['tp5n']}, 09:58:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:52 INFO - 'talos_options': ['--xperf_path', 09:58:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:58:52 INFO - 'tests': ['tp5n']}}, 09:58:52 INFO - 'talos.zip': {'path': '', 09:58:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:58:52 INFO - Running post-action listener: _resource_record_post_action 09:58:52 INFO - ##### 09:58:52 INFO - ##### Running create-virtualenv step. 09:58:52 INFO - ##### 09:58:52 INFO - Running pre-action listener: _resource_record_pre_action 09:58:52 INFO - Running main action method: create_virtualenv 09:58:52 INFO - Creating virtualenv /builds/slave/test/build/venv 09:58:52 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:58:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:58:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:58:52 INFO - Using real prefix '/tools/python27' 09:58:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:58:53 INFO - Installing distribute.............................................................................................................................................................................................done. 09:58:56 INFO - Installing pip.................done. 09:58:56 INFO - Return code: 0 09:58:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:58: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')]} 09:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58: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')]} 09:58:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:56 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 0x10d219a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d229420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed60c5b3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0b8e00>, '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 0x10cf21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0b3b20>, '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.ddS2XBy0tE/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.uZ1zyuSAvl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:58:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:58:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:58:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ddS2XBy0tE/Render', 09:58:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:58:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:58:56 INFO - 'HOME': '/Users/cltbld', 09:58:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:58:56 INFO - 'LOGNAME': 'cltbld', 09:58:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:56 INFO - 'MOZ_NO_REMOTE': '1', 09:58:56 INFO - 'NO_EM_RESTART': '1', 09:58:56 INFO - 'PAGER': '/bin/cat', 09:58:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:58:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:56 INFO - 'PWD': '/builds/slave/test', 09:58:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:58:56 INFO - 'SHELL': '/bin/bash', 09:58:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uZ1zyuSAvl/Listeners', 09:58:56 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 09:58:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:58:56 INFO - 'USER': 'cltbld', 09:58:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:58:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:58:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:56 INFO - 'XPC_FLAGS': '0x0', 09:58:56 INFO - 'XPC_SERVICE_NAME': '0', 09:58:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:58:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:57 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:58:57 INFO - Cleaning up... 09:58:57 INFO - Return code: 0 09:58:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:57 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 0x10d219a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d229420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed60c5b3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0b8e00>, '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 0x10cf21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0b3b20>, '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.ddS2XBy0tE/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.uZ1zyuSAvl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:58:57 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 09:58:57 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 09:58:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ddS2XBy0tE/Render', 09:58:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:58:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:58:57 INFO - 'HOME': '/Users/cltbld', 09:58:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:58:57 INFO - 'LOGNAME': 'cltbld', 09:58:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:57 INFO - 'MOZ_NO_REMOTE': '1', 09:58:57 INFO - 'NO_EM_RESTART': '1', 09:58:57 INFO - 'PAGER': '/bin/cat', 09:58:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:58:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:57 INFO - 'PWD': '/builds/slave/test', 09:58:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:58:57 INFO - 'SHELL': '/bin/bash', 09:58:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uZ1zyuSAvl/Listeners', 09:58:57 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 09:58:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:58:57 INFO - 'USER': 'cltbld', 09:58:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:58:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:58:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:57 INFO - 'XPC_FLAGS': '0x0', 09:58:57 INFO - 'XPC_SERVICE_NAME': '0', 09:58:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:58:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:57 INFO - Downloading/unpacking psutil>=0.7.1 09:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:59:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:59:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:59:00 INFO - Installing collected packages: psutil 09:59:00 INFO - Running setup.py install for psutil 09:59:00 INFO - building 'psutil._psutil_osx' extension 09:59:00 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:59:01 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:59:01 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:59:01 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:59:01 INFO - building 'psutil._psutil_posix' extension 09:59:01 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:59:01 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:59:01 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:59:01 INFO - ^ 09:59:01 INFO - 1 warning generated. 09:59:01 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:59:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:59:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:59:01 INFO - Successfully installed psutil 09:59:01 INFO - Cleaning up... 09:59:01 INFO - Return code: 0 09:59:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:59:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:59:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:01 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 0x10d219a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d229420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed60c5b3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0b8e00>, '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 0x10cf21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0b3b20>, '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.ddS2XBy0tE/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.uZ1zyuSAvl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:59:01 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 09:59:01 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 09:59:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ddS2XBy0tE/Render', 09:59:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:59:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:59:01 INFO - 'HOME': '/Users/cltbld', 09:59:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:59:01 INFO - 'LOGNAME': 'cltbld', 09:59:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:01 INFO - 'MOZ_NO_REMOTE': '1', 09:59:01 INFO - 'NO_EM_RESTART': '1', 09:59:01 INFO - 'PAGER': '/bin/cat', 09:59:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:59:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:01 INFO - 'PWD': '/builds/slave/test', 09:59:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:59:01 INFO - 'SHELL': '/bin/bash', 09:59:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uZ1zyuSAvl/Listeners', 09:59:01 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 09:59:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:59:01 INFO - 'USER': 'cltbld', 09:59:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:59:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:59:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:01 INFO - 'XPC_FLAGS': '0x0', 09:59:01 INFO - 'XPC_SERVICE_NAME': '0', 09:59:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:59:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:59:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:59:04 INFO - Installing collected packages: mozsystemmonitor 09:59:04 INFO - Running setup.py install for mozsystemmonitor 09:59:04 INFO - Successfully installed mozsystemmonitor 09:59:04 INFO - Cleaning up... 09:59:04 INFO - Return code: 0 09:59:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:59:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d219a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d229420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed60c5b3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0b8e00>, '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 0x10cf21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0b3b20>, '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.ddS2XBy0tE/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.uZ1zyuSAvl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:59:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:59:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:59:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ddS2XBy0tE/Render', 09:59:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:59:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:59:04 INFO - 'HOME': '/Users/cltbld', 09:59:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:59:04 INFO - 'LOGNAME': 'cltbld', 09:59:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:04 INFO - 'MOZ_NO_REMOTE': '1', 09:59:04 INFO - 'NO_EM_RESTART': '1', 09:59:04 INFO - 'PAGER': '/bin/cat', 09:59:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:59:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:04 INFO - 'PWD': '/builds/slave/test', 09:59:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:59:04 INFO - 'SHELL': '/bin/bash', 09:59:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uZ1zyuSAvl/Listeners', 09:59:04 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 09:59:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:59:04 INFO - 'USER': 'cltbld', 09:59:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:59:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:59:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:04 INFO - 'XPC_FLAGS': '0x0', 09:59:04 INFO - 'XPC_SERVICE_NAME': '0', 09:59:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:59:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:04 INFO - Downloading/unpacking blobuploader==1.2.4 09:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:07 INFO - Downloading blobuploader-1.2.4.tar.gz 09:59:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:59:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:59:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:08 INFO - Downloading docopt-0.6.1.tar.gz 09:59:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:59:08 INFO - Installing collected packages: blobuploader, requests, docopt 09:59:08 INFO - Running setup.py install for blobuploader 09:59:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:59:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:59:08 INFO - Running setup.py install for requests 09:59:09 INFO - Running setup.py install for docopt 09:59:09 INFO - Successfully installed blobuploader requests docopt 09:59:09 INFO - Cleaning up... 09:59:09 INFO - Return code: 0 09:59:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:59: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')]} 09:59:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59: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')]} 09:59:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:09 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 0x10d219a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d229420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed60c5b3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0b8e00>, '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 0x10cf21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0b3b20>, '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.ddS2XBy0tE/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.uZ1zyuSAvl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:59:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:59:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:59:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ddS2XBy0tE/Render', 09:59:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:59:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:59:09 INFO - 'HOME': '/Users/cltbld', 09:59:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:59:09 INFO - 'LOGNAME': 'cltbld', 09:59:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:09 INFO - 'MOZ_NO_REMOTE': '1', 09:59:09 INFO - 'NO_EM_RESTART': '1', 09:59:09 INFO - 'PAGER': '/bin/cat', 09:59:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:59:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:09 INFO - 'PWD': '/builds/slave/test', 09:59:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:59:09 INFO - 'SHELL': '/bin/bash', 09:59:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uZ1zyuSAvl/Listeners', 09:59:09 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 09:59:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:59:09 INFO - 'USER': 'cltbld', 09:59:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:59:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:59:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:09 INFO - 'XPC_FLAGS': '0x0', 09:59:09 INFO - 'XPC_SERVICE_NAME': '0', 09:59:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:59:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:59:09 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-o8uHW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:59:09 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-3jzmtY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:59:09 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-xa7soO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:59:10 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-sysrF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:59:10 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-87EQLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:59:10 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-ckfpgd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:59:10 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-CM6xa2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:59:10 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-12YHM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:59:10 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-G1cxzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:59:10 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-8RKPzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:59:10 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-d3fqup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:59:10 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-FyA9r5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:59:10 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-MeJwxs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:59:11 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-eJLMbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:59:11 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-OmAQyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:59:11 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-VkLKW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:59:11 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-cYqWw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:59:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:59:11 INFO - Running setup.py install for manifestparser 09:59:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:59:11 INFO - Running setup.py install for mozcrash 09:59:11 INFO - Running setup.py install for mozdebug 09:59:11 INFO - Running setup.py install for mozdevice 09:59:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:59:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:59:12 INFO - Running setup.py install for mozfile 09:59:12 INFO - Running setup.py install for mozhttpd 09:59:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:59:12 INFO - Running setup.py install for mozinfo 09:59:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:59:12 INFO - Running setup.py install for mozInstall 09:59:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:59:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:59:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:59:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:59:12 INFO - Running setup.py install for mozleak 09:59:12 INFO - Running setup.py install for mozlog 09:59:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:59:12 INFO - Running setup.py install for moznetwork 09:59:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:59:13 INFO - Running setup.py install for mozprocess 09:59:13 INFO - Running setup.py install for mozprofile 09:59:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:59:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:59:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:59:13 INFO - Running setup.py install for mozrunner 09:59:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:59:13 INFO - Running setup.py install for mozscreenshot 09:59:13 INFO - Running setup.py install for moztest 09:59:13 INFO - Running setup.py install for mozversion 09:59:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:59:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:59:14 INFO - Cleaning up... 09:59:14 INFO - Return code: 0 09:59:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:59:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:59:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:59:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:14 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 0x10d219a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d229420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed60c5b3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0b8e00>, '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 0x10cf21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0b3b20>, '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.ddS2XBy0tE/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.uZ1zyuSAvl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:59:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:59:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:59:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ddS2XBy0tE/Render', 09:59:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:59:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:59:14 INFO - 'HOME': '/Users/cltbld', 09:59:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:59:14 INFO - 'LOGNAME': 'cltbld', 09:59:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:14 INFO - 'MOZ_NO_REMOTE': '1', 09:59:14 INFO - 'NO_EM_RESTART': '1', 09:59:14 INFO - 'PAGER': '/bin/cat', 09:59:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:59:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:14 INFO - 'PWD': '/builds/slave/test', 09:59:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:59:14 INFO - 'SHELL': '/bin/bash', 09:59:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uZ1zyuSAvl/Listeners', 09:59:14 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 09:59:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:59:14 INFO - 'USER': 'cltbld', 09:59:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:59:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:59:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:14 INFO - 'XPC_FLAGS': '0x0', 09:59:14 INFO - 'XPC_SERVICE_NAME': '0', 09:59:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:59:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:59:14 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-vMclru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:59:14 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:59:14 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-uw6tFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:59:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:59:14 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-WtPWkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:59:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:59:14 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-Nif4MD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:59:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:59:14 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-udx_A3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:59:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:59:14 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-aGI_QE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:59:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:59:14 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-UxbJJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:59:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:59:15 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-yscyJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:59:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:59:15 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-mW80_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:59:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:59:15 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-ZHvDHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:59:15 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)) 09:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:59:15 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-PXmhc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:59:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:59:15 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-iuFTG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:59:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:59:15 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-5LN2pV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:59:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:59:15 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-Mzj2ol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:59:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:59:15 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-pO3tuV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:59:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:59:15 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-1YWadr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:59:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:59:16 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-49xEmw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:59:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:59:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:59:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:59:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:59:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:59:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:59:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:19 INFO - Downloading blessings-1.6.tar.gz 09:59:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:59:19 INFO - Installing collected packages: blessings 09:59:19 INFO - Running setup.py install for blessings 09:59:19 INFO - Successfully installed blessings 09:59:19 INFO - Cleaning up... 09:59:19 INFO - Return code: 0 09:59:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:59:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:59:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:59:19 INFO - Reading from file tmpfile_stdout 09:59:19 INFO - Current package versions: 09:59:19 INFO - blessings == 1.6 09:59:19 INFO - blobuploader == 1.2.4 09:59:19 INFO - docopt == 0.6.1 09:59:19 INFO - manifestparser == 1.1 09:59:19 INFO - mozInstall == 1.12 09:59:19 INFO - mozcrash == 0.17 09:59:19 INFO - mozdebug == 0.1 09:59:19 INFO - mozdevice == 0.48 09:59:19 INFO - mozfile == 1.2 09:59:19 INFO - mozhttpd == 0.7 09:59:19 INFO - mozinfo == 0.9 09:59:19 INFO - mozleak == 0.1 09:59:19 INFO - mozlog == 3.1 09:59:19 INFO - moznetwork == 0.27 09:59:19 INFO - mozprocess == 0.22 09:59:19 INFO - mozprofile == 0.28 09:59:19 INFO - mozrunner == 6.11 09:59:19 INFO - mozscreenshot == 0.1 09:59:19 INFO - mozsystemmonitor == 0.0 09:59:19 INFO - moztest == 0.7 09:59:19 INFO - mozversion == 1.4 09:59:19 INFO - psutil == 3.1.1 09:59:19 INFO - requests == 1.2.3 09:59:19 INFO - wsgiref == 0.1.2 09:59:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:59:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:59:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:19 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 0x10d219a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d229420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed60c5b3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0b8e00>, '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 0x10cf21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0b3b20>, '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.ddS2XBy0tE/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.uZ1zyuSAvl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:59:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:59:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:59:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ddS2XBy0tE/Render', 09:59:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:59:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:59:19 INFO - 'HOME': '/Users/cltbld', 09:59:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:59:19 INFO - 'LOGNAME': 'cltbld', 09:59:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:19 INFO - 'MOZ_NO_REMOTE': '1', 09:59:19 INFO - 'NO_EM_RESTART': '1', 09:59:19 INFO - 'PAGER': '/bin/cat', 09:59:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:59:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:19 INFO - 'PWD': '/builds/slave/test', 09:59:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:59:19 INFO - 'SHELL': '/bin/bash', 09:59:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uZ1zyuSAvl/Listeners', 09:59:19 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 09:59:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:59:19 INFO - 'USER': 'cltbld', 09:59:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:59:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:59:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:19 INFO - 'XPC_FLAGS': '0x0', 09:59:19 INFO - 'XPC_SERVICE_NAME': '0', 09:59:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:59:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:59:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:59:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:59:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:59:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:59:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:59:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:59:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:59:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:59:19 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:59:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:59:19 INFO - Cleaning up... 09:59:19 INFO - Return code: 0 09:59:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:59:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:59:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:19 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 0x10d219a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d229420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed60c5b3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0b8e00>, '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 0x10cf21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0b3b20>, '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.ddS2XBy0tE/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.uZ1zyuSAvl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:59:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:59:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:59:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ddS2XBy0tE/Render', 09:59:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:59:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:59:19 INFO - 'HOME': '/Users/cltbld', 09:59:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:59:19 INFO - 'LOGNAME': 'cltbld', 09:59:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:19 INFO - 'MOZ_NO_REMOTE': '1', 09:59:19 INFO - 'NO_EM_RESTART': '1', 09:59:19 INFO - 'PAGER': '/bin/cat', 09:59:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:59:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:19 INFO - 'PWD': '/builds/slave/test', 09:59:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:59:19 INFO - 'SHELL': '/bin/bash', 09:59:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uZ1zyuSAvl/Listeners', 09:59:19 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 09:59:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:59:19 INFO - 'USER': 'cltbld', 09:59:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:59:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:59:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:19 INFO - 'XPC_FLAGS': '0x0', 09:59:19 INFO - 'XPC_SERVICE_NAME': '0', 09:59:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:59:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:20 INFO - Downloading/unpacking jsonschema 09:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:59:22 INFO - Downloading/unpacking functools32 (from jsonschema) 09:59: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 09:59: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 09:59: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 09:59: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 09:59: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 09:59: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 09:59:23 INFO - Downloading functools32-3.2.3-2.tar.gz 09:59:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:59:23 INFO - warning: no files found matching '*.txt' 09:59:23 INFO - no previously-included directories found matching 'build' 09:59:23 INFO - no previously-included directories found matching 'dist' 09:59:23 INFO - no previously-included directories found matching '.git*' 09:59:23 INFO - Installing collected packages: jsonschema, functools32 09:59:23 INFO - Running setup.py install for functools32 09:59:23 INFO - warning: no files found matching '*.txt' 09:59:23 INFO - no previously-included directories found matching 'build' 09:59:23 INFO - no previously-included directories found matching 'dist' 09:59:23 INFO - no previously-included directories found matching '.git*' 09:59:23 INFO - Successfully installed jsonschema functools32 09:59:23 INFO - Cleaning up... 09:59:23 INFO - Return code: 0 09:59:23 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:59:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:59:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:59:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:23 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 0x10d219a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d229420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed60c5b3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0b8e00>, '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 0x10cf21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0b3b20>, '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.ddS2XBy0tE/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.uZ1zyuSAvl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:59:23 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 09:59:23 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 09:59:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ddS2XBy0tE/Render', 09:59:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:59:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:59:23 INFO - 'HOME': '/Users/cltbld', 09:59:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:59:23 INFO - 'LOGNAME': 'cltbld', 09:59:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:23 INFO - 'MOZ_NO_REMOTE': '1', 09:59:23 INFO - 'NO_EM_RESTART': '1', 09:59:23 INFO - 'PAGER': '/bin/cat', 09:59:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:59:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:23 INFO - 'PWD': '/builds/slave/test', 09:59:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:59:23 INFO - 'SHELL': '/bin/bash', 09:59:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uZ1zyuSAvl/Listeners', 09:59:23 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 09:59:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:59:23 INFO - 'USER': 'cltbld', 09:59:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:59:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:59:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:23 INFO - 'XPC_FLAGS': '0x0', 09:59:23 INFO - 'XPC_SERVICE_NAME': '0', 09:59:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:59:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:23 INFO - Downloading/unpacking flake8 09:59:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:59:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:59:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:59:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:59:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:59:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:59:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:59:27 INFO - no previously-included directories found matching 'docs/_build' 09:59:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:59:27 INFO - Running setup.py install for pep8 09:59:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:59:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:59:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:59:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:59:27 INFO - no previously-included directories found matching 'docs/_build' 09:59:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:59:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:59:27 INFO - Cleaning up... 09:59:27 INFO - Return code: 0 09:59:27 INFO - Running post-action listener: _resource_record_post_action 09:59:27 INFO - Running post-action listener: _start_resource_monitoring 09:59:27 INFO - Starting resource monitoring. 09:59:27 INFO - ##### 09:59:27 INFO - ##### Running install step. 09:59:27 INFO - ##### 09:59:27 INFO - Running pre-action listener: _resource_record_pre_action 09:59:27 INFO - Running main action method: install 09:59:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:59:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:59:28 INFO - Reading from file tmpfile_stdout 09:59:28 INFO - Detecting whether we're running mozinstall >=1.0... 09:59:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:59:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:59:28 INFO - Reading from file tmpfile_stdout 09:59:28 INFO - Output received: 09:59:28 INFO - Usage: mozinstall [options] installer 09:59:28 INFO - Options: 09:59:28 INFO - -h, --help show this help message and exit 09:59:28 INFO - -d DEST, --destination=DEST 09:59:28 INFO - Directory to install application into. [default: 09:59:28 INFO - "/builds/slave/test"] 09:59:28 INFO - --app=APP Application being installed. [default: firefox] 09:59:28 INFO - mkdir: /builds/slave/test/build/application 09:59:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:59:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 09:59:50 INFO - Reading from file tmpfile_stdout 09:59:50 INFO - Output received: 09:59:50 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 09:59:50 INFO - Running post-action listener: _resource_record_post_action 09:59:50 INFO - ##### 09:59:50 INFO - ##### Running run-tests step. 09:59:50 INFO - ##### 09:59:50 INFO - Running pre-action listener: _resource_record_pre_action 09:59:50 INFO - Running main action method: run_tests 09:59:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:59:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:59:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:59:50 INFO - 2016-07-01 09:59:50.638 screenresolution[1640:7602] starting screenresolution argv=screenresolution get 09:59:50 INFO - 2016-07-01 09:59:50.641 screenresolution[1640:7602] Display 0: 1600x1200x32@60 09:59:50 INFO - 2016-07-01 09:59:50.647 screenresolution[1641:7604] starting screenresolution argv=screenresolution list 09:59:50 INFO - Available Modes on Display 0 09:59:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:59:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:59:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:59:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:59:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:59:50 INFO - Intel Iris: 09:59:50 INFO - Chipset Model: Intel Iris 09:59:50 INFO - Type: GPU 09:59:50 INFO - Bus: Built-In 09:59:50 INFO - VRAM (Dynamic, Max): 1536 MB 09:59:50 INFO - Vendor: Intel (0x8086) 09:59:50 INFO - Device ID: 0x0a2e 09:59:50 INFO - Revision ID: 0x0009 09:59:50 INFO - Displays: 09:59:50 INFO - Display: 09:59:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:59:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:59:50 INFO - Display Serial Number: 1600x1200 60 09:59:50 INFO - Main Display: Yes 09:59:50 INFO - Mirror: Off 09:59:50 INFO - Online: Yes 09:59:50 INFO - Rotation: Supported 09:59:50 INFO - Return code: 0 09:59:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:59:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:59:50 INFO - Python 2.7.3 09:59:50 INFO - Return code: 0 09:59:50 INFO - grabbing minidump binary from tooltool 09:59: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')]} 09:59:50 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 0x10d0b8e00>, '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 0x10cf21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0b3b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:59:50 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:59:50 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 09:59:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:59:50 INFO - Return code: 0 09:59:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:59:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:59:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:59:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:59:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:59:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:59:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:59:52 INFO - Return code: 0 09:59:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Jp7YfCxVTTO9uUnLtgbujQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0159', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:59:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Jp7YfCxVTTO9uUnLtgbujQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0159 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:59:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ddS2XBy0tE/Render', 09:59:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:59:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:59:52 INFO - 'HOME': '/Users/cltbld', 09:59:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:59:52 INFO - 'LOGNAME': 'cltbld', 09:59:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:59:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:59:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:52 INFO - 'MOZ_NO_REMOTE': '1', 09:59:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:59:52 INFO - 'NO_EM_RESTART': '1', 09:59:52 INFO - 'PAGER': '/bin/cat', 09:59:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:59:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:52 INFO - 'PWD': '/builds/slave/test', 09:59:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:59:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:59:52 INFO - 'SHELL': '/bin/bash', 09:59:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uZ1zyuSAvl/Listeners', 09:59:52 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 09:59:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:59:52 INFO - 'USER': 'cltbld', 09:59:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:59:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:59:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:52 INFO - 'XPC_FLAGS': '0x0', 09:59:52 INFO - 'XPC_SERVICE_NAME': '0', 09:59:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:59:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Jp7YfCxVTTO9uUnLtgbujQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0159', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:59:52 INFO - mozversion application_buildid: 20160701074922 09:59:52 INFO - mozversion application_changeset: 4c7636b942946b1057c6f8fe5ae92377011a86bf 09:59:52 INFO - mozversion application_display_name: Firefox 09:59:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:59:52 INFO - mozversion application_name: Firefox 09:59:52 INFO - mozversion application_remotingname: firefox 09:59:52 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:59:52 INFO - mozversion application_vendor: Mozilla 09:59:52 INFO - mozversion application_version: 48.0 09:59:52 INFO - mozversion platform_buildid: 20160701074922 09:59:52 INFO - mozversion platform_changeset: 4c7636b942946b1057c6f8fe5ae92377011a86bf 09:59:52 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:59:52 INFO - mozversion platform_version: 48.0 09:59:52 INFO - using testdate: 1467392392 09:59:52 INFO - actual date: 1467392392 09:59:52 INFO - starting webserver on 'localhost:49278' 09:59:52 INFO - SUITE-START | Running 2 tests 09:59:52 INFO - TEST-START | dromaeo_css 09:59:52 INFO - operating with platform_type : mac_ 09:59:52 INFO - Initialising browser for dromaeo_css test... 09:59:52 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/tmpLmHlv_/profile http://localhost:49278/getInfo.html) 09:59:54 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 09:59:54 INFO - PROCESS | 1659 | colorDepth:24 09:59:54 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 09:59:54 INFO - PROCESS | 1659 | __metrics 09:59:55 ERROR - PROCESS | 1659 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 09:59:55 INFO - TEST-INFO | 1659: exit 0 09:59:55 INFO - Browser initialized. 09:59:55 INFO - Running cycle 1/1 for dromaeo_css test... 09:59:55 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/tmpLmHlv_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:00:07 INFO - PROCESS | 1663 | RSS: Main: 171220992 10:00:07 INFO - PROCESS | 1663 | 10:00:57 INFO - PROCESS | 1663 | 1467392457104 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] 10:03:07 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 10:03:08 INFO - PROCESS | 1663 | RSS: Main: 182288384 10:03:08 INFO - PROCESS | 1663 | 10:06:10 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 10:06:11 INFO - PROCESS | 1663 | RSS: Main: 193011712 10:06:11 INFO - PROCESS | 1663 | 10:09:12 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 10:09:13 INFO - PROCESS | 1663 | RSS: Main: 195084288 10:09:13 INFO - PROCESS | 1663 | 10:12:15 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 10:12:15 INFO - PROCESS | 1663 | RSS: Main: 198791168 10:12:15 INFO - PROCESS | 1663 | 10:15:18 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 10:15:19 INFO - PROCESS | 1663 | RSS: Main: 197963776 10:15:19 INFO - PROCESS | 1663 | 10:18:21 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 10:18:21 INFO - PROCESS | 1663 | RSS: Main: 202911744 10:18:21 INFO - PROCESS | 1663 | 10:18:21 INFO - PROCESS | 1663 | __start_tp_report 10:18:21 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 10:18:21 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 10:18:21 INFO - PROCESS | 1663 | |i|pagename|runs| 10:18:21 INFO - PROCESS | 1663 | |0;dojo.html;3670.2475992421555;3698.334299826031;3712.610175931527;3721.5534135903695;3758.2859256741217;5532.972335138319;6069.089636554513;6093.725782339794;6099.481544068754;6132.080187971801;5935.762569497226;6067.726952287147;6090.020743258437;6112.174856394386;6134.969325153368;4415.536368681291;5297.708626025576;5432.619716619838;5468.945310546903;5581.776728930838;4619.145458090247;5378.569714422837;5387.78448862045;5406.053940560406;5497.47773961473;5445.237666726662;5453.972730136364;5464.672119672812;5470.042742520063;5470.699111548864;5446.074167391553;5474.671519708791;5489.560835133179;5506.063969125258;5557.833265002057;5320.707361095138;5451.209574611698;5472.315960504937;5476.479734425223;5505.532029777473;4714.811407543694;5826.621269617462;5873.383294754075;6086.3609321021095;6105.206323178003;6284.057391391282;6315.5894866833505;6338.778142764981;6345.42891139795;6346.936530634727;6338.429541341301;6342.048692696087;6348.841278968017;6350.809475715736;6360.745570177188;6095.573309868267;6120.296165940929;6120.418560236771;6145.4161854623735;6178.764247150543;6519.282878883319;6550.737970481223;6571.4085732283365;6583;6602.900956485657;6268.905966410507;6301.117843501914;6302.810915672537;6307.148534947815;6322;6363.681815909186;6390;6405.391487808651;6431.967840160769;6472.546921715529;6290.2766181889665;6304.5586808922935;6324.620522768649;6352.6823658816875;6353.047042943595;6355.332690067568;6360.077788720702;6360.968195158995;6369.45859601939;6375.585586936927;4997.475265097112;5096.566791822663;5180.222966555047;5196.090684130262;5202.947970520322;4611.16998940194;4637.5130611286;4646.303054541778;4660.207764680013;4674.929876051862;6133.610107582658;6223.159873417121;6225.1907252057845;6231.532635052298;6282.120503129566;5973.880522389528;6335.809925702236;6377.585456945284;6397.8720425592155;6446.903296450557;6241.282252540925;6280.623162610258;6288.339724328971;6293.370662933761;6297.370262973757;5567.66594004361;5699.344575373802;5701.600887937888;5723.284589426322;5743.59794814359;5618.763871948165;6640.568363056386;6737.124173857367;6750.966245168743;6778.966105169541;6400.39196276353;6442.774502892564;6475.158229430144;6481.708323125376;6485.610863348025;6511.218653761579;6599.274079851309;6741.662916854039;6746.4265537429865;6747.865042699217;6326.33573474797;6381.266154392304;6389.265234497906;6399.904001440075;6405.583637063576;6412.070249813844;6442.226932768098;6470.773522926675;6476.255230648348;6488.448481879093;5508.20131080983;6260.092286618324;6285;6300.054991751274;6315.778947736807;4641.930371044505;5217.269582258411;5576.525995290446;5957.057926602209;6290.591111577733;5489.862753431196;5854.707264636666;6173.351798061139;6279.780207692709;6291.591046581958;6192.59748116371;6199.628022318675;6265.906011409924;6273.811785646255;6279.246490421178;5211.713355765318;6247.656378899204;6264.404881536247;6272.341404152498;6272.341404152498 10:18:21 INFO - PROCESS | 1663 | |1;ext.html;544.21768707483;560.5487582496089;575.4619430832171;579.9971000144999;600.8557946092938;38427.80786096069;39274;39380;39411.802940985326;39465.4080188797;40977;41342.58657413425;41367.37948930761;41391.379129313085;41518.79240603793;9731.95134024329;9839.950800245988;9905.950470247675;9918.05778451046;9932.006799320083;9760.219182465386;9905.00949905011;9921.15670168033;10007.699769006942;10010.699679009642;9934;9971.40171589707;9994.750131246705;10075.546600402999;10077.344972576759;9919.256055795844;9964.850527242097;10009.949950250202;10071.647492337734;10073.949630251838;9815.018498150199;9818.165455936254;9943.552540135712;9952.95023524885;9965.20278377728;39269.60730392688;39629;39831;40039.39940900889;40153;3205.3589282143666;3452.723782097426;3511.666391692785;3797.6392242736897;3881.2819628368843;26774.464510709873;27519.724802752116;27535;28374;28738.712612873813;2743.561030235153;2768.1418760184406;2791.148699646607;2805.2425845021935;2893.2188309156622;314327.428362859;314925;315138;319538.4023079893;320485;36926.076848079014;37643.24713505714;37909.86270411892;64920.67539662271;65354;36614.63385366165;36806.44790328147;36890.8155459221;36977;36984;15630.843691562939;16148.75776863348;16310;16323.591910202102;16370.754438683429;13374;13730.45078196881;13739.519116830863;13833.446662133603;13839.169649821042;8195.795105122419;8208.753737387888;8237;8294.626741796514;8508.829823403497;3144.386844565288;3586.444101164324;3605.22487665148;3618.656227658368;3650.8174591270863;869.9695510657097;1128.5937062657438;1161.0885454918018;1165.0504838556549;1167.7781221567875;31088.378232435676;31134.532982004836;31206.375872482422;31675.366492670477;31945.840270798497;1151.5739176504746;1153.9134564907665;1184.5972369394447;1186.845710057687;1217.8538575371012;12983.823449313992;16009.759853602205;16083.115428651303;16295.022298662117;16316.592085197964;684311;687010.5649471821;696293;697172;702500;59434.70282648559;61148.38851611427;61229.69385153046;61262.38737612656;61270.693646532374;1334.8998825087963;1349.9335524935389;1556.4007856975147;1581.351645825206;1656.6024154202905;29433.411331773674;30427.54358684577;30541.04971740705;31041.689583104784;31382;54143.64640883852;54612.453875460735;54878.45121548734;55109.448905510435;56826.44281007282;397388;483059;483686;483977.5801121113;484407;26926;27838.58242126329;28365.71634283631;28614.284642884093;28670;41575.168496630504;44175.11649767051;46032;47821.5217847831;48904.02191956212;32089.67910320867;38088.809555952044;38226.61773382342;38326.04184895288;38838.80580597079;31107.37785244328;34012.82993585016;36790.8160459196;38016.619833801306;38274.2345153101;32589.18527036843;37799.43300850435;38048.80975595104;38474.807625961694;38754.80622596869;30718.232044199074;31564.579593917868;32808.179795505304;32849.67150328466;32906.835465822514;21190.7880921195;25278;25511.87244063768;25723.661605724526;25908.61137082983 10:18:21 INFO - PROCESS | 1663 | |2;jquery.html;366.25284419783645;414.24193725482354;416.22789725059994;416.6396067401698;426.2540554030447;15714.685706285896;20285.695714564292;20775.96120193988;21022.264220752277;21036.89481552594;20595.588088238226;21921.342359729235;22118.009379155872;22162.77837221627;22302.442438939033;4938.358013458245;5285.942811437709;5802.622829516078;6109.450149486545;6118.3269840317525;5896.351401345849;5939.643621382731;6050.394960503959;6057.697115144248;6062.939370606282;5043.773030213631;5833.824985250428;5868.354481007107;5993.490553302952;6037.939620603782;5053.292539044518;5977.193078934331;5994.130851026599;6003.279606447254;6039.456448919618;5022;5277.445868183824;5286.444923283038;5313.335833020872;5314.813981510629;27364.31589210266;27529.44941101167;27630.72369276322;27816.721832781615;28088.578671319945;2207.7902599253043;2377.1917548033753;2448.7306396296394;2623.4359612683365;2664.0276299150864;9712.368696034735;9917.603295868157;10240.180785537214;10362.222833287533;15061.322240499094;1797.5506123469133;1829.670659281342;1831.9908400458046;1845.3817970979737;1861.8138186181272;113693.4315328418;118173.40913295465;119121.40439297835;119909;119993;11870.287782733063;12037.638870833889;12065.577704780291;12085.066389377658;12154.270743755404;15265.3893844245;15559.688806224038;15561.377544898303;15562.377504899678;15618.9219053904;7524.435667324972;7768.922310776933;9134.492808686626;9311.860322095174;9374.718758437259;9164.312676549285;9498.857517137249;9533.998930112377;9585.376950498196;9599.280053995979;3958.5843486434087;4849;4863.927041094386;4893.584045356113;4897.975510122498;2016.2842191022269;2047.3857842647146;2065.10168076887;2079.064421010551;2115.9788402115782;773.2113244490588;824.3240542755003;824.6577670266892;913.3104506097853;970.834958057132;17025.574360641083;17111.91444042797;21107.78892211089;21294.148234070773;21382.786172138392;851.8807366968506;1006.3659894266711;1033.5245786938092;1053.4995876958383;1060.7401186709305;11126.443677816076;11485.483153258123;11515.25150865191;11537.942310288396;11557.422128893522;460882;611303;614667;635080;665292;99412.5029374863;105621.47189264004;109710;114893.85106148999;119830.4008479952;902.4810733828075;1040.5161599856103;1055.9260851740305;1114.1031469666834;1115.3976852499559;15189.104701982122;15705.13621750769;18652.880827150413;19333.806661933202;19521.414357569294;38334.42498362471;45505.86235344143;51671;52957.20564191463;53576.73211633917;72558.91161632685;72687.63656181685;79574;80085;80119.79820302817;7498.550086994798;8047.476914000571;8361;8415.915840841759;8489.702860399857;10056.899431005597;11005.944970275097;11178.720531986766;12477.064220183704;12676.873231267939;8827.955860220658;9516.904830951602;9931.801363972536;10860.837087443537;11219.943900280447;11026.614068507564;11037.834432483358;11128.332300062022;11352.148588855704;11461.770764584828;11136.16478764112;11487.425628718363;11727.35499547533;11847.466863990969;11882.82175767347;6990.335918087773;8264.958675206586;8375.623096960773;8398.370122240734;8418.663253470038;8332.708355207538;10397.116245118947;11315.773684526428;11397;11680 10:18:21 INFO - PROCESS | 1663 | |3;mootools.html;1424.3092100331337;1652.5207689769968;1677.5386768638623;2071.523549583596;2078.241441873715;8170.4280700351;8790.47257164569;8909.688160914362;9100.271978241733;9108.817823643523;8897.555122243879;8945.194932456077;8951.283897288218;9032.141946515087;9107.271418286538;2521.218422289087;2527.7851382632452;2529.2285852814884;2548.961765573518;2572.318335641057;2174.793394627508;2498.9375265618323;2562.9102981395654;2575.484903019394;2594.8962041518316;2517.6223566465087;2531.1773673556077;2573.137998770414;2579.742025797424;2582;2541.6568763217006;2566.1275166443497;2567.8844451999703;2568.036986130201;2582.9870850645625;2532.4048848520583;2548.604966230237;2567.7047139579;2568.191019828748;2596.9870150649313;9164.266858651292;9185.954070229673;9203.493807840567;9207.079292070806;9210.95394523023;5629.127485239795;5662.915056274118;5668.886622267572;5680.488756011979;5750.971245143747;3653.050206946213;3749.250149970017;3789.0906182515996;3793.696504279651;3802.125511132427;1050.7793363393696;1070.379180075562;1074.0762943868267;1079.865016872891;1091.8689757229183;12060.879391206063;12080.456379462945;12093.57672481459;12348.073894457862;12358.505659773598;4926.75366231687;4988.90022199554;5096.311997880312;5102.744862756922;5111.769970351269;10282.897171028344;10325.32885362464;10462.529186186639;10489.160867130611;10525.36847789135;5574.777008919597;5584.21820945068;5664.461876121762;5675.602707810496;5753.539716822645;4652.976735116303;5068.315777370081;5122.590192784568;5157.200633901676;5179.22311653255;4169.1661667666585;4184.958150418457;4316.223079845595;4325.4593175853015;4359.564043595615;1400.6358346829693;1435.777454494555;1436.992815035918;1445.3062529985666;1445.985540144585;943.5423819447562;955.9044095590524;960.279790157382;963.9614415423305;1007.7631756537207;5941.702914854326;5965.135055417027;6009.399060094043;6136.263648362135;6173.135760993465;453.51926957425235;461.96997195182206;465.0953894674825;470.0317346266633;471.0837421215771;4004.979975100106;4087.05997620543;4110.260153172458;4125.793710314472;4178.206140833232;9091.590878410487;10605.787884242272;10946.562137514411;10979.615713449992;11043.39261340634;10237.9488102559;10258.794824103476;10506.474676266156;10598.410238464137;10622.89377106219;7064.823379415556;7072.611006394698;8183.672653093929;8291.875621865676;8369.288610468178;6043.969780151071;6068.6965651716355;6090.665013424305;6128.387161283836;6200.534959877937;8061.951946246951;9190.40262382943;9453.810923781624;9480.668176613786;9881.258905581966;8156.796080098045;9765.462899540309;9857.901420985698;10042.849357259502;10156;6967.1291088613925;7451.478396512192;7599.772006839804;7616.8476630465975;7744.993150890348;8282.50304981703;8356.373272004503;8418.158184181533;8448.788780280542;8460.915390846012;7444.73943411978;7592.620368981639;7604.695812167452;7610.238976102345;7692.846143076995;7375.483716140034;7401.111866576045;7455.925440745523;7536.794112941903;7544.660490277841;7126;7183.245759195418;7197.856042879218;7215.062041934725;7231.842905135153;4978.352814134139;4983.925241121458;5075.1625981712605;5180.585553155664;5183.50756678115;4346.804393802223;5027.497250274943;5103.4386217516785;5136.203888397305;5208.453112423141 10:18:21 INFO - PROCESS | 1663 | |4;prototype.html;308.8008234688626;315.9889403870865;317.3858583640657;339.55857385398974;340.3261542146549;6245.156903817983;6409.13476680648;6883.827904302395;7027.191872934614;7113.964430177848;5588.748506317215;6589.604623722568;7043.823904402392;7079.6814143363545;7083.114610673666;5178.637495375326;5201.739913004353;5209.921851172236;5211.218317252424;5218.817341393052;5195.714235717034;5217;5220.373555173384;5239.607029472786;5241.73791310433;4235.9788201058955;5107.642465027449;5151.330327057477;5162.122439185328;5164.070467315882;4841.8063277468855;4887.022595480882;5063.696178229318;5160.122779127557;5163.993021360836;3669.21111960927;4230.746155230665;4259.680523960685;4266.722663026924;4298.226319262531;6099.878002439927;6665.100211471437;6782.016607591871;6789.898151527731;6793.830154246183;5210.426853046162;6023.096535519663;6030.96984515079;6046.123312119718;6051.727672254759;5249.845034092532;5622.3253209614695;6859.07402500661;7417.406607471389;7505.587192704399;4676.854170728159;4712.198926182557;4801.8079276828885;4965.77654005567;4984.501549845023;6099.420555047263;7901.249381308767;7963.482373645695;7993.600319984036;8100.797480062986;5095.210242412358;5099.311592934906;5099.745012749348;5105.106606343875;5110.488951104934;5202.2456743771945;5203.843884683465;5205.2192171173865;5215.852512447255;5216.37403511581;6041;6042.758289668452;6043.456088952015;6051.546134039964;6061.848453788691;7422.765505856402;7544.132424771112;7614.428917831185;7623.733169339046;7634;1792.7669402977529;1802.1980218802769;1815.4372144635206;1816.8819026763217;1820.2991848138563;1070.2240875365453;1127.8308253762002;1137.311926284586;1149.6263714292888;1165.976680466386;7125.3230943060325;7127.46544009191;7155.749548765768;7173.5337203081635;7180.928190718026;7816.648250828726;7838.333741631911;7849.097353804272;7855.607219638995;7870;7150.892736608955;7151.7854464366155;7164.928350716426;7167.104111986002;7197.640117994079;4026.416169655442;4111.239420707178;4151.46031015966;4165.854195103157;4193.412922190896;8289.129641387688;8359.95820020896;8380.497170169809;8385.077641459435;8390.874136887951;6568.474522038321;6905.205901321412;8228.958855205685;8230.465019773696;8246.340292776564;8050.879236811453;8342.791430214293;8370.288525475282;8373.623186956602;8403.621837017348;7642.082950045808;7940.404469664913;7979.16218797018;7981.920180798118;8020.157883422156;7768.689252430066;7786.688532458865;7808;7837.725679601187;7848.686052557834;7275.599842008529;7774.378049756119;8342.958285208535;8349.99800024001;8379.664813407395;4784.928226076542;4803.471618122074;4808.927866081942;4813.4945830687275;4825.059113472839;7583.924160758322;7823.960880195563;7832.373410127062;7842.64708088126;7854.978852749106;7482.625868706434;7540.359069479156;7611.847763044819;7624.8475030500185;7628.237176282328;7397.668419684508;7551;7602.7339043135435;7610.048743907012;7653.0816302041885;7252.673629686782;7421.369183619453;7430.331270185709;7499.100107987077;7513.699452022077;7352.48532602734;7631.046119235096;7655.349295309961;7672.347850432776;7677.965339185233;5979.641221526722;6014.72933717975;6669.4664426844765;7419.406447484296;7453 10:18:21 INFO - PROCESS | 1663 | |5;yui.html;688.088283024992;727.6107282603807;774.6475353714058;782.4561929459027;789.9368050555956;15446.691066178684;15587;15683.059016459007;15717.607059823511;15725.977811442248;14468.92765536171;14494.710105797878;14521.419143234258;14530.20083895388;14551.199684017374;776.4215659333776;932.822763674903;938.1790932933683;952.5618215620823;955.1833182628822;921.2537844346068;922.5341202692664;946.3612061858253;957.6121670723368;961.9711408657716;981.4307701533094;1013.0679774607343;1015.96952091437;1022.269077609509;1023.9846402303972;969.1471505075524;970.0929630795229;985.6747273399761;987.323683276954;1008.5612758450061;733.2044731466366;753.4688044928313;761.801931497809;762.5691484311346;764.1556080530988;14805.407783688639;15129.319180636898;15234.390624375012;15327.310271037719;15334.9233253833;13443.865561344359;13469.663258418519;13472.932635336761;13618.387172577159;13667.863321366858;9846.359986600919;10443.164546836235;10491.632792852213;10513.316634418814;10550.683479495627;3569.3218288525095;3703.8333275002688;3715.665590096877;3725.66469017787;3797.810109494514;76333;77883;78090;79256.60371698163;79312.41375172522;9527.333086683866;9578.90421095794;9703.854442183372;9803.558839852223;9968.302218844612;16298.755518667229;18455.723164152547;20793.688094678593;21366.78633213679;21547;7716.498427602188;7817.765467035998;7871.921280787234;7951.125376208613;8144.5520496373265;4038.8788336349958;4045.4943132108488;4069.4302797608357;4135.379693046068;4204.495460544754;3631.618680038558;3632.909177270589;3643.653852883972;3650.8539658413365;3710.332140214787;694.1080711285973;703.8416356319788;704.9400800931876;710.6198183971551;718.6586371473613;584.8771757930797;604.3291945940003;609.250621735268;610.3713175429315;620.3548309757801;8486.19381158789;8564.828703425897;8598.613062412081;8688.218060374596;8709.695160669346;570.7431655754926;578.94789468948;598.5720210049835;600.5225845452876;654.1300070905684;3237.206884313311;4055.249778790874;4192.45498085247;4268.743875367426;4309.073549186877;98699;99268.02927882948;99639.00360996442;100855.48716769254;102792;84784.57607712045;84953.72569411463;85900.57049714711;86134;86238.7064194025;71092.64453677699;71749.64125179341;74080.88878666825;75786.62106689431;76597;8667.566621669017;8905.287576993955;8927.018028017043;8962.879640044994;9055.864162037444;47500.7624961873;49016.5098349012;51597.7420112897;53747.73126134344;53760;72567.63716181596;75056.62471687606;75259;75790;76537.46925061579;11302.773944520899;11401.714957126138;11645.184837061324;11687.824682629598;11821.408929553316;12138.393080346124;12182.878171218174;12265.938670306592;12397.318147501974;12540.749185016066;11563.074954003827;11566.30602163873;11692.181547291608;11884.881151188378;12387.132900696864;11700.648980530597;11787.292762434281;11804.996575291196;11838.526458941546;11852.525898963944;11344.319340839576;11380.715482113013;11578.71053223676;11615.825762613398;11787.233829801036;9845.704628861145;9953.104220619889;10090.09189172978;10321.63874264397;10380.792384152426;8883.777905552155;9088.454692718458;9845.704628861145;9912.207023438252;9960.203183745138 10:18:21 INFO - PROCESS | 1663 | __end_tp_report 10:18:21 INFO - PROCESS | 1663 | __start_cc_report 10:18:21 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,402 10:18:21 INFO - PROCESS | 1663 | __end_cc_report 10:18:21 INFO - PROCESS | 1663 | __startTimestamp1467393501421__endTimestamp 10:18:21 INFO - PROCESS | 1663 | 10:18:21 INFO - PROCESS | 1663 | ------- Summary: start ------- 10:18:21 INFO - PROCESS | 1663 | Number of tests: 6 10:18:21 INFO - PROCESS | 1663 | 10:18:21 INFO - PROCESS | 1663 | [#0] dojo.html Cycles:165 Average:5935.98 Median:6241.28 stddev:659.33 (10.6%) stddev-sans-first:636.94 10:18:21 INFO - PROCESS | 1663 | Values: 3670.2 3698.3 3712.6 3721.6 3758.3 5533.0 6069.1 6093.7 6099.5 6132.1 5935.8 6067.7 6090.0 6112.2 6135.0 4415.5 5297.7 5432.6 5468.9 5581.8 4619.1 5378.6 5387.8 5406.1 5497.5 5445.2 5454.0 5464.7 5470.0 5470.7 5446.1 5474.7 5489.6 5506.1 5557.8 5320.7 5451.2 5472.3 5476.5 5505.5 4714.8 5826.6 5873.4 6086.4 6105.2 6284.1 6315.6 6338.8 6345.4 6346.9 6338.4 6342.0 6348.8 6350.8 6360.7 6095.6 6120.3 6120.4 6145.4 6178.8 6519.3 6550.7 6571.4 6583.0 6602.9 6268.9 6301.1 6302.8 6307.1 6322.0 6363.7 6390.0 6405.4 6432.0 6472.5 6290.3 6304.6 6324.6 6352.7 6353.0 6355.3 6360.1 6361.0 6369.5 6375.6 4997.5 5096.6 5180.2 5196.1 5202.9 4611.2 4637.5 4646.3 4660.2 4674.9 6133.6 6223.2 6225.2 6231.5 6282.1 5973.9 6335.8 6377.6 6397.9 6446.9 6241.3 6280.6 6288.3 6293.4 6297.4 5567.7 5699.3 5701.6 5723.3 5743.6 5618.8 6640.6 6737.1 6751.0 6779.0 6400.4 6442.8 6475.2 6481.7 6485.6 6511.2 6599.3 6741.7 6746.4 6747.9 6326.3 6381.3 6389.3 6399.9 6405.6 6412.1 6442.2 6470.8 6476.3 6488.4 5508.2 6260.1 6285.0 6300.1 6315.8 4641.9 5217.3 5576.5 5957.1 6290.6 5489.9 5854.7 6173.4 6279.8 6291.6 6192.6 6199.6 6265.9 6273.8 6279.2 5211.7 6247.7 6264.4 6272.3 6272.3 10:18:21 INFO - PROCESS | 1663 | 10:18:21 INFO - PROCESS | 1663 | [#1] ext.html Cycles:180 Average:62402.31 Median:36848.63 stddev:138630.69 (376.2%) stddev-sans-first:138941.78 10:18:21 INFO - PROCESS | 1663 | Values: 544.2 560.5 575.5 580.0 600.9 38427.8 39274.0 39380.0 39411.8 39465.4 40977.0 41342.6 41367.4 41391.4 41518.8 9732.0 9840.0 9906.0 9918.1 9932.0 9760.2 9905.0 9921.2 10007.7 10010.7 9934.0 9971.4 9994.8 10075.5 10077.3 9919.3 9964.9 10009.9 10071.6 10073.9 9815.0 9818.2 9943.6 9953.0 9965.2 39269.6 39629.0 39831.0 40039.4 40153.0 3205.4 3452.7 3511.7 3797.6 3881.3 26774.5 27519.7 27535.0 28374.0 28738.7 2743.6 2768.1 2791.1 2805.2 2893.2 314327.4 314925.0 315138.0 319538.4 320485.0 36926.1 37643.2 37909.9 64920.7 65354.0 36614.6 36806.4 36890.8 36977.0 36984.0 15630.8 16148.8 16310.0 16323.6 16370.8 13374.0 13730.5 13739.5 13833.4 13839.2 8195.8 8208.8 8237.0 8294.6 8508.8 3144.4 3586.4 3605.2 3618.7 3650.8 870.0 1128.6 1161.1 1165.1 1167.8 31088.4 31134.5 31206.4 31675.4 31945.8 1151.6 1153.9 1184.6 1186.8 1217.9 12983.8 16009.8 16083.1 16295.0 16316.6 684311.0 687010.6 696293.0 697172.0 702500.0 59434.7 61148.4 61229.7 61262.4 61270.7 1334.9 1349.9 1556.4 1581.4 1656.6 29433.4 30427.5 30541.0 31041.7 31382.0 54143.6 54612.5 54878.5 55109.4 56826.4 397388.0 483059.0 483686.0 483977.6 484407.0 26926.0 27838.6 28365.7 28614.3 28670.0 41575.2 44175.1 46032.0 47821.5 48904.0 32089.7 38088.8 38226.6 38326.0 38838.8 31107.4 34012.8 36790.8 38016.6 38274.2 32589.2 37799.4 38048.8 38474.8 38754.8 30718.2 31564.6 32808.2 32849.7 32906.8 21190.8 25278.0 25511.9 25723.7 25908.6 10:18:21 INFO - PROCESS | 1663 | 10:18:21 INFO - PROCESS | 1663 | [#2] jquery.html Cycles:180 Average:34436.31 Median:15014.17 stddev:99971.06 (665.8%) stddev-sans-first:100218.78 10:18:21 INFO - PROCESS | 1663 | Values: 366.3 414.2 416.2 416.6 426.3 15714.7 20285.7 20776.0 21022.3 21036.9 20595.6 21921.3 22118.0 22162.8 22302.4 4938.4 5285.9 5802.6 6109.5 6118.3 5896.4 5939.6 6050.4 6057.7 6062.9 5043.8 5833.8 5868.4 5993.5 6037.9 5053.3 5977.2 5994.1 6003.3 6039.5 5022.0 5277.4 5286.4 5313.3 5314.8 27364.3 27529.4 27630.7 27816.7 28088.6 2207.8 2377.2 2448.7 2623.4 2664.0 9712.4 9917.6 10240.2 10362.2 15061.3 1797.6 1829.7 1832.0 1845.4 1861.8 113693.4 118173.4 119121.4 119909.0 119993.0 11870.3 12037.6 12065.6 12085.1 12154.3 15265.4 15559.7 15561.4 15562.4 15618.9 7524.4 7768.9 9134.5 9311.9 9374.7 9164.3 9498.9 9534.0 9585.4 9599.3 3958.6 4849.0 4863.9 4893.6 4898.0 2016.3 2047.4 2065.1 2079.1 2116.0 773.2 824.3 824.7 913.3 970.8 17025.6 17111.9 21107.8 21294.1 21382.8 851.9 1006.4 1033.5 1053.5 1060.7 11126.4 11485.5 11515.3 11537.9 11557.4 460882.0 611303.0 614667.0 635080.0 665292.0 99412.5 105621.5 109710.0 114893.9 119830.4 902.5 1040.5 1055.9 1114.1 1115.4 15189.1 15705.1 18652.9 19333.8 19521.4 38334.4 45505.9 51671.0 52957.2 53576.7 72558.9 72687.6 79574.0 80085.0 80119.8 7498.6 8047.5 8361.0 8415.9 8489.7 10056.9 11005.9 11178.7 12477.1 12676.9 8828.0 9516.9 9931.8 10860.8 11219.9 11026.6 11037.8 11128.3 11352.1 11461.8 11136.2 11487.4 11727.4 11847.5 11882.8 6990.3 8265.0 8375.6 8398.4 8418.7 8332.7 10397.1 11315.8 11397.0 11680.0 10:18:21 INFO - PROCESS | 1663 | 10:18:21 INFO - PROCESS | 1663 | [#3] mootools.html Cycles:180 Average:5818.30 Median:5085.74 stddev:3176.23 (62.5%) stddev-sans-first:3167.97 10:18:21 INFO - PROCESS | 1663 | Values: 1424.3 1652.5 1677.5 2071.5 2078.2 8170.4 8790.5 8909.7 9100.3 9108.8 8897.6 8945.2 8951.3 9032.1 9107.3 2521.2 2527.8 2529.2 2549.0 2572.3 2174.8 2498.9 2562.9 2575.5 2594.9 2517.6 2531.2 2573.1 2579.7 2582.0 2541.7 2566.1 2567.9 2568.0 2583.0 2532.4 2548.6 2567.7 2568.2 2597.0 9164.3 9186.0 9203.5 9207.1 9211.0 5629.1 5662.9 5668.9 5680.5 5751.0 3653.1 3749.3 3789.1 3793.7 3802.1 1050.8 1070.4 1074.1 1079.9 1091.9 12060.9 12080.5 12093.6 12348.1 12358.5 4926.8 4988.9 5096.3 5102.7 5111.8 10282.9 10325.3 10462.5 10489.2 10525.4 5574.8 5584.2 5664.5 5675.6 5753.5 4653.0 5068.3 5122.6 5157.2 5179.2 4169.2 4185.0 4316.2 4325.5 4359.6 1400.6 1435.8 1437.0 1445.3 1446.0 943.5 955.9 960.3 964.0 1007.8 5941.7 5965.1 6009.4 6136.3 6173.1 453.5 462.0 465.1 470.0 471.1 4005.0 4087.1 4110.3 4125.8 4178.2 9091.6 10605.8 10946.6 10979.6 11043.4 10237.9 10258.8 10506.5 10598.4 10622.9 7064.8 7072.6 8183.7 8291.9 8369.3 6044.0 6068.7 6090.7 6128.4 6200.5 8062.0 9190.4 9453.8 9480.7 9881.3 8156.8 9765.5 9857.9 10042.8 10156.0 6967.1 7451.5 7599.8 7616.8 7745.0 8282.5 8356.4 8418.2 8448.8 8460.9 7444.7 7592.6 7604.7 7610.2 7692.8 7375.5 7401.1 7455.9 7536.8 7544.7 7126.0 7183.2 7197.9 7215.1 7231.8 4978.4 4983.9 5075.2 5180.6 5183.5 4346.8 5027.5 5103.4 5136.2 5208.5 10:18:21 INFO - PROCESS | 1663 | 10:18:21 INFO - PROCESS | 1663 | [#4] prototype.html Cycles:180 Average:6123.43 Median:6826.45 stddev:1988.66 (29.1%) stddev-sans-first:1945.76 10:18:21 INFO - PROCESS | 1663 | Values: 308.8 316.0 317.4 339.6 340.3 6245.2 6409.1 6883.8 7027.2 7114.0 5588.7 6589.6 7043.8 7079.7 7083.1 5178.6 5201.7 5209.9 5211.2 5218.8 5195.7 5217.0 5220.4 5239.6 5241.7 4236.0 5107.6 5151.3 5162.1 5164.1 4841.8 4887.0 5063.7 5160.1 5164.0 3669.2 4230.7 4259.7 4266.7 4298.2 6099.9 6665.1 6782.0 6789.9 6793.8 5210.4 6023.1 6031.0 6046.1 6051.7 5249.8 5622.3 6859.1 7417.4 7505.6 4676.9 4712.2 4801.8 4965.8 4984.5 6099.4 7901.2 7963.5 7993.6 8100.8 5095.2 5099.3 5099.7 5105.1 5110.5 5202.2 5203.8 5205.2 5215.9 5216.4 6041.0 6042.8 6043.5 6051.5 6061.8 7422.8 7544.1 7614.4 7623.7 7634.0 1792.8 1802.2 1815.4 1816.9 1820.3 1070.2 1127.8 1137.3 1149.6 1166.0 7125.3 7127.5 7155.7 7173.5 7180.9 7816.6 7838.3 7849.1 7855.6 7870.0 7150.9 7151.8 7164.9 7167.1 7197.6 4026.4 4111.2 4151.5 4165.9 4193.4 8289.1 8360.0 8380.5 8385.1 8390.9 6568.5 6905.2 8229.0 8230.5 8246.3 8050.9 8342.8 8370.3 8373.6 8403.6 7642.1 7940.4 7979.2 7981.9 8020.2 7768.7 7786.7 7808.0 7837.7 7848.7 7275.6 7774.4 8343.0 8350.0 8379.7 4784.9 4803.5 4808.9 4813.5 4825.1 7583.9 7824.0 7832.4 7842.6 7855.0 7482.6 7540.4 7611.8 7624.8 7628.2 7397.7 7551.0 7602.7 7610.0 7653.1 7252.7 7421.4 7430.3 7499.1 7513.7 7352.5 7631.0 7655.3 7672.3 7678.0 5979.6 6014.7 6669.5 7419.4 7453.0 10:18:21 INFO - PROCESS | 1663 | 10:18:21 INFO - PROCESS | 1663 | [#5] yui.html Cycles:180 Average:19153.34 Median:581.91 stddev:27276.30 (4687.4%) stddev-sans-first:27317.58 10:18:21 INFO - PROCESS | 1663 | Values: 688.1 727.6 774.6 782.5 789.9 15446.7 15587.0 15683.1 15717.6 15726.0 14468.9 14494.7 14521.4 14530.2 14551.2 776.4 932.8 938.2 952.6 955.2 921.3 922.5 946.4 957.6 962.0 981.4 1013.1 1016.0 1022.3 1024.0 969.1 970.1 985.7 987.3 1008.6 733.2 753.5 761.8 762.6 764.2 14805.4 15129.3 15234.4 15327.3 15334.9 13443.9 13469.7 13472.9 13618.4 13667.9 9846.4 10443.2 10491.6 10513.3 10550.7 3569.3 3703.8 3715.7 3725.7 3797.8 76333.0 77883.0 78090.0 79256.6 79312.4 9527.3 9578.9 9703.9 9803.6 9968.3 16298.8 18455.7 20793.7 21366.8 21547.0 7716.5 7817.8 7871.9 7951.1 8144.6 4038.9 4045.5 4069.4 4135.4 4204.5 3631.6 3632.9 3643.7 3650.9 3710.3 694.1 703.8 704.9 710.6 718.7 584.9 604.3 609.3 610.4 620.4 8486.2 8564.8 8598.6 8688.2 8709.7 570.7 578.9 598.6 600.5 654.1 3237.2 4055.2 4192.5 4268.7 4309.1 98699.0 99268.0 99639.0 100855.5 102792.0 84784.6 84953.7 85900.6 86134.0 86238.7 71092.6 71749.6 74080.9 75786.6 76597.0 8667.6 8905.3 8927.0 8962.9 9055.9 47500.8 49016.5 51597.7 53747.7 53760.0 72567.6 75056.6 75259.0 75790.0 76537.5 11302.8 11401.7 11645.2 11687.8 11821.4 12138.4 12182.9 12265.9 12397.3 12540.7 11563.1 11566.3 11692.2 11884.9 12387.1 11700.6 11787.3 11805.0 11838.5 11852.5 11344.3 11380.7 11578.7 11615.8 11787.2 9845.7 9953.1 10090.1 10321.6 10380.8 8883.8 9088.5 9845.7 9912.2 9960.2 10:18:21 INFO - PROCESS | 1663 | -------- Summary: end -------- 10:18:21 INFO - PROCESS | 1663 | 10:18:21 INFO - TEST-INFO | 1663: exit 0 10:18:21 INFO - TEST-OK | dromaeo_css | took 1109641ms 10:18:21 INFO - TEST-START | kraken 10:18:21 INFO - operating with platform_type : mac_ 10:18:21 INFO - Initialising browser for kraken test... 10:18:21 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/tmpwvSJ3j/profile http://localhost:49278/getInfo.html) 10:18:24 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 10:18:24 INFO - PROCESS | 1672 | colorDepth:24 10:18:24 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 10:18:24 INFO - PROCESS | 1672 | __metrics 10:18:24 ERROR - PROCESS | 1672 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 10:18:25 INFO - TEST-INFO | 1672: exit 0 10:18:25 INFO - Browser initialized. 10:18:25 INFO - Running cycle 1/1 for kraken test... 10:18:25 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/tmpwvSJ3j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:18:37 INFO - PROCESS | 1676 | RSS: Main: 171438080 10:18:37 INFO - PROCESS | 1676 | 10:18:39 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 10:18:40 INFO - PROCESS | 1676 | RSS: Main: 183808000 10:18:40 INFO - PROCESS | 1676 | 10:18:43 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 10:18:43 INFO - PROCESS | 1676 | RSS: Main: 192434176 10:18:43 INFO - PROCESS | 1676 | 10:18:47 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 10:18:48 INFO - PROCESS | 1676 | RSS: Main: 194465792 10:18:48 INFO - PROCESS | 1676 | 10:18:50 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 10:18:50 INFO - PROCESS | 1676 | RSS: Main: 196907008 10:18:50 INFO - PROCESS | 1676 | 10:18:52 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:18:53 INFO - PROCESS | 1676 | RSS: Main: 197677056 10:18:53 INFO - PROCESS | 1676 | 10:18:56 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 10:18:56 INFO - PROCESS | 1676 | RSS: Main: 197840896 10:18:56 INFO - PROCESS | 1676 | 10:18:59 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 10:19:00 INFO - PROCESS | 1676 | RSS: Main: 198025216 10:19:00 INFO - PROCESS | 1676 | 10:19:03 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 10:19:03 INFO - PROCESS | 1676 | RSS: Main: 198311936 10:19:03 INFO - PROCESS | 1676 | 10:19:05 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:19:05 INFO - PROCESS | 1676 | RSS: Main: 197779456 10:19:05 INFO - PROCESS | 1676 | 10:19:07 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:19:08 INFO - PROCESS | 1676 | RSS: Main: 197939200 10:19:08 INFO - PROCESS | 1676 | 10:19:10 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:19:11 INFO - PROCESS | 1676 | RSS: Main: 198184960 10:19:11 INFO - PROCESS | 1676 | 10:19:13 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:19:14 INFO - PROCESS | 1676 | RSS: Main: 198336512 10:19:14 INFO - PROCESS | 1676 | 10:19:17 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:19:18 INFO - PROCESS | 1676 | RSS: Main: 198275072 10:19:18 INFO - PROCESS | 1676 | 10:19:19 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 10:19:20 INFO - PROCESS | 1676 | RSS: Main: 200208384 10:19:20 INFO - PROCESS | 1676 | 10:19:20 INFO - PROCESS | 1676 | __start_tp_report 10:19:20 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 10:19:20 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 10:19:20 INFO - PROCESS | 1676 | |i|pagename|runs| 10:19:20 INFO - PROCESS | 1676 | |0;ai-astar;117;110;116;118;118;130;116;116;128;169 10:19:20 INFO - PROCESS | 1676 | |1;audio-beat-detection;153;121;137;157;119;142;157;146;168;152 10:19:20 INFO - PROCESS | 1676 | |2;audio-dft;220;267;193;193;200;219;260;284;236;198 10:19:20 INFO - PROCESS | 1676 | |3;audio-fft;65;82;72;134;58;57;57;65;127;56 10:19:20 INFO - PROCESS | 1676 | |4;audio-oscillator;77;81;120;79;85;85;117;80;81;133 10:19:20 INFO - PROCESS | 1676 | |5;imaging-gaussian-blur;116;87;90;88;104;115;92;90;130;86 10:19:20 INFO - PROCESS | 1676 | |6;imaging-darkroom;96;95;96;97;96;97;96;98;92;97 10:19:20 INFO - PROCESS | 1676 | |7;imaging-desaturate;108;80;142;146;91;90;92;90;90;90 10:19:20 INFO - PROCESS | 1676 | |8;json-parse-financial;59;62;65;64;65;65;65;79;62;61 10:19:20 INFO - PROCESS | 1676 | |9;json-stringify-tinderbox;64;66;66;75;70;79;71;66;66;69 10:19:20 INFO - PROCESS | 1676 | |10;stanford-crypto-aes;78;99;68;71;94;104;71;95;112;108 10:19:20 INFO - PROCESS | 1676 | |11;stanford-crypto-ccm;130;131;118;161;118;140;142;147;155;136 10:19:20 INFO - PROCESS | 1676 | |12;stanford-crypto-pbkdf2;163;164;184;216;170;165;166;184;165;227 10:19:20 INFO - PROCESS | 1676 | |13;stanford-crypto-sha256-iterative;68;68;70;65;68;68;66;66;67;71 10:19:20 INFO - PROCESS | 1676 | __end_tp_report 10:19:20 INFO - PROCESS | 1676 | __start_cc_report 10:19:20 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,1038 10:19:20 INFO - PROCESS | 1676 | __end_cc_report 10:19:20 INFO - PROCESS | 1676 | __startTimestamp1467393560118__endTimestamp 10:19:20 INFO - PROCESS | 1676 | 10:19:20 INFO - PROCESS | 1676 | ------- Summary: start ------- 10:19:20 INFO - PROCESS | 1676 | Number of tests: 14 10:19:20 INFO - PROCESS | 1676 | 10:19:20 INFO - PROCESS | 1676 | [#0] ai-astar Cycles:10 Average:123.80 Median:118.00 stddev:16.95 (14.4%) stddev-sans-first:17.80 10:19:20 INFO - PROCESS | 1676 | Values: 117.0 110.0 116.0 118.0 118.0 130.0 116.0 116.0 128.0 169.0 10:19:20 INFO - PROCESS | 1676 | 10:19:20 INFO - PROCESS | 1676 | [#1] audio-beat-detection Cycles:10 Average:145.20 Median:152.50 stddev:15.83 (10.4%) stddev-sans-first:16.54 10:19:20 INFO - PROCESS | 1676 | Values: 153.0 121.0 137.0 157.0 119.0 142.0 157.0 146.0 168.0 152.0 10:19:20 INFO - PROCESS | 1676 | 10:19:20 INFO - PROCESS | 1676 | [#2] audio-dft Cycles:10 Average:227.00 Median:228.00 stddev:33.36 (14.6%) stddev-sans-first:35.28 10:19:20 INFO - PROCESS | 1676 | Values: 220.0 267.0 193.0 193.0 200.0 219.0 260.0 284.0 236.0 198.0 10:19:20 INFO - PROCESS | 1676 | 10:19:20 INFO - PROCESS | 1676 | [#3] audio-fft Cycles:10 Average:77.30 Median:61.50 stddev:29.23 (47.5%) stddev-sans-first:30.66 10:19:20 INFO - PROCESS | 1676 | Values: 65.0 82.0 72.0 134.0 58.0 57.0 57.0 65.0 127.0 56.0 10:19:20 INFO - PROCESS | 1676 | 10:19:20 INFO - PROCESS | 1676 | [#4] audio-oscillator Cycles:10 Average:93.80 Median:80.50 stddev:20.91 (26.0%) stddev-sans-first:21.28 10:19:20 INFO - PROCESS | 1676 | Values: 77.0 81.0 120.0 79.0 85.0 85.0 117.0 80.0 81.0 133.0 10:19:20 INFO - PROCESS | 1676 | 10:19:20 INFO - PROCESS | 1676 | [#5] imaging-gaussian-blur Cycles:10 Average:99.80 Median:87.50 stddev:15.53 (17.7%) stddev-sans-first:15.32 10:19:20 INFO - PROCESS | 1676 | Values: 116.0 87.0 90.0 88.0 104.0 115.0 92.0 90.0 130.0 86.0 10:19:20 INFO - PROCESS | 1676 | 10:19:20 INFO - PROCESS | 1676 | [#6] imaging-darkroom Cycles:10 Average:96.00 Median:96.50 stddev:1.63 (1.7%) stddev-sans-first:1.73 10:19:20 INFO - PROCESS | 1676 | Values: 96.0 95.0 96.0 97.0 96.0 97.0 96.0 98.0 92.0 97.0 10:19:20 INFO - PROCESS | 1676 | 10:19:20 INFO - PROCESS | 1676 | [#7] imaging-desaturate Cycles:10 Average:101.90 Median:90.00 stddev:23.22 (25.8%) stddev-sans-first:24.52 10:19:20 INFO - PROCESS | 1676 | Values: 108.0 80.0 142.0 146.0 91.0 90.0 92.0 90.0 90.0 90.0 10:19:20 INFO - PROCESS | 1676 | 10:19:20 INFO - PROCESS | 1676 | [#8] json-parse-financial Cycles:10 Average:64.70 Median:65.00 stddev:5.44 (8.4%) stddev-sans-first:5.36 10:19:20 INFO - PROCESS | 1676 | Values: 59.0 62.0 65.0 64.0 65.0 65.0 65.0 79.0 62.0 61.0 10:19:20 INFO - PROCESS | 1676 | 10:19:20 INFO - PROCESS | 1676 | [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:69.50 stddev:4.73 (6.8%) stddev-sans-first:4.63 10:19:20 INFO - PROCESS | 1676 | Values: 64.0 66.0 66.0 75.0 70.0 79.0 71.0 66.0 66.0 69.0 10:19:20 INFO - PROCESS | 1676 | 10:19:20 INFO - PROCESS | 1676 | [#10] stanford-crypto-aes Cycles:10 Average:90.00 Median:74.50 stddev:16.59 (22.3%) stddev-sans-first:17.01 10:19:20 INFO - PROCESS | 1676 | Values: 78.0 99.0 68.0 71.0 94.0 104.0 71.0 95.0 112.0 108.0 10:19:20 INFO - PROCESS | 1676 | 10:19:20 INFO - PROCESS | 1676 | [#11] stanford-crypto-ccm Cycles:10 Average:137.80 Median:141.00 stddev:14.28 (10.1%) stddev-sans-first:14.87 10:19:20 INFO - PROCESS | 1676 | Values: 130.0 131.0 118.0 161.0 118.0 140.0 142.0 147.0 155.0 136.0 10:19:20 INFO - PROCESS | 1676 | 10:19:20 INFO - PROCESS | 1676 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.40 Median:177.00 stddev:23.16 (13.1%) stddev-sans-first:23.69 10:19:20 INFO - PROCESS | 1676 | Values: 163.0 164.0 184.0 216.0 170.0 165.0 166.0 184.0 165.0 227.0 10:19:20 INFO - PROCESS | 1676 | 10:19:20 INFO - PROCESS | 1676 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:1.83 (2.7%) stddev-sans-first:1.94 10:19:20 INFO - PROCESS | 1676 | Values: 68.0 68.0 70.0 65.0 68.0 68.0 66.0 66.0 67.0 71.0 10:19:20 INFO - PROCESS | 1676 | -------- Summary: end -------- 10:19:20 INFO - PROCESS | 1676 | 10:19:20 INFO - TEST-INFO | 1676: exit 0 10:19:21 INFO - TEST-OK | kraken | took 59112ms 10:19:21 INFO - SUITE-END | took 1168s 10:19:21 INFO - Completed test suite (00:19:28) 10:19:21 INFO - javascript benchmark 10:19:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3670.2475992421555, 3698.334299826031, 3712.610175931527, 3721.5534135903695, 3758.2859256741217, 5532.972335138319, 6069.089636554513, 6093.725782339794, 6099.481544068754, 6132.080187971801, 5935.762569497226, 6067.726952287147, 6090.020743258437, 6112.174856394386, 6134.969325153368, 4415.536368681291, 5297.708626025576, 5432.619716619838, 5468.945310546903, 5581.776728930838, 4619.145458090247, 5378.569714422837, 5387.78448862045, 5406.053940560406, 5497.47773961473, 5445.237666726662, 5453.972730136364, 5464.672119672812, 5470.042742520063, 5470.699111548864, 5446.074167391553, 5474.671519708791, 5489.560835133179, 5506.063969125258, 5557.833265002057, 5320.707361095138, 5451.209574611698, 5472.315960504937, 5476.479734425223, 5505.532029777473, 4714.811407543694, 5826.621269617462, 5873.383294754075, 6086.3609321021095, 6105.206323178003, 6284.057391391282, 6315.5894866833505, 6338.778142764981, 6345.42891139795, 6346.936530634727, 6338.429541341301, 6342.048692696087, 6348.841278968017, 6350.809475715736, 6360.745570177188, 6095.573309868267, 6120.296165940929, 6120.418560236771, 6145.4161854623735, 6178.764247150543, 6519.282878883319, 6550.737970481223, 6571.4085732283365, 6583.0, 6602.900956485657, 6268.905966410507, 6301.117843501914, 6302.810915672537, 6307.148534947815, 6322.0, 6363.681815909186, 6390.0, 6405.391487808651, 6431.967840160769, 6472.546921715529, 6290.2766181889665, 6304.5586808922935, 6324.620522768649, 6352.6823658816875, 6353.047042943595, 6355.332690067568, 6360.077788720702, 6360.968195158995, 6369.45859601939, 6375.585586936927, 4997.475265097112, 5096.566791822663, 5180.222966555047, 5196.090684130262, 5202.947970520322, 4611.16998940194, 4637.5130611286, 4646.303054541778, 4660.207764680013, 4674.929876051862, 6133.610107582658, 6223.159873417121, 6225.1907252057845, 6231.532635052298, 6282.120503129566, 5973.880522389528, 6335.809925702236, 6377.585456945284, 6397.8720425592155, 6446.903296450557, 6241.282252540925, 6280.623162610258, 6288.339724328971, 6293.370662933761, 6297.370262973757, 5567.66594004361, 5699.344575373802, 5701.600887937888, 5723.284589426322, 5743.59794814359, 5618.763871948165, 6640.568363056386, 6737.124173857367, 6750.966245168743, 6778.966105169541, 6400.39196276353, 6442.774502892564, 6475.158229430144, 6481.708323125376, 6485.610863348025, 6511.218653761579, 6599.274079851309, 6741.662916854039, 6746.4265537429865, 6747.865042699217, 6326.33573474797, 6381.266154392304, 6389.265234497906, 6399.904001440075, 6405.583637063576, 6412.070249813844, 6442.226932768098, 6470.773522926675, 6476.255230648348, 6488.448481879093, 5508.20131080983, 6260.092286618324, 6285.0, 6300.054991751274, 6315.778947736807, 4641.930371044505, 5217.269582258411, 5576.525995290446, 5957.057926602209, 6290.591111577733, 5489.862753431196, 5854.707264636666, 6173.351798061139, 6279.780207692709, 6291.591046581958, 6192.59748116371, 6199.628022318675, 6265.906011409924, 6273.811785646255, 6279.246490421178, 5211.713355765318, 6247.656378899204, 6264.404881536247, 6272.341404152498, 6272.341404152498], "value": 5898.546398187278, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.21768707483, 560.5487582496089, 575.4619430832171, 579.9971000144999, 600.8557946092938, 38427.80786096069, 39274.0, 39380.0, 39411.802940985326, 39465.4080188797, 40977.0, 41342.58657413425, 41367.37948930761, 41391.379129313085, 41518.79240603793, 9731.95134024329, 9839.950800245988, 9905.950470247675, 9918.05778451046, 9932.006799320083, 9760.219182465386, 9905.00949905011, 9921.15670168033, 10007.699769006942, 10010.699679009642, 9934.0, 9971.40171589707, 9994.750131246705, 10075.546600402999, 10077.344972576759, 9919.256055795844, 9964.850527242097, 10009.949950250202, 10071.647492337734, 10073.949630251838, 9815.018498150199, 9818.165455936254, 9943.552540135712, 9952.95023524885, 9965.20278377728, 39269.60730392688, 39629.0, 39831.0, 40039.39940900889, 40153.0, 3205.3589282143666, 3452.723782097426, 3511.666391692785, 3797.6392242736897, 3881.2819628368843, 26774.464510709873, 27519.724802752116, 27535.0, 28374.0, 28738.712612873813, 2743.561030235153, 2768.1418760184406, 2791.148699646607, 2805.2425845021935, 2893.2188309156622, 314327.428362859, 314925.0, 315138.0, 319538.4023079893, 320485.0, 36926.076848079014, 37643.24713505714, 37909.86270411892, 64920.67539662271, 65354.0, 36614.63385366165, 36806.44790328147, 36890.8155459221, 36977.0, 36984.0, 15630.843691562939, 16148.75776863348, 16310.0, 16323.591910202102, 16370.754438683429, 13374.0, 13730.45078196881, 13739.519116830863, 13833.446662133603, 13839.169649821042, 8195.795105122419, 8208.753737387888, 8237.0, 8294.626741796514, 8508.829823403497, 3144.386844565288, 3586.444101164324, 3605.22487665148, 3618.656227658368, 3650.8174591270863, 869.9695510657097, 1128.5937062657438, 1161.0885454918018, 1165.0504838556549, 1167.7781221567875, 31088.378232435676, 31134.532982004836, 31206.375872482422, 31675.366492670477, 31945.840270798497, 1151.5739176504746, 1153.9134564907665, 1184.5972369394447, 1186.845710057687, 1217.8538575371012, 12983.823449313992, 16009.759853602205, 16083.115428651303, 16295.022298662117, 16316.592085197964, 684311.0, 687010.5649471821, 696293.0, 697172.0, 702500.0, 59434.70282648559, 61148.38851611427, 61229.69385153046, 61262.38737612656, 61270.693646532374, 1334.8998825087963, 1349.9335524935389, 1556.4007856975147, 1581.351645825206, 1656.6024154202905, 29433.411331773674, 30427.54358684577, 30541.04971740705, 31041.689583104784, 31382.0, 54143.64640883852, 54612.453875460735, 54878.45121548734, 55109.448905510435, 56826.44281007282, 397388.0, 483059.0, 483686.0, 483977.5801121113, 484407.0, 26926.0, 27838.58242126329, 28365.71634283631, 28614.284642884093, 28670.0, 41575.168496630504, 44175.11649767051, 46032.0, 47821.5217847831, 48904.02191956212, 32089.67910320867, 38088.809555952044, 38226.61773382342, 38326.04184895288, 38838.80580597079, 31107.37785244328, 34012.82993585016, 36790.8160459196, 38016.619833801306, 38274.2345153101, 32589.18527036843, 37799.43300850435, 38048.80975595104, 38474.807625961694, 38754.80622596869, 30718.232044199074, 31564.579593917868, 32808.179795505304, 32849.67150328466, 32906.835465822514, 21190.7880921195, 25278.0, 25511.87244063768, 25723.661605724526, 25908.61137082983], "value": 18668.371513151906, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.25284419783645, 414.24193725482354, 416.22789725059994, 416.6396067401698, 426.2540554030447, 15714.685706285896, 20285.695714564292, 20775.96120193988, 21022.264220752277, 21036.89481552594, 20595.588088238226, 21921.342359729235, 22118.009379155872, 22162.77837221627, 22302.442438939033, 4938.358013458245, 5285.942811437709, 5802.622829516078, 6109.450149486545, 6118.3269840317525, 5896.351401345849, 5939.643621382731, 6050.394960503959, 6057.697115144248, 6062.939370606282, 5043.773030213631, 5833.824985250428, 5868.354481007107, 5993.490553302952, 6037.939620603782, 5053.292539044518, 5977.193078934331, 5994.130851026599, 6003.279606447254, 6039.456448919618, 5022.0, 5277.445868183824, 5286.444923283038, 5313.335833020872, 5314.813981510629, 27364.31589210266, 27529.44941101167, 27630.72369276322, 27816.721832781615, 28088.578671319945, 2207.7902599253043, 2377.1917548033753, 2448.7306396296394, 2623.4359612683365, 2664.0276299150864, 9712.368696034735, 9917.603295868157, 10240.180785537214, 10362.222833287533, 15061.322240499094, 1797.5506123469133, 1829.670659281342, 1831.9908400458046, 1845.3817970979737, 1861.8138186181272, 113693.4315328418, 118173.40913295465, 119121.40439297835, 119909.0, 119993.0, 11870.287782733063, 12037.638870833889, 12065.577704780291, 12085.066389377658, 12154.270743755404, 15265.3893844245, 15559.688806224038, 15561.377544898303, 15562.377504899678, 15618.9219053904, 7524.435667324972, 7768.922310776933, 9134.492808686626, 9311.860322095174, 9374.718758437259, 9164.312676549285, 9498.857517137249, 9533.998930112377, 9585.376950498196, 9599.280053995979, 3958.5843486434087, 4849.0, 4863.927041094386, 4893.584045356113, 4897.975510122498, 2016.2842191022269, 2047.3857842647146, 2065.10168076887, 2079.064421010551, 2115.9788402115782, 773.2113244490588, 824.3240542755003, 824.6577670266892, 913.3104506097853, 970.834958057132, 17025.574360641083, 17111.91444042797, 21107.78892211089, 21294.148234070773, 21382.786172138392, 851.8807366968506, 1006.3659894266711, 1033.5245786938092, 1053.4995876958383, 1060.7401186709305, 11126.443677816076, 11485.483153258123, 11515.25150865191, 11537.942310288396, 11557.422128893522, 460882.0, 611303.0, 614667.0, 635080.0, 665292.0, 99412.5029374863, 105621.47189264004, 109710.0, 114893.85106148999, 119830.4008479952, 902.4810733828075, 1040.5161599856103, 1055.9260851740305, 1114.1031469666834, 1115.3976852499559, 15189.104701982122, 15705.13621750769, 18652.880827150413, 19333.806661933202, 19521.414357569294, 38334.42498362471, 45505.86235344143, 51671.0, 52957.20564191463, 53576.73211633917, 72558.91161632685, 72687.63656181685, 79574.0, 80085.0, 80119.79820302817, 7498.550086994798, 8047.476914000571, 8361.0, 8415.915840841759, 8489.702860399857, 10056.899431005597, 11005.944970275097, 11178.720531986766, 12477.064220183704, 12676.873231267939, 8827.955860220658, 9516.904830951602, 9931.801363972536, 10860.837087443537, 11219.943900280447, 11026.614068507564, 11037.834432483358, 11128.332300062022, 11352.148588855704, 11461.770764584828, 11136.16478764112, 11487.425628718363, 11727.35499547533, 11847.466863990969, 11882.82175767347, 6990.335918087773, 8264.958675206586, 8375.623096960773, 8398.370122240734, 8418.663253470038, 8332.708355207538, 10397.116245118947, 11315.773684526428, 11397.0, 11680.0], "value": 9605.664829215262, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1424.3092100331337, 1652.5207689769968, 1677.5386768638623, 2071.523549583596, 2078.241441873715, 8170.4280700351, 8790.47257164569, 8909.688160914362, 9100.271978241733, 9108.817823643523, 8897.555122243879, 8945.194932456077, 8951.283897288218, 9032.141946515087, 9107.271418286538, 2521.218422289087, 2527.7851382632452, 2529.2285852814884, 2548.961765573518, 2572.318335641057, 2174.793394627508, 2498.9375265618323, 2562.9102981395654, 2575.484903019394, 2594.8962041518316, 2517.6223566465087, 2531.1773673556077, 2573.137998770414, 2579.742025797424, 2582.0, 2541.6568763217006, 2566.1275166443497, 2567.8844451999703, 2568.036986130201, 2582.9870850645625, 2532.4048848520583, 2548.604966230237, 2567.7047139579, 2568.191019828748, 2596.9870150649313, 9164.266858651292, 9185.954070229673, 9203.493807840567, 9207.079292070806, 9210.95394523023, 5629.127485239795, 5662.915056274118, 5668.886622267572, 5680.488756011979, 5750.971245143747, 3653.050206946213, 3749.250149970017, 3789.0906182515996, 3793.696504279651, 3802.125511132427, 1050.7793363393696, 1070.379180075562, 1074.0762943868267, 1079.865016872891, 1091.8689757229183, 12060.879391206063, 12080.456379462945, 12093.57672481459, 12348.073894457862, 12358.505659773598, 4926.75366231687, 4988.90022199554, 5096.311997880312, 5102.744862756922, 5111.769970351269, 10282.897171028344, 10325.32885362464, 10462.529186186639, 10489.160867130611, 10525.36847789135, 5574.777008919597, 5584.21820945068, 5664.461876121762, 5675.602707810496, 5753.539716822645, 4652.976735116303, 5068.315777370081, 5122.590192784568, 5157.200633901676, 5179.22311653255, 4169.1661667666585, 4184.958150418457, 4316.223079845595, 4325.4593175853015, 4359.564043595615, 1400.6358346829693, 1435.777454494555, 1436.992815035918, 1445.3062529985666, 1445.985540144585, 943.5423819447562, 955.9044095590524, 960.279790157382, 963.9614415423305, 1007.7631756537207, 5941.702914854326, 5965.135055417027, 6009.399060094043, 6136.263648362135, 6173.135760993465, 453.51926957425235, 461.96997195182206, 465.0953894674825, 470.0317346266633, 471.0837421215771, 4004.979975100106, 4087.05997620543, 4110.260153172458, 4125.793710314472, 4178.206140833232, 9091.590878410487, 10605.787884242272, 10946.562137514411, 10979.615713449992, 11043.39261340634, 10237.9488102559, 10258.794824103476, 10506.474676266156, 10598.410238464137, 10622.89377106219, 7064.823379415556, 7072.611006394698, 8183.672653093929, 8291.875621865676, 8369.288610468178, 6043.969780151071, 6068.6965651716355, 6090.665013424305, 6128.387161283836, 6200.534959877937, 8061.951946246951, 9190.40262382943, 9453.810923781624, 9480.668176613786, 9881.258905581966, 8156.796080098045, 9765.462899540309, 9857.901420985698, 10042.849357259502, 10156.0, 6967.1291088613925, 7451.478396512192, 7599.772006839804, 7616.8476630465975, 7744.993150890348, 8282.50304981703, 8356.373272004503, 8418.158184181533, 8448.788780280542, 8460.915390846012, 7444.73943411978, 7592.620368981639, 7604.695812167452, 7610.238976102345, 7692.846143076995, 7375.483716140034, 7401.111866576045, 7455.925440745523, 7536.794112941903, 7544.660490277841, 7126.0, 7183.245759195418, 7197.856042879218, 7215.062041934725, 7231.842905135153, 4978.352814134139, 4983.925241121458, 5075.1625981712605, 5180.585553155664, 5183.50756678115, 4346.804393802223, 5027.497250274943, 5103.4386217516785, 5136.203888397305, 5208.453112423141], "value": 4661.874555588245, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.8008234688626, 315.9889403870865, 317.3858583640657, 339.55857385398974, 340.3261542146549, 6245.156903817983, 6409.13476680648, 6883.827904302395, 7027.191872934614, 7113.964430177848, 5588.748506317215, 6589.604623722568, 7043.823904402392, 7079.6814143363545, 7083.114610673666, 5178.637495375326, 5201.739913004353, 5209.921851172236, 5211.218317252424, 5218.817341393052, 5195.714235717034, 5217.0, 5220.373555173384, 5239.607029472786, 5241.73791310433, 4235.9788201058955, 5107.642465027449, 5151.330327057477, 5162.122439185328, 5164.070467315882, 4841.8063277468855, 4887.022595480882, 5063.696178229318, 5160.122779127557, 5163.993021360836, 3669.21111960927, 4230.746155230665, 4259.680523960685, 4266.722663026924, 4298.226319262531, 6099.878002439927, 6665.100211471437, 6782.016607591871, 6789.898151527731, 6793.830154246183, 5210.426853046162, 6023.096535519663, 6030.96984515079, 6046.123312119718, 6051.727672254759, 5249.845034092532, 5622.3253209614695, 6859.07402500661, 7417.406607471389, 7505.587192704399, 4676.854170728159, 4712.198926182557, 4801.8079276828885, 4965.77654005567, 4984.501549845023, 6099.420555047263, 7901.249381308767, 7963.482373645695, 7993.600319984036, 8100.797480062986, 5095.210242412358, 5099.311592934906, 5099.745012749348, 5105.106606343875, 5110.488951104934, 5202.2456743771945, 5203.843884683465, 5205.2192171173865, 5215.852512447255, 5216.37403511581, 6041.0, 6042.758289668452, 6043.456088952015, 6051.546134039964, 6061.848453788691, 7422.765505856402, 7544.132424771112, 7614.428917831185, 7623.733169339046, 7634.0, 1792.7669402977529, 1802.1980218802769, 1815.4372144635206, 1816.8819026763217, 1820.2991848138563, 1070.2240875365453, 1127.8308253762002, 1137.311926284586, 1149.6263714292888, 1165.976680466386, 7125.3230943060325, 7127.46544009191, 7155.749548765768, 7173.5337203081635, 7180.928190718026, 7816.648250828726, 7838.333741631911, 7849.097353804272, 7855.607219638995, 7870.0, 7150.892736608955, 7151.7854464366155, 7164.928350716426, 7167.104111986002, 7197.640117994079, 4026.416169655442, 4111.239420707178, 4151.46031015966, 4165.854195103157, 4193.412922190896, 8289.129641387688, 8359.95820020896, 8380.497170169809, 8385.077641459435, 8390.874136887951, 6568.474522038321, 6905.205901321412, 8228.958855205685, 8230.465019773696, 8246.340292776564, 8050.879236811453, 8342.791430214293, 8370.288525475282, 8373.623186956602, 8403.621837017348, 7642.082950045808, 7940.404469664913, 7979.16218797018, 7981.920180798118, 8020.157883422156, 7768.689252430066, 7786.688532458865, 7808.0, 7837.725679601187, 7848.686052557834, 7275.599842008529, 7774.378049756119, 8342.958285208535, 8349.99800024001, 8379.664813407395, 4784.928226076542, 4803.471618122074, 4808.927866081942, 4813.4945830687275, 4825.059113472839, 7583.924160758322, 7823.960880195563, 7832.373410127062, 7842.64708088126, 7854.978852749106, 7482.625868706434, 7540.359069479156, 7611.847763044819, 7624.8475030500185, 7628.237176282328, 7397.668419684508, 7551.0, 7602.7339043135435, 7610.048743907012, 7653.0816302041885, 7252.673629686782, 7421.369183619453, 7430.331270185709, 7499.100107987077, 7513.699452022077, 7352.48532602734, 7631.046119235096, 7655.349295309961, 7672.347850432776, 7677.965339185233, 5979.641221526722, 6014.72933717975, 6669.4664426844765, 7419.406447484296, 7453.0], "value": 5456.830901855629, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [688.088283024992, 727.6107282603807, 774.6475353714058, 782.4561929459027, 789.9368050555956, 15446.691066178684, 15587.0, 15683.059016459007, 15717.607059823511, 15725.977811442248, 14468.92765536171, 14494.710105797878, 14521.419143234258, 14530.20083895388, 14551.199684017374, 776.4215659333776, 932.822763674903, 938.1790932933683, 952.5618215620823, 955.1833182628822, 921.2537844346068, 922.5341202692664, 946.3612061858253, 957.6121670723368, 961.9711408657716, 981.4307701533094, 1013.0679774607343, 1015.96952091437, 1022.269077609509, 1023.9846402303972, 969.1471505075524, 970.0929630795229, 985.6747273399761, 987.323683276954, 1008.5612758450061, 733.2044731466366, 753.4688044928313, 761.801931497809, 762.5691484311346, 764.1556080530988, 14805.407783688639, 15129.319180636898, 15234.390624375012, 15327.310271037719, 15334.9233253833, 13443.865561344359, 13469.663258418519, 13472.932635336761, 13618.387172577159, 13667.863321366858, 9846.359986600919, 10443.164546836235, 10491.632792852213, 10513.316634418814, 10550.683479495627, 3569.3218288525095, 3703.8333275002688, 3715.665590096877, 3725.66469017787, 3797.810109494514, 76333.0, 77883.0, 78090.0, 79256.60371698163, 79312.41375172522, 9527.333086683866, 9578.90421095794, 9703.854442183372, 9803.558839852223, 9968.302218844612, 16298.755518667229, 18455.723164152547, 20793.688094678593, 21366.78633213679, 21547.0, 7716.498427602188, 7817.765467035998, 7871.921280787234, 7951.125376208613, 8144.5520496373265, 4038.8788336349958, 4045.4943132108488, 4069.4302797608357, 4135.379693046068, 4204.495460544754, 3631.618680038558, 3632.909177270589, 3643.653852883972, 3650.8539658413365, 3710.332140214787, 694.1080711285973, 703.8416356319788, 704.9400800931876, 710.6198183971551, 718.6586371473613, 584.8771757930797, 604.3291945940003, 609.250621735268, 610.3713175429315, 620.3548309757801, 8486.19381158789, 8564.828703425897, 8598.613062412081, 8688.218060374596, 8709.695160669346, 570.7431655754926, 578.94789468948, 598.5720210049835, 600.5225845452876, 654.1300070905684, 3237.206884313311, 4055.249778790874, 4192.45498085247, 4268.743875367426, 4309.073549186877, 98699.0, 99268.02927882948, 99639.00360996442, 100855.48716769254, 102792.0, 84784.57607712045, 84953.72569411463, 85900.57049714711, 86134.0, 86238.7064194025, 71092.64453677699, 71749.64125179341, 74080.88878666825, 75786.62106689431, 76597.0, 8667.566621669017, 8905.287576993955, 8927.018028017043, 8962.879640044994, 9055.864162037444, 47500.7624961873, 49016.5098349012, 51597.7420112897, 53747.73126134344, 53760.0, 72567.63716181596, 75056.62471687606, 75259.0, 75790.0, 76537.46925061579, 11302.773944520899, 11401.714957126138, 11645.184837061324, 11687.824682629598, 11821.408929553316, 12138.393080346124, 12182.878171218174, 12265.938670306592, 12397.318147501974, 12540.749185016066, 11563.074954003827, 11566.30602163873, 11692.181547291608, 11884.881151188378, 12387.132900696864, 11700.648980530597, 11787.292762434281, 11804.996575291196, 11838.526458941546, 11852.525898963944, 11344.319340839576, 11380.715482113013, 11578.71053223676, 11615.825762613398, 11787.233829801036, 9845.704628861145, 9953.104220619889, 10090.09189172978, 10321.63874264397, 10380.792384152426, 8883.777905552155, 9088.454692718458, 9845.704628861145, 9912.207023438252, 9960.203183745138], "value": 7179.226517847372, "unit": "score"}], "name": "dromaeo_css", "value": 7603.234219129396, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 110.0, 116.0, 118.0, 118.0, 130.0, 116.0, 116.0, 128.0, 169.0], "value": 123.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 121.0, 137.0, 157.0, 119.0, 142.0, 157.0, 146.0, 168.0, 152.0], "value": 145.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [220.0, 267.0, 193.0, 193.0, 200.0, 219.0, 260.0, 284.0, 236.0, 198.0], "value": 227.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 82.0, 72.0, 134.0, 58.0, 57.0, 57.0, 65.0, 127.0, 56.0], "value": 77.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 81.0, 120.0, 79.0, 85.0, 85.0, 117.0, 80.0, 81.0, 133.0], "value": 93.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 87.0, 90.0, 88.0, 104.0, 115.0, 92.0, 90.0, 130.0, 86.0], "value": 99.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 97.0, 96.0, 97.0, 96.0, 98.0, 92.0, 97.0], "value": 96.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 80.0, 142.0, 146.0, 91.0, 90.0, 92.0, 90.0, 90.0, 90.0], "value": 101.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 62.0, 65.0, 64.0, 65.0, 65.0, 65.0, 79.0, 62.0, 61.0], "value": 64.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 66.0, 75.0, 70.0, 79.0, 71.0, 66.0, 66.0, 69.0], "value": 69.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 99.0, 68.0, 71.0, 94.0, 104.0, 71.0, 95.0, 112.0, 108.0], "value": 90.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 131.0, 118.0, 161.0, 118.0, 140.0, 142.0, 147.0, 155.0, 136.0], "value": 137.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 184.0, 216.0, 170.0, 165.0, 166.0, 184.0, 165.0, 227.0], "value": 180.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 70.0, 65.0, 68.0, 68.0, 66.0, 66.0, 67.0, 71.0], "value": 67.7, "unit": "score"}], "name": "kraken", "value": 1574.6, "alertThreshold": 2.0}]} 10:19:21 INFO - Return code: 0 10:19:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:19:21 ERROR - # TBPL SUCCESS # 10:19:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:19:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:19:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:19:21 INFO - 2016-07-01 10:19:21.473 screenresolution[1681:10433] starting screenresolution argv=screenresolution get 10:19:21 INFO - 2016-07-01 10:19:21.476 screenresolution[1681:10433] Display 0: 1600x1200x32@60 10:19:21 INFO - 2016-07-01 10:19:21.482 screenresolution[1682:10436] starting screenresolution argv=screenresolution list 10:19:21 INFO - Available Modes on Display 0 10:19:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:19:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:19:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:19:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:19:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:19:21 INFO - Intel Iris: 10:19:21 INFO - Chipset Model: Intel Iris 10:19:21 INFO - Type: GPU 10:19:21 INFO - Bus: Built-In 10:19:21 INFO - VRAM (Dynamic, Max): 1536 MB 10:19:21 INFO - Vendor: Intel (0x8086) 10:19:21 INFO - Device ID: 0x0a2e 10:19:21 INFO - Revision ID: 0x0009 10:19:21 INFO - Displays: 10:19:21 INFO - Display: 10:19:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:19:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:19:21 INFO - Display Serial Number: 1600x1200 60 10:19:21 INFO - Main Display: Yes 10:19:21 INFO - Mirror: Off 10:19:21 INFO - Online: Yes 10:19:21 INFO - Rotation: Supported 10:19:21 INFO - Return code: 0 10:19:21 INFO - Running post-action listener: _resource_record_post_action 10:19:21 INFO - Running post-run listener: _resource_record_post_run 10:19:22 INFO - Total resource usage - Wall time: 1193s; CPU: 53.0%; Read bytes: 37615104; Write bytes: 497152000; Read time: 394; Write time: 1671 10:19:22 INFO - install - Wall time: 23s; CPU: 55.0%; Read bytes: 191310336; Write bytes: 187672576; Read time: 17577; Write time: 414 10:19:22 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 31473152; Write bytes: 299526144; Read time: 313; Write time: 1227 10:19:22 INFO - Running post-run listener: _upload_blobber_files 10:19:22 INFO - Blob upload gear active. 10:19:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:19:22 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 10:19:22 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'] 10:19:22 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 10:19:23 INFO - (blobuploader) - INFO - Open directory for files ... 10:19:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:19:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:19:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:19:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:19:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:19:24 INFO - (blobuploader) - INFO - Done attempting. 10:19:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:19:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:19:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:19:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:19:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:19:25 INFO - (blobuploader) - INFO - Done attempting. 10:19:25 INFO - (blobuploader) - INFO - Iteration through files over. 10:19:25 INFO - Return code: 0 10:19:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:19:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:19:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2858963d11f1bceffaede5a79a1a38f9f12879b2c761ea49c87723a3eeadea46239024b0d71f946f839d5ad641cde6b819f62aba116a0613ab1db1d833947196", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9318233e11a51d6408788a4b144ca28ccd8e2c22166ca1a4fa7315db7864b5531db16fcbf8d6e682db13e48e4d93589e00c8d5cb145c7521858db74444778fb7"} 10:19:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:19:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:19:25 INFO - Contents: 10:19:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2858963d11f1bceffaede5a79a1a38f9f12879b2c761ea49c87723a3eeadea46239024b0d71f946f839d5ad641cde6b819f62aba116a0613ab1db1d833947196", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9318233e11a51d6408788a4b144ca28ccd8e2c22166ca1a4fa7315db7864b5531db16fcbf8d6e682db13e48e4d93589e00c8d5cb145c7521858db74444778fb7"} 10:19:25 INFO - Running post-run listener: copy_logs_to_upload_dir 10:19:25 INFO - Copying logs to upload dir... 10:19:25 INFO - mkdir: /builds/slave/test/build/upload/logs 10:19:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.942413 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-07-01 10:19:25.397476) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 10:19:25.401527) ========= 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.ddS2XBy0tE/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.uZ1zyuSAvl/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2858963d11f1bceffaede5a79a1a38f9f12879b2c761ea49c87723a3eeadea46239024b0d71f946f839d5ad641cde6b819f62aba116a0613ab1db1d833947196", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9318233e11a51d6408788a4b144ca28ccd8e2c22166ca1a4fa7315db7864b5531db16fcbf8d6e682db13e48e4d93589e00c8d5cb145c7521858db74444778fb7"} build_url:https://queue.taskcluster.net/v1/task/Jp7YfCxVTTO9uUnLtgbujQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010981 build_url: 'https://queue.taskcluster.net/v1/task/Jp7YfCxVTTO9uUnLtgbujQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2858963d11f1bceffaede5a79a1a38f9f12879b2c761ea49c87723a3eeadea46239024b0d71f946f839d5ad641cde6b819f62aba116a0613ab1db1d833947196", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9318233e11a51d6408788a4b144ca28ccd8e2c22166ca1a4fa7315db7864b5531db16fcbf8d6e682db13e48e4d93589e00c8d5cb145c7521858db74444778fb7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 10:19:25.434779) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 10:19:25.435168) ========= 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.ddS2XBy0tE/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.uZ1zyuSAvl/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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.005135 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 10:19:25.484280) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 10:19:25.484633) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 10:19:25.485013) ========= ========= Total master_lag: 0.18 =========