builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0032 starttime: 1461953286.89 results: success (0) buildid: 20160429101348 builduid: 201814c460594d4ba49129a13698efa5 revision: e828b778e62c0795a1e85dd39f782b59dcebd445 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 11:08:06.885901) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 11:08:06.886310) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 11:08:06.886585) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 11:08:07.416499) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-29 11:08:07.416800) ========= 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.96Swecb1pE/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.iGkMjyUzY9/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-29 11:08:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 13.3M=0.001s 2016-04-29 11:08:07 (13.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.441885 ========= master_lag: 0.72 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-29 11:08:08.576785) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 11:08:08.577058) ========= 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.96Swecb1pE/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.iGkMjyUzY9/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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.026482 ========= master_lag: 0.13 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 11:08:08.733098) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-29 11:08:08.733450) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e828b778e62c0795a1e85dd39f782b59dcebd445 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev e828b778e62c0795a1e85dd39f782b59dcebd445 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.96Swecb1pE/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.iGkMjyUzY9/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-29 11:08:08,810 truncating revision to first 12 chars 2016-04-29 11:08:08,810 Setting DEBUG logging. 2016-04-29 11:08:08,810 attempt 1/10 2016-04-29 11:08:08,810 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e828b778e62c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-29 11:08:09,488 unpacking tar archive at: fx-team-e828b778e62c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.094839 ========= master_lag: 0.14 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-29 11:08:09.966375) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 11:08:09.966656) ========= script_repo_revision: e828b778e62c0795a1e85dd39f782b59dcebd445 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 11:08:09.967092) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 11:08:09.967375) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 11:08:09.995832) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-04-29 11:08:09.996131) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.96Swecb1pE/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.iGkMjyUzY9/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 11:08:10 INFO - MultiFileLogger online at 20160429 11:08:10 in /builds/slave/test 11:08:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:08:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:08:10 INFO - {'append_to_log': False, 11:08:10 INFO - 'base_work_dir': '/builds/slave/test', 11:08:10 INFO - 'blob_upload_branch': 'Fx-Team', 11:08:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:08:10 INFO - 'branch': 'Fx-Team', 11:08:10 INFO - 'buildbot_json_path': 'buildprops.json', 11:08:10 INFO - 'config_files': ('talos/mac_config.py',), 11:08:10 INFO - 'default_actions': ('clobber', 11:08:10 INFO - 'read-buildbot-config', 11:08:10 INFO - 'download-and-extract', 11:08:10 INFO - 'populate-webroot', 11:08:10 INFO - 'create-virtualenv', 11:08:10 INFO - 'install', 11:08:10 INFO - 'run-tests'), 11:08:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:08:10 INFO - 'download_minidump_stackwalk': True, 11:08:10 INFO - 'download_symbols': 'ondemand', 11:08:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:08:10 INFO - 'tooltool.py': '/tools/tooltool.py', 11:08:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:08:10 INFO - '/tools/misc-python/virtualenv.py')}, 11:08:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:08:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:08:10 INFO - 'installer_path': 'installer.exe', 11:08:10 INFO - 'log_level': 'info', 11:08:10 INFO - 'log_name': 'talos', 11:08:10 INFO - 'log_to_console': True, 11:08:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:08:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:08:10 INFO - 'opt_config_files': (), 11:08:10 INFO - 'pip_index': False, 11:08:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:08:10 INFO - 'cmd': ('bash', 11:08:10 INFO - '-c', 11:08:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:08:10 INFO - 'enabled': True, 11:08:10 INFO - 'halt_on_failure': False, 11:08:10 INFO - 'name': 'check_screen_resolution'},), 11:08:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:08:10 INFO - 'cmd': ('bash', 11:08:10 INFO - '-c', 11:08:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:08:10 INFO - 'enabled': True, 11:08:10 INFO - 'halt_on_failure': False, 11:08:10 INFO - 'name': 'check_screen_resolution'},), 11:08:10 INFO - 'run_cmd_checks_enabled': True, 11:08:10 INFO - 'sps_profile': False, 11:08:10 INFO - 'sps_profile_interval': 0, 11:08:10 INFO - 'suite': 'dromaeojs', 11:08:10 INFO - 'system_bits': '32', 11:08:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:08:10 INFO - 'title': 't-yosemite-r7-0032', 11:08:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:08:10 INFO - 'use_talos_json': True, 11:08:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:08:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:08:10 INFO - 'work_dir': 'build'} 11:08:10 INFO - ##### 11:08:10 INFO - ##### Running clobber step. 11:08:10 INFO - ##### 11:08:10 INFO - Running pre-action listener: _resource_record_pre_action 11:08:10 INFO - Running main action method: clobber 11:08:10 INFO - rmtree: /builds/slave/test/build 11:08:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:08:12 INFO - Running post-action listener: _resource_record_post_action 11:08:12 INFO - ##### 11:08:12 INFO - ##### Running read-buildbot-config step. 11:08:12 INFO - ##### 11:08:12 INFO - Running pre-action listener: _resource_record_pre_action 11:08:12 INFO - Running main action method: read_buildbot_config 11:08:12 INFO - Using buildbot properties: 11:08:12 INFO - { 11:08:12 INFO - "project": "", 11:08:12 INFO - "product": "firefox", 11:08:12 INFO - "script_repo_revision": "production", 11:08:12 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 11:08:12 INFO - "repository": "", 11:08:12 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 11:08:12 INFO - "buildid": "20160429101348", 11:08:12 INFO - "pgo_build": "False", 11:08:12 INFO - "basedir": "/builds/slave/test", 11:08:12 INFO - "buildnumber": 747, 11:08:12 INFO - "slavename": "t-yosemite-r7-0032", 11:08:12 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 11:08:12 INFO - "platform": "yosemite_r7", 11:08:12 INFO - "scheduler": "tests-fx-team-macosx64-talos", 11:08:12 INFO - "branch": "fx-team", 11:08:12 INFO - "repo_path": "integration/fx-team", 11:08:12 INFO - "revision": "e828b778e62c0795a1e85dd39f782b59dcebd445", 11:08:12 INFO - "stage_platform": "macosx64", 11:08:12 INFO - "builduid": "201814c460594d4ba49129a13698efa5", 11:08:12 INFO - "slavebuilddir": "test" 11:08:12 INFO - } 11:08:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 11:08:12 INFO - Running post-action listener: _resource_record_post_action 11:08:12 INFO - ##### 11:08:12 INFO - ##### Running download-and-extract step. 11:08:12 INFO - ##### 11:08:12 INFO - Running pre-action listener: _resource_record_pre_action 11:08:12 INFO - Running main action method: download_and_extract 11:08:12 INFO - mkdir: /builds/slave/test/build/tests 11:08:12 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')]} 11:08:12 INFO - https://queue.taskcluster.net/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 11:08:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 11:08:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 11:08:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 11:08:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 11:08:13 INFO - Downloaded 1199 bytes. 11:08:13 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 11:08:13 INFO - Using the following test package requirements: 11:08:13 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 11:08:13 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 11:08:13 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 11:08:13 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 11:08:13 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 11:08:13 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 11:08:13 INFO - u'jsshell-mac.zip'], 11:08:13 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 11:08:13 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 11:08:13 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 11:08:13 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 11:08:13 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 11:08:13 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 11:08:13 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 11:08:13 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 11:08:13 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 11:08:13 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 11:08:13 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 11:08:13 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:08:13 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')]} 11:08:13 INFO - https://queue.taskcluster.net/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:08:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 11:08:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 11:08:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 11:08:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:08:14 INFO - Downloaded 18124297 bytes. 11:08:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:08:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 11:08:17 INFO - Return code: 0 11:08:17 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 11:08:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:17 INFO - https://queue.taskcluster.net/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:08:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 11:08:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 11:08:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 11:08:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:08:23 INFO - Downloaded 18124297 bytes. 11:08:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:08:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 11:08:27 INFO - Return code: 0 11:08: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')]} 11:08:27 INFO - https://queue.taskcluster.net/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 11:08:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 11:08:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 11:08:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 11:08:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 11:08:28 INFO - Downloaded 10840145 bytes. 11:08:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:08:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 11:08:28 INFO - Return code: 0 11:08:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:28 INFO - https://queue.taskcluster.net/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 11:08:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 11:08:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 11:08:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 11:08:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 11:08:31 INFO - Downloaded 110274242 bytes. 11:08:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 11:08:31 INFO - mkdir: /builds/slave/test/properties 11:08:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:08:31 INFO - Writing to file /builds/slave/test/properties/build_url 11:08:31 INFO - Contents: 11:08:31 INFO - build_url:https://queue.taskcluster.net/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 11:08:32 INFO - Running post-action listener: _resource_record_post_action 11:08:32 INFO - Running post-action listener: set_extra_try_arguments 11:08:32 INFO - ##### 11:08:32 INFO - ##### Running populate-webroot step. 11:08:32 INFO - ##### 11:08:32 INFO - Running pre-action listener: _resource_record_pre_action 11:08:32 INFO - Running main action method: populate_webroot 11:08:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:08:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:08:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:08:32 INFO - '--tppagecycles', 11:08:32 INFO - '7'], 11:08:32 INFO - 'tests': ['tsvgm']}}, 11:08:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:08:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:08:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:08:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:08:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:08:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:08:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:32 INFO - 'talos_options': ['--disable-e10s'], 11:08:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:08:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:08:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:32 INFO - 'talos_options': ['--disable-e10s'], 11:08:32 INFO - 'tests': ['damp', 'tps']}, 11:08:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:32 INFO - 'tests': ['damp', 'tps']}, 11:08:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:08:32 INFO - 'tests': ['dromaeo_dom']}, 11:08:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:08:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:08:32 INFO - 'tests': ['a11yr', 11:08:32 INFO - 'ts_paint', 11:08:32 INFO - 'tpaint', 11:08:32 INFO - 'sessionrestore', 11:08:32 INFO - 'sessionrestore_no_auto_restore', 11:08:32 INFO - 'tabpaint']}, 11:08:32 INFO - 'other-e10s': {'tests': ['a11yr', 11:08:32 INFO - 'ts_paint', 11:08:32 INFO - 'tpaint', 11:08:32 INFO - 'sessionrestore', 11:08:32 INFO - 'sessionrestore_no_auto_restore', 11:08:32 INFO - 'tabpaint']}, 11:08:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:08:32 INFO - 'ts_paint', 11:08:32 INFO - 'tpaint', 11:08:32 INFO - 'sessionrestore', 11:08:32 INFO - 'sessionrestore_no_auto_restore', 11:08:32 INFO - 'tabpaint']}, 11:08:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:08:32 INFO - 'ts_paint', 11:08:32 INFO - 'tpaint', 11:08:32 INFO - 'sessionrestore', 11:08:32 INFO - 'sessionrestore_no_auto_restore', 11:08:32 INFO - 'tabpaint']}, 11:08:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:08:32 INFO - 'tests': ['a11yr', 11:08:32 INFO - 'ts_paint', 11:08:32 INFO - 'tpaint', 11:08:32 INFO - 'sessionrestore', 11:08:32 INFO - 'sessionrestore_no_auto_restore', 11:08:32 INFO - 'tabpaint']}, 11:08:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:08:32 INFO - 'tests': ['a11yr', 11:08:32 INFO - 'ts_paint', 11:08:32 INFO - 'tpaint', 11:08:32 INFO - 'sessionrestore', 11:08:32 INFO - 'sessionrestore_no_auto_restore', 11:08:32 INFO - 'tabpaint']}, 11:08:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:08:32 INFO - 'tests': ['tsvgx', 11:08:32 INFO - 'tsvgr_opacity', 11:08:32 INFO - 'tart', 11:08:32 INFO - 'tscrollx', 11:08:32 INFO - 'cart']}, 11:08:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:08:32 INFO - 'tsvgr_opacity', 11:08:32 INFO - 'tart', 11:08:32 INFO - 'tscrollx', 11:08:32 INFO - 'cart']}, 11:08:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:32 INFO - 'talos_options': ['--disable-e10s'], 11:08:32 INFO - 'tests': ['tp5o']}, 11:08:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:32 INFO - 'tests': ['tp5o']}, 11:08:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:32 INFO - 'talos_options': ['--disable-e10s', 11:08:32 INFO - '--xperf_path', 11:08:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:08:32 INFO - 'tests': ['tp5n']}, 11:08:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:32 INFO - 'talos_options': ['--xperf_path', 11:08:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:08:32 INFO - 'tests': ['tp5n']}}, 11:08:32 INFO - 'talos.zip': {'path': '', 11:08:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:08:32 INFO - Running post-action listener: _resource_record_post_action 11:08:32 INFO - ##### 11:08:32 INFO - ##### Running create-virtualenv step. 11:08:32 INFO - ##### 11:08:32 INFO - Running pre-action listener: _resource_record_pre_action 11:08:32 INFO - Running main action method: create_virtualenv 11:08:32 INFO - Creating virtualenv /builds/slave/test/build/venv 11:08:32 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 11:08:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:08:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:08:32 INFO - Using real prefix '/tools/python27' 11:08:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:08:33 INFO - Installing distribute.............................................................................................................................................................................................done. 11:08:36 INFO - Installing pip.................done. 11:08:36 INFO - Return code: 0 11:08:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:08:36 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')]} 11:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:36 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')]} 11:08:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:36 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 0x107729a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107739420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d4254c2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075c8e00>, '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 0x1073f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075c3b20>, '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.96Swecb1pE/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.iGkMjyUzY9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 11:08:36 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 11:08:36 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 11:08:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.96Swecb1pE/Render', 11:08:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:08:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:08:36 INFO - 'HOME': '/Users/cltbld', 11:08:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:08:36 INFO - 'LOGNAME': 'cltbld', 11:08:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:36 INFO - 'MOZ_NO_REMOTE': '1', 11:08:36 INFO - 'NO_EM_RESTART': '1', 11:08:36 INFO - 'PAGER': '/bin/cat', 11:08:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:08:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:36 INFO - 'PWD': '/builds/slave/test', 11:08:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:08:36 INFO - 'SHELL': '/bin/bash', 11:08:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iGkMjyUzY9/Listeners', 11:08:36 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 11:08:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:08:36 INFO - 'USER': 'cltbld', 11:08:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:08:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:08:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:36 INFO - 'XPC_FLAGS': '0x0', 11:08:36 INFO - 'XPC_SERVICE_NAME': '0', 11:08:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:08:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:36 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 11:08:36 INFO - Cleaning up... 11:08:36 INFO - Return code: 0 11:08:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:08:36 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')]} 11:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:36 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')]} 11:08:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:36 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 0x107729a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107739420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d4254c2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075c8e00>, '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 0x1073f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075c3b20>, '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.96Swecb1pE/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.iGkMjyUzY9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 11:08:36 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 11:08:36 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 11:08:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.96Swecb1pE/Render', 11:08:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:08:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:08:36 INFO - 'HOME': '/Users/cltbld', 11:08:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:08:36 INFO - 'LOGNAME': 'cltbld', 11:08:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:36 INFO - 'MOZ_NO_REMOTE': '1', 11:08:36 INFO - 'NO_EM_RESTART': '1', 11:08:36 INFO - 'PAGER': '/bin/cat', 11:08:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:08:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:36 INFO - 'PWD': '/builds/slave/test', 11:08:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:08:36 INFO - 'SHELL': '/bin/bash', 11:08:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iGkMjyUzY9/Listeners', 11:08:36 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 11:08:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:08:36 INFO - 'USER': 'cltbld', 11:08:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:08:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:08:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:36 INFO - 'XPC_FLAGS': '0x0', 11:08:36 INFO - 'XPC_SERVICE_NAME': '0', 11:08:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:08:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:36 INFO - Downloading/unpacking psutil>=0.7.1 11:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:08:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:08:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:08:40 INFO - Installing collected packages: psutil 11:08:40 INFO - Running setup.py install for psutil 11:08:40 INFO - building 'psutil._psutil_osx' extension 11:08:40 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 11:08:40 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 11:08:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 11:08:41 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 11:08:41 INFO - building 'psutil._psutil_posix' extension 11:08:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 11:08:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:08:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:08:41 INFO - ^ 11:08:41 INFO - 1 warning generated. 11:08:41 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 11:08:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:08:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:08:41 INFO - Successfully installed psutil 11:08:41 INFO - Cleaning up... 11:08:41 INFO - Return code: 0 11:08:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:08:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107729a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107739420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d4254c2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075c8e00>, '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 0x1073f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075c3b20>, '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.96Swecb1pE/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.iGkMjyUzY9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 11:08:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 11:08:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 11:08:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.96Swecb1pE/Render', 11:08:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:08:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:08:41 INFO - 'HOME': '/Users/cltbld', 11:08:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:08:41 INFO - 'LOGNAME': 'cltbld', 11:08:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:41 INFO - 'MOZ_NO_REMOTE': '1', 11:08:41 INFO - 'NO_EM_RESTART': '1', 11:08:41 INFO - 'PAGER': '/bin/cat', 11:08:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:08:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:41 INFO - 'PWD': '/builds/slave/test', 11:08:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:08:41 INFO - 'SHELL': '/bin/bash', 11:08:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iGkMjyUzY9/Listeners', 11:08:41 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 11:08:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:08:41 INFO - 'USER': 'cltbld', 11:08:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:08:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:08:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:41 INFO - 'XPC_FLAGS': '0x0', 11:08:41 INFO - 'XPC_SERVICE_NAME': '0', 11:08:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:08:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:08:41 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 11:08:41 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 11:08:41 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 11:08:41 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 11:08:41 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 11:08:41 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 11:08:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:08:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:08:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:08:44 INFO - Installing collected packages: mozsystemmonitor 11:08:44 INFO - Running setup.py install for mozsystemmonitor 11:08:44 INFO - Successfully installed mozsystemmonitor 11:08:44 INFO - Cleaning up... 11:08:44 INFO - Return code: 0 11:08:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107729a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107739420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d4254c2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075c8e00>, '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 0x1073f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075c3b20>, '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.96Swecb1pE/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.iGkMjyUzY9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 11:08:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:08:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:08:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.96Swecb1pE/Render', 11:08:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:08:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:08:44 INFO - 'HOME': '/Users/cltbld', 11:08:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:08:44 INFO - 'LOGNAME': 'cltbld', 11:08:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:44 INFO - 'MOZ_NO_REMOTE': '1', 11:08:44 INFO - 'NO_EM_RESTART': '1', 11:08:44 INFO - 'PAGER': '/bin/cat', 11:08:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:08:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:44 INFO - 'PWD': '/builds/slave/test', 11:08:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:08:44 INFO - 'SHELL': '/bin/bash', 11:08:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iGkMjyUzY9/Listeners', 11:08:44 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 11:08:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:08:44 INFO - 'USER': 'cltbld', 11:08:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:08:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:08:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:44 INFO - 'XPC_FLAGS': '0x0', 11:08:44 INFO - 'XPC_SERVICE_NAME': '0', 11:08:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:08:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:44 INFO - Downloading/unpacking blobuploader==1.2.4 11:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:47 INFO - Downloading blobuploader-1.2.4.tar.gz 11:08:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:08:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:08:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:48 INFO - Downloading docopt-0.6.1.tar.gz 11:08:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:08:48 INFO - Installing collected packages: blobuploader, requests, docopt 11:08:48 INFO - Running setup.py install for blobuploader 11:08:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:08:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:08:48 INFO - Running setup.py install for requests 11:08:49 INFO - Running setup.py install for docopt 11:08:49 INFO - Successfully installed blobuploader requests docopt 11:08:49 INFO - Cleaning up... 11:08:49 INFO - Return code: 0 11:08:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107729a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107739420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d4254c2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075c8e00>, '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 0x1073f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075c3b20>, '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.96Swecb1pE/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.iGkMjyUzY9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 11:08:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:08:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:08:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.96Swecb1pE/Render', 11:08:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:08:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:08:49 INFO - 'HOME': '/Users/cltbld', 11:08:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:08:49 INFO - 'LOGNAME': 'cltbld', 11:08:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:49 INFO - 'MOZ_NO_REMOTE': '1', 11:08:49 INFO - 'NO_EM_RESTART': '1', 11:08:49 INFO - 'PAGER': '/bin/cat', 11:08:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:08:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:49 INFO - 'PWD': '/builds/slave/test', 11:08:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:08:49 INFO - 'SHELL': '/bin/bash', 11:08:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iGkMjyUzY9/Listeners', 11:08:49 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 11:08:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:08:49 INFO - 'USER': 'cltbld', 11:08:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:08:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:08:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:49 INFO - 'XPC_FLAGS': '0x0', 11:08:49 INFO - 'XPC_SERVICE_NAME': '0', 11:08:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:08:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:08:49 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-WDI2Ra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:08:49 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-x1mA9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:08:49 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-1J5Tv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:08:50 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-8uc94Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:08:50 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-DmebrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:08:50 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-vnwboI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:08:50 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-I1mz8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:08:50 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-2dlJIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:08:50 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-h_ppv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:08:50 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-lLfB0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:08:50 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-Es9xR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:08:50 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-TTlnMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:08:50 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-WsBXde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:08:51 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-hD7jQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:08:51 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-aiaB4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:08:51 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-R7CdBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:08:51 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-Nsh6xU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:08:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:08:51 INFO - Running setup.py install for manifestparser 11:08:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:08:51 INFO - Running setup.py install for mozcrash 11:08:51 INFO - Running setup.py install for mozdebug 11:08:51 INFO - Running setup.py install for mozdevice 11:08:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:08:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:08:52 INFO - Running setup.py install for mozfile 11:08:52 INFO - Running setup.py install for mozhttpd 11:08:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:08:52 INFO - Running setup.py install for mozinfo 11:08:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:08:52 INFO - Running setup.py install for mozInstall 11:08:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:08:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:08:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:08:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:08:52 INFO - Running setup.py install for mozleak 11:08:52 INFO - Running setup.py install for mozlog 11:08:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:08:52 INFO - Running setup.py install for moznetwork 11:08:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:08:53 INFO - Running setup.py install for mozprocess 11:08:53 INFO - Running setup.py install for mozprofile 11:08:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:08:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:08:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:08:53 INFO - Running setup.py install for mozrunner 11:08:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:08:53 INFO - Running setup.py install for mozscreenshot 11:08:53 INFO - Running setup.py install for moztest 11:08:53 INFO - Running setup.py install for mozversion 11:08:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:08:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:08:53 INFO - Cleaning up... 11:08:54 INFO - Return code: 0 11:08:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:08:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107729a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107739420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d4254c2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075c8e00>, '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 0x1073f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075c3b20>, '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.96Swecb1pE/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.iGkMjyUzY9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 11:08:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:08:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:08:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.96Swecb1pE/Render', 11:08:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:08:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:08:54 INFO - 'HOME': '/Users/cltbld', 11:08:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:08:54 INFO - 'LOGNAME': 'cltbld', 11:08:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:54 INFO - 'MOZ_NO_REMOTE': '1', 11:08:54 INFO - 'NO_EM_RESTART': '1', 11:08:54 INFO - 'PAGER': '/bin/cat', 11:08:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:08:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:54 INFO - 'PWD': '/builds/slave/test', 11:08:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:08:54 INFO - 'SHELL': '/bin/bash', 11:08:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iGkMjyUzY9/Listeners', 11:08:54 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 11:08:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:08:54 INFO - 'USER': 'cltbld', 11:08:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:08:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:08:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:54 INFO - 'XPC_FLAGS': '0x0', 11:08:54 INFO - 'XPC_SERVICE_NAME': '0', 11:08:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:08:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:08:54 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-1P3uFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:08:54 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)) 11:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:08:54 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-hNJ6iI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:08:54 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)) 11:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:08:54 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-eobHev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:08:54 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)) 11:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:08:54 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-deM3xQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:08:54 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)) 11:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:08:54 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-hi7Rc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:08:54 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)) 11:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:08:54 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-zJqZLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:08:54 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)) 11:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:08:54 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-vHLjdS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:08:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:08:55 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-cl549J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:08:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:08:55 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-gl3cjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:08:55 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)) 11:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:08:55 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-OF3rh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:08:55 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)) 11:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:08:55 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-QLUHHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:08:55 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)) 11:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:08:55 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-PKQ4pZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:08:55 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)) 11:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:08:55 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-PeIGMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:08:55 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)) 11:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:08:55 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-lhkv6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:08:55 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)) 11:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:08:55 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-9uxg14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:08:55 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)) 11:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:08:55 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-bqUMu2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:08:55 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)) 11:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:08:55 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-0TIH59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:08:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:58 INFO - Downloading blessings-1.6.tar.gz 11:08:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:08:58 INFO - Installing collected packages: blessings 11:08:58 INFO - Running setup.py install for blessings 11:08:58 INFO - Successfully installed blessings 11:08:58 INFO - Cleaning up... 11:08:58 INFO - Return code: 0 11:08:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:08:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:08:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:08:59 INFO - Reading from file tmpfile_stdout 11:08:59 INFO - Current package versions: 11:08:59 INFO - blessings == 1.6 11:08:59 INFO - blobuploader == 1.2.4 11:08:59 INFO - docopt == 0.6.1 11:08:59 INFO - manifestparser == 1.1 11:08:59 INFO - mozInstall == 1.12 11:08:59 INFO - mozcrash == 0.17 11:08:59 INFO - mozdebug == 0.1 11:08:59 INFO - mozdevice == 0.48 11:08:59 INFO - mozfile == 1.2 11:08:59 INFO - mozhttpd == 0.7 11:08:59 INFO - mozinfo == 0.9 11:08:59 INFO - mozleak == 0.1 11:08:59 INFO - mozlog == 3.1 11:08:59 INFO - moznetwork == 0.27 11:08:59 INFO - mozprocess == 0.22 11:08:59 INFO - mozprofile == 0.28 11:08:59 INFO - mozrunner == 6.11 11:08:59 INFO - mozscreenshot == 0.1 11:08:59 INFO - mozsystemmonitor == 0.0 11:08:59 INFO - moztest == 0.7 11:08:59 INFO - mozversion == 1.4 11:08:59 INFO - psutil == 3.1.1 11:08:59 INFO - requests == 1.2.3 11:08:59 INFO - wsgiref == 0.1.2 11:08:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:08:59 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')]} 11:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:59 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')]} 11:08:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:59 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 0x107729a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107739420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d4254c2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075c8e00>, '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 0x1073f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075c3b20>, '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.96Swecb1pE/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.iGkMjyUzY9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 11:08:59 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 11:08:59 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 11:08:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.96Swecb1pE/Render', 11:08:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:08:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:08:59 INFO - 'HOME': '/Users/cltbld', 11:08:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:08:59 INFO - 'LOGNAME': 'cltbld', 11:08:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:59 INFO - 'MOZ_NO_REMOTE': '1', 11:08:59 INFO - 'NO_EM_RESTART': '1', 11:08:59 INFO - 'PAGER': '/bin/cat', 11:08:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:08:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:59 INFO - 'PWD': '/builds/slave/test', 11:08:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:08:59 INFO - 'SHELL': '/bin/bash', 11:08:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iGkMjyUzY9/Listeners', 11:08:59 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 11:08:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:08:59 INFO - 'USER': 'cltbld', 11:08:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:08:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:08:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:59 INFO - 'XPC_FLAGS': '0x0', 11:08:59 INFO - 'XPC_SERVICE_NAME': '0', 11:08:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:08:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:59 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)) 11:08:59 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)) 11:08:59 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)) 11:08:59 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)) 11:08:59 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)) 11:08:59 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)) 11:08:59 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)) 11:08:59 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)) 11:08:59 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)) 11:08:59 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)) 11:08:59 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)) 11:08:59 INFO - Cleaning up... 11:08:59 INFO - Return code: 0 11:08:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:08:59 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')]} 11:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:59 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')]} 11:08:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:59 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 0x107729a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107739420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d4254c2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075c8e00>, '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 0x1073f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075c3b20>, '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.96Swecb1pE/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.iGkMjyUzY9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 11:08:59 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 11:08:59 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 11:08:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.96Swecb1pE/Render', 11:08:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:08:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:08:59 INFO - 'HOME': '/Users/cltbld', 11:08:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:08:59 INFO - 'LOGNAME': 'cltbld', 11:08:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:59 INFO - 'MOZ_NO_REMOTE': '1', 11:08:59 INFO - 'NO_EM_RESTART': '1', 11:08:59 INFO - 'PAGER': '/bin/cat', 11:08:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:08:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:59 INFO - 'PWD': '/builds/slave/test', 11:08:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:08:59 INFO - 'SHELL': '/bin/bash', 11:08:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iGkMjyUzY9/Listeners', 11:08:59 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 11:08:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:08:59 INFO - 'USER': 'cltbld', 11:08:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:08:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:08:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:59 INFO - 'XPC_FLAGS': '0x0', 11:08:59 INFO - 'XPC_SERVICE_NAME': '0', 11:08:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:08:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:59 INFO - Downloading/unpacking jsonschema 11:08:59 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 11:08:59 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 11:08:59 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 11:08:59 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 11:08:59 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 11:08:59 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 11:09:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:09:02 INFO - Downloading/unpacking functools32 (from jsonschema) 11:09:02 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 11:09:02 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 11:09:02 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 11:09:02 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 11:09:02 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 11:09:02 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 11:09:02 INFO - Downloading functools32-3.2.3-2.tar.gz 11:09:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:09:02 INFO - warning: no files found matching '*.txt' 11:09:02 INFO - no previously-included directories found matching 'build' 11:09:02 INFO - no previously-included directories found matching 'dist' 11:09:02 INFO - no previously-included directories found matching '.git*' 11:09:02 INFO - Installing collected packages: jsonschema, functools32 11:09:02 INFO - Running setup.py install for functools32 11:09:02 INFO - warning: no files found matching '*.txt' 11:09:02 INFO - no previously-included directories found matching 'build' 11:09:02 INFO - no previously-included directories found matching 'dist' 11:09:02 INFO - no previously-included directories found matching '.git*' 11:09:02 INFO - Successfully installed jsonschema functools32 11:09:02 INFO - Cleaning up... 11:09:02 INFO - Return code: 0 11:09:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:02 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 0x107729a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107739420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d4254c2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075c8e00>, '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 0x1073f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075c3b20>, '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.96Swecb1pE/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.iGkMjyUzY9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 11:09:02 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 11:09:02 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 11:09:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.96Swecb1pE/Render', 11:09:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:09:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:09:02 INFO - 'HOME': '/Users/cltbld', 11:09:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:09:02 INFO - 'LOGNAME': 'cltbld', 11:09:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:02 INFO - 'MOZ_NO_REMOTE': '1', 11:09:02 INFO - 'NO_EM_RESTART': '1', 11:09:02 INFO - 'PAGER': '/bin/cat', 11:09:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:09:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:02 INFO - 'PWD': '/builds/slave/test', 11:09:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:09:02 INFO - 'SHELL': '/bin/bash', 11:09:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iGkMjyUzY9/Listeners', 11:09:02 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 11:09:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:09:02 INFO - 'USER': 'cltbld', 11:09:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:09:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:09:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:02 INFO - 'XPC_FLAGS': '0x0', 11:09:02 INFO - 'XPC_SERVICE_NAME': '0', 11:09:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:09:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:03 INFO - Downloading/unpacking flake8 11:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:09:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:09:05 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 11:09:05 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 11:09:05 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 11:09:05 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 11:09:05 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 11:09:05 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 11:09:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:09:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:09:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:09:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:09:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:09:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:09:06 INFO - no previously-included directories found matching 'docs/_build' 11:09:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:09:07 INFO - Running setup.py install for pep8 11:09:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:09:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:09:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:09:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:09:07 INFO - no previously-included directories found matching 'docs/_build' 11:09:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:09:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:09:07 INFO - Cleaning up... 11:09:07 INFO - Return code: 0 11:09:07 INFO - Running post-action listener: _resource_record_post_action 11:09:07 INFO - Running post-action listener: _start_resource_monitoring 11:09:07 INFO - Starting resource monitoring. 11:09:07 INFO - ##### 11:09:07 INFO - ##### Running install step. 11:09:07 INFO - ##### 11:09:07 INFO - Running pre-action listener: _resource_record_pre_action 11:09:07 INFO - Running main action method: install 11:09:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:09:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:09:07 INFO - Reading from file tmpfile_stdout 11:09:07 INFO - Detecting whether we're running mozinstall >=1.0... 11:09:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:09:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:09:07 INFO - Reading from file tmpfile_stdout 11:09:07 INFO - Output received: 11:09:07 INFO - Usage: mozinstall [options] installer 11:09:07 INFO - Options: 11:09:07 INFO - -h, --help show this help message and exit 11:09:07 INFO - -d DEST, --destination=DEST 11:09:07 INFO - Directory to install application into. [default: 11:09:07 INFO - "/builds/slave/test"] 11:09:07 INFO - --app=APP Application being installed. [default: firefox] 11:09:07 INFO - mkdir: /builds/slave/test/build/application 11:09:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:09:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 11:09:41 INFO - Reading from file tmpfile_stdout 11:09:41 INFO - Output received: 11:09:41 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:09:41 INFO - Running post-action listener: _resource_record_post_action 11:09:41 INFO - ##### 11:09:41 INFO - ##### Running run-tests step. 11:09:41 INFO - ##### 11:09:41 INFO - Running pre-action listener: _resource_record_pre_action 11:09:41 INFO - Running main action method: run_tests 11:09:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:09:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:09:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:09:41 INFO - 2016-04-29 11:09:41.484 screenresolution[1644:7845] starting screenresolution argv=screenresolution get 11:09:41 INFO - 2016-04-29 11:09:41.486 screenresolution[1644:7845] Display 0: 1600x1200x32@60 11:09:41 INFO - 2016-04-29 11:09:41.491 screenresolution[1645:7847] starting screenresolution argv=screenresolution list 11:09:41 INFO - Available Modes on Display 0 11:09:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:09:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:09:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:09:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:09:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:09:41 INFO - Intel Iris: 11:09:41 INFO - Chipset Model: Intel Iris 11:09:41 INFO - Type: GPU 11:09:41 INFO - Bus: Built-In 11:09:41 INFO - VRAM (Dynamic, Max): 1536 MB 11:09:41 INFO - Vendor: Intel (0x8086) 11:09:41 INFO - Device ID: 0x0a2e 11:09:41 INFO - Revision ID: 0x0009 11:09:41 INFO - Displays: 11:09:41 INFO - Display: 11:09:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:09:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:09:41 INFO - Display Serial Number: 1600x1200 60 11:09:41 INFO - Main Display: Yes 11:09:41 INFO - Mirror: Off 11:09:41 INFO - Online: Yes 11:09:41 INFO - Rotation: Supported 11:09:41 INFO - Return code: 0 11:09:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:09:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:09:41 INFO - Python 2.7.3 11:09:41 INFO - Return code: 0 11:09:41 INFO - grabbing minidump binary from tooltool 11:09:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:41 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 0x1075c8e00>, '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 0x1073f1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1075c3b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:09:41 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 11:09:41 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 11:09:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:09:41 INFO - Return code: 0 11:09:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:09:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:09:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:09:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:09:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:09:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:09:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:09:42 INFO - Return code: 0 11:09:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:09:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0032 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:09:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.96Swecb1pE/Render', 11:09:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:09:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:09:42 INFO - 'HOME': '/Users/cltbld', 11:09:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:09:42 INFO - 'LOGNAME': 'cltbld', 11:09:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:09:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:42 INFO - 'MOZ_NO_REMOTE': '1', 11:09:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:09:42 INFO - 'NO_EM_RESTART': '1', 11:09:42 INFO - 'PAGER': '/bin/cat', 11:09:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:42 INFO - 'PWD': '/builds/slave/test', 11:09:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:09:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:09:42 INFO - 'SHELL': '/bin/bash', 11:09:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iGkMjyUzY9/Listeners', 11:09:42 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 11:09:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:09:42 INFO - 'USER': 'cltbld', 11:09:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:09:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:42 INFO - 'XPC_FLAGS': '0x0', 11:09:42 INFO - 'XPC_SERVICE_NAME': '0', 11:09:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:09:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:09:43 INFO - mozversion application_buildid: 20160429101348 11:09:43 INFO - mozversion application_changeset: e828b778e62c0795a1e85dd39f782b59dcebd445 11:09:43 INFO - mozversion application_display_name: Nightly 11:09:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:09:43 INFO - mozversion application_name: Firefox 11:09:43 INFO - mozversion application_remotingname: firefox 11:09:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:09:43 INFO - mozversion application_vendor: Mozilla 11:09:43 INFO - mozversion application_version: 49.0a1 11:09:43 INFO - mozversion platform_buildid: 20160429101348 11:09:43 INFO - mozversion platform_changeset: e828b778e62c0795a1e85dd39f782b59dcebd445 11:09:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:09:43 INFO - mozversion platform_version: 49.0a1 11:09:43 INFO - using testdate: 1461953383 11:09:43 INFO - actual date: 1461953383 11:09:43 INFO - starting webserver on 'localhost:49275' 11:09:43 INFO - SUITE-START | Running 2 tests 11:09:43 INFO - TEST-START | dromaeo_css 11:09:43 INFO - operating with platform_type : mac_ 11:09:43 INFO - Initialising browser for dromaeo_css test... 11:09:43 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpncFqiI/profile http://localhost:49275/getInfo.html) 11:09:45 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 11:09:45 INFO - PROCESS | 1663 | colorDepth:24 11:09:45 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 11:09:45 INFO - PROCESS | 1663 | __metrics 11:09:45 INFO - PROCESS | 1663 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:09:45 ERROR - PROCESS | 1663 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:09:46 INFO - TEST-INFO | 1663: exit 0 11:09:46 INFO - Browser initialized. 11:09:46 INFO - Running cycle 1/1 for dromaeo_css test... 11:09:46 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpncFqiI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:09:58 INFO - PROCESS | 1665 | RSS: Main: 239382528 11:09:58 INFO - PROCESS | 1665 | 11:10:49 INFO - PROCESS | 1665 | 1461953449456 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] 11:12:59 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 11:13:01 INFO - PROCESS | 1665 | RSS: Main: 326377472 11:13:01 INFO - PROCESS | 1665 | 11:16:03 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 11:16:04 INFO - PROCESS | 1665 | RSS: Main: 368308224 11:16:04 INFO - PROCESS | 1665 | 11:19:06 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 11:19:07 INFO - PROCESS | 1665 | RSS: Main: 369676288 11:19:07 INFO - PROCESS | 1665 | 11:22:09 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 11:22:10 INFO - PROCESS | 1665 | RSS: Main: 368218112 11:22:10 INFO - PROCESS | 1665 | 11:25:13 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 11:25:14 INFO - PROCESS | 1665 | RSS: Main: 336527360 11:25:14 INFO - PROCESS | 1665 | 11:28:17 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 11:28:17 INFO - PROCESS | 1665 | RSS: Main: 374444032 11:28:17 INFO - PROCESS | 1665 | 11:28:17 INFO - PROCESS | 1665 | __start_tp_report 11:28:17 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 11:28:17 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 11:28:17 INFO - PROCESS | 1665 | |i|pagename|runs| 11:28:17 INFO - PROCESS | 1665 | |0;dojo.html;3337.5828021497314;3390.542276792632;3394.202362444825;3418.914527136823;3448.7930724156536;5554.50009499145;5579.609427340083;5592.832215033545;5599.832005039845;5601.52387047101;5631.1271752878365;5662.122371032487;5683.715814209283;5769.971150144243;5784.82645520634;5124.256982737501;5145.099607568679;5159.406668233145;5161.922571161435;5257.263983042358;5252.947470525284;5257.369115706101;5290.629655924067;5304.814331498398;5338.225957236198;5132.717700526469;5142.6914385137015;5170.6122040847085;5181.35233095863;5192.3769147702515;5180.456052114511;5184.403793563751;5212.400573934008;5254.106801843695;5282.313299271109;5154.896902061938;5160.200168973777;5167.689938603658;5184.274201611777;5245.423003469616;5440.047991601454;5537.501624853782;5541.251930989305;5551.3893471718075;5563.332400112013;6113.633182009094;6114.724837382284;6128.38716128388;6143.020634992025;6144.695739097839;6165.907511387333;6222.688865556749;6228.532860035471;6233.189685340877;6234.625922444622;5541.889162216733;5663.1505274208375;5706.457886500776;5719.771209151588;5764.193012978187;6314.778982735674;6340.207474065742;6347.809565713036;6353.047042943595;6362.6500542469685;6051.425114614105;6085.6348619083;6087;6090.908636370458;6093.75624974996;6007.339192688801;6111.075205202202;6145.125736650364;6229.065640154013;6247.718852651642;6099.8795552502925;6139.706800529493;6140.17107690465;6156.322804491502;6157.876842463125;6167.907481387782;6174.44430001302;6187.133801267826;6188.257409110935;6192.845178870474;4757.381540399726;4833.081714474239;4835.564799168022;4836.854894353175;4920.40955085392;4397.516273209944;4402.207602631493;4440.666949978765;4449.310356894686;4453.1093781243235;5585.134304182858;5590.993621148233;5594.86012849682;5596.412376700469;5605.523530499871;6096.6476373754385;6126.548209435026;6214.9689251553455;6222.81331560054;6223.284322302902;5613.129964855454;5639.379668236491;5648.378678345379;5651.095824668033;5664.122061080539;5204.531592156724;5296.179092240709;5303.946960530422;5311.203319502106;5316.574674026068;6241.157443745127;6323.494120470351;6328.968355158195;6336.588121771978;6346.841328966812;6167.414095660905;6184.793965176747;6189.257289125334;6197.25632924052;6211.503079753518;5220.477952204749;6171.691415429121;6211.9068213975925;6359.077933699495;6371.076193951943;6074.635521868702;6123.313124872426;6126.9168432863735;6129.389354848411;6130.489860652556;6202.658853763086;6205.286392064971;6205.441510264098;6213.37866213375;6217.751289948352;5796.884062318814;5881.264841894763;5945.256842894638;6001.849953751192;6027.698615069141;5979.1928089707335;5992.970035149797;5997.220361352996;6001.939980600138;6013.6692481913915;5636.915446268227;5794.1308803679785;5848.327442344185;5856.59003869725;5862.7654893805475;5789.594728368974;5873.765049397976;5979.252593425822;5989.490893274121;6030.095485677183;5828.154917537018;5838.795642152504;5844.211031510692;5844.824655260349;5855.531557475307 11:28:17 INFO - PROCESS | 1665 | |1;ext.html;495.28431416603013;507.91111555477795;531.3464438740349;543.7743336515347;556.9275994120763;24561.508769824613;38164;38944.610553894454;38980;39046.82859514216;42153.36769948453;42754.14491710164;42771.78614106925;42777;42968.78515607418;8568.571571421435;8782.780430489225;9392;9662.033796620351;9663.5168241588;8638.740837774845;9546.809063818719;11363.772724545504;11620.07039436843;11628.767424651502;11517.078633709325;11641.941790291037;11648.009919156882;11649.534018639244;11651;8430.199131082598;9370.672026479075;11232.269902456314;11613.954744073075;11617.593384231512;11387.487563059682;11536.769264614744;11546.59586914454;11558.248713833575;11565.768684626344;37927.431088533696;38676;38753.612463875565;38790;38876.61123388758;3199.280161963563;3201.2317043909525;3211.951820722691;3261.037993791837;3445.328161008604;27614.585781213296;28877.85561072202;30301.393972120655;30317.545236821465;30377.392452151053;2494.7006359237007;2816.324082220273;2847.8893231639677;2854.24362543926;2923.1961210667023;448355;482878.5856070732;487235;488267;490135.99999999645;60224;60630.696846515486;60915.39084609186;60967;61049.69475152685;65224.34775652277;65499;65609.67195163993;65639;65646.67176664087;16932.06873621938;17132.486025419257;17134.314627414762;17144.485665430057;17152;11815;12013.519459221534;12842.550510732079;13253.006024548005;13336;16358.672826543641;16405.91797041031;16418.917905410395;16434.616980537754;16455.83544164567;6765.274854911966;6765.763198288037;6858.245592984767;6864.931350686529;6873.1064961554675;986.3736527305069;1055.7466208109997;1062.436908438529;1063.776606912557;1081.4940493022323;29323;29338.97313594014;29727;30036.69963300339;30108.24729381783;964.2141654551518;1023.6417253961054;1118.3122379736403;1130.6834086455806;1174.9412529373496;14667.413303467954;15150.924245378703;15165.393384264506;15183.392664293526;15645.139517326428;643271;648240;651819;651935;652820;60141.69929150414;60372.69813650904;60549.39450605526;60596;60706.39293607096;1138.5616537632905;1485.7697056955756;1487.9628009299638;1494.6562290673205;1541.5606552132588;28461.146165615064;28706.712932870403;29139.562906556843;29204.415911682074;29291.707082928897;52024.95950081053;53609.46390536045;53628;53644.195337070756;53706.92586148177;416830;427196;427410;428001.89985751815;428531;23017.65473517932;25219.865106069905;25250.242492725247;25549.87225063863;25745.742542575084;36014.8199259002;43465;43639.781801090794;44524;44965.77517112524;36000.81999589985;37540.81229593835;37570.624293757806;37868.59182673573;38067.80966095152;30958.84520577383;33440.665593344725;36602.633973659926;37435.25129497449;37461.250774984896;36591.817040914626;36934.445983309735;37380.25239495141;37671.434928475544;37745.433818492194;30988.22529436692;33164.33671326512;33374.831880884056;33430.997070087935;33515.497267540515;23293.18473853407;24489.265322040366;24591;25103.372415689755;25163.49673006566 11:28:17 INFO - PROCESS | 1665 | |2;jquery.html;382.67594124329815;391.77864506553794;393.6122918924859;395.4226828829909;408.10217521452813;14796.482123125692;19149.90425047876;20100.09549570269;20144.99999999998;20248.08883600238;18821.529461763428;19293.807061929376;20061.699074513857;22144;22156.88921555394;6035.396460353952;6151.938480615181;6223.87552248957;6228.96885515574;6245.188125543673;5931.169636250928;6095.542834287424;6159.692015399234;6170.969145154268;6196.504279657616;5918.940810591882;6081.422264884851;6111.51107911366;6115.571909966304;6120.96939515304;5913.852153696149;5979.34227235006;6026.186464827258;6028.7588496460085;6038.96980515099;5084.059449001909;5258.3689957205;5287.41838397776;5288.127458969266;5296;25742.613860792102;26324.341891452674;26756.732432675813;26782.732172678414;26799.79400926963;2230.565039817236;2445.2297526279344;2648.695400029002;2998.4003199360213;3111.579936708538;12437.191582547195;14003.929980350134;15281.61795955099;15501.224938753017;15591.610209744733;1668.124234776752;1673.8493535581856;1722.1991773825107;1757.0511923561262;1784.9286028558972;84399;113045;114581;125175;125818.3709081458;11646.883531164749;11775.470103845348;11809.763804723858;11858.16992810495;11930.22453540517;15030.624234394227;15141.167235801917;15159.317830697644;15180.696386072217;15214.391424342903;7123.964380178066;8291.875621865556;8600.268977137013;8750.737477875675;8758.47449153053;8586.527740974307;8605.053444121142;8611.268042216356;8712;8738.388312818042;4555.248384016666;4634.629229661619;4645.72970029944;4645.976770116195;4677.976610116928;1576.9119307677665;1811.5652243461475;2005.6089062632645;2011.688188330811;2048.313814872005;920.7099763574587;980.6910823090703;1018.5721996761378;1046.9214808889212;1047.0785708576404;19971.400857974284;20069.799302007086;20422.69365959512;20581.38255852327;20620.381388558366;929.6467342409841;966.3525437956586;985.6353149334792;1002.644061358222;1016.6390931219458;10511.054005139575;10782.67651970442;10823.783524329468;10835.891641083488;10842.186835987333;584356;591362;599538;611671;612768.9361553253;116151;122870.38564807118;128862;129602;133923.66076339112;997.4464172384396;1015.1168483419325;1036.0002597493303;1037.5538518436992;1051.279873286801;17986;18291.63416731631;18427.447176584723;18611.81388186101;18663;54977.72511137419;56161.71919140378;56491.15263271136;57464.71267643635;57812.71093644505;81892;85039;85681.57159214164;86306;86714;7725.690972361042;7813.648385822538;8031.638576264199;8061.758147255592;8083.474574152661;9562.760930976503;11100.666979990614;12272.570460033856;12623.179493332904;12720.491180353052;10370.429626370622;10723.30298530593;10947.50736216888;10969.177311701495;11146.275492092987;5990.161377407254;8635;10466.267361284637;10467.319624224401;10901.890981090404;10732.946335268585;10865.945670271598;11064.391458469861;11078.667639970814;11123.888761112608;7898.68405263783;7944.086430060386;7982.401319900914;8006.799830004296;8090.11008789021;8252.752417427488;10438.530266138194;10792.244542881923;11042.282251653616;11333.036691881283 11:28:17 INFO - PROCESS | 1665 | |3;mootools.html;1430.1419148510895;1437.0802686280776;1590.5705459525925;1817.7818661760582;1986.2849374225268;7790.3767698584115;8557.015943166538;8765.649374025032;8767.736967890958;8779.868301975475;8440.662373505053;8667.306615470763;8670.089640587727;8675.60959756811;8689.000764912036;2045.0899349789274;2381.3451300892307;2430.9756902431013;2456.4472993576483;2471.0486462711897;2160.1899287767087;2430.7812296893276;2448;2475.504899020194;2484.229888734489;2397.160993652225;2429.2712186344115;2446.6085426331792;2447.155731272708;2447.571674956884;2089.6238677038127;2130.6803979403135;2305.6772051912744;2406.6630671705975;2433.9634905476432;2416.66166736657;2447.2535876557645;2448.24104527597;2448.5959816630234;2453.2272334214845;8556.957215213884;8648.264897483721;8648.870266946002;8657.177568131017;8679.522626255553;5105.642605017651;5380.515753582196;5390.21841832932;5403.675779453206;5404.675719456845;2941.3234955960247;2999.760019198459;3491.2319289756215;3634.182308980485;3640.4721315409383;1045.9163266938626;1046.6859942017363;1052.921030922684;1055.9313644613153;1062.1078294232882;11528.423578821026;11712.004479619243;11720.413979301002;11745.354005529607;11772.587959421464;4851.611871050308;4864.635152363587;4893.021395720799;4943;4946.530079642428;10044.096031357212;10045.19638428924;10051.195904327637;10069.899301007043;10101.090901818872;5310.176922577007;5399.946000540023;5443.755031023614;5452.318460192476;5454.509094181463;4420.84527041552;4616.053708989649;4801.231802911518;4939.234418665113;4971.7016978980655;3969.2061587682;3998.4402183694306;4078.4290199372113;4116.670666346685;4122.216778812016;1331.7136815584695;1335.4124185358412;1338.4713038349992;1353.708952575201;1356.2066191278016;905.7328088213993;925.9768505787409;929.5491686532026;953.4088864903804;974.770928831724;5793.449622285876;5938.673372964442;5954.374790647006;6077.118817771398;6149.200603921461;428.2355994549714;460.34630824229674;473.836526398392;480.41149591750525;480.49787971569793;3946.230485055444;3984.4023396490757;4030.9798451008146;4058.5332686741403;4082.4896887889013;10218.540165692562;10677.89322106769;10781.784364312669;10785.13718902486;10806.621768238074;10604.257701960789;10739.892601074045;10745.301555398873;10759.946200268949;10766.461676916122;8150.75547733569;8213.79465513355;8225.83548329042;8230.09468958414;8237.546934918517;4971.602271818174;5641.5204707600315;5850.151727999501;5918;5946.316173639913;9624.470654114091;9825.656102036395;9882.555285012335;9936.602535898772;9943.751406214902;9625;10068.44623545712;10154.441505717257;10204.2346823987;10209.54057067419;6920.757773477904;7135.750248741269;7320.1215854097845;7438.107427108782;7626.275503827128;8343.874841877498;8355.456895301786;8448.281896038905;8463.957680211559;8464;7308.926910731037;7311.195768465358;7395.741149059757;7572.8485430292185;7593.468457207942;7044.823879403056;7139.607321597362;7219.675114619749;7267.127944646676;7429.405647548291;6982.057422247932;7002.544834585736;7045.929540704732;7057;7095.325944035309;4563.657725670521;4825.782839772289;4856.8300109495995;4898.436679781871;5091.465396133501;4416.227160247008;4892.535209155125;4966.652334336562;5017.422996355466;5179.274901513866 11:28:17 INFO - PROCESS | 1665 | |4;prototype.html;295.4814300901917;315.34251086484676;323.61328212785713;324.34967889381795;330.95366648669176;4321.018497236908;4340.370646256291;4761.571458568728;5160.071187186305;5162.767675454605;4502.896790286384;4763.071201115784;5179.482051794818;5218.973905130469;5250.422453530108;3629.3687076869323;4036.6789096269617;4054.1688953764556;4054.5539990600937;4075;3651.7626354286886;3765.5104836371233;3896;4014.0767623446623;4039.2527382434196;3965.1673148638674;3993.101552150772;4001.939001414274;4003.3994900764974;4011.9799401002956;3805.3721136012523;4007;4007.5190977082643;4018.6985976051765;4031.4154447605224;3164.971384300112;3390.9830450847835;3416.3167366526545;3429.554157959474;3561.7684850484634;4199.706020578561;4841.080194762983;5012.573931215815;5058.519440653132;5094.78376906047;4310.956890431087;4593.793279302439;4594.95405045952;4626.375439315683;4633.652476064275;5097.515736005073;5444.366689992986;5501.257330260403;5501.669899805985;5505.889882202334;3254.8047117173046;3848.960780589225;3862.2661694278;3864.574896761354;3886.747361421527;5577.239266563077;5708.316046766173;5708.828735137952;5789.88420231593;5806.393624352112;3960.6039396060164;3968.940465893014;3972.3644216925154;3981.3629819228786;3994.463515667572;3080;3407.522946787452;4024.63778259958;4028.315186418316;4040.4747382840633;4041.5150181977765;4375.890602734893;4592.402987611589;4612.5156858530045;4623;4660.906781864412;5018.749062546858;5555.805546805843;5563.777448902079;5595.160725891067;1458.3364569121024;1460.8393076761547;1465.4724299252262;1467.8752306054105;1471.683588028579;886.866969954512;891.9018907920124;896.7982204004047;969.5297780576415;992.270681049428;4791.113643975876;5572.414896435897;5602.52378547828;5605.80379686709;5609.691466969356;5148.536631703165;5658.009848276535;6125.387461253839;6199.659018754011;6201.56589038772;4456.77716114193;5273.868153296122;5564.554835613141;5576.191452239403;5596.188552659842;2701.729827017322;3112.097491727419;3154.747620190379;3223.3714425687235;3233.4503134467195;6477.352264773579;6505.381988711065;6505.934940650627;6510.446612037935;6523.934760652428;4965.950340496621;5558.638688485235;6321.747130114744;6396.904046439307;6415.871682566416;6415.541198866836;6452.161219041494;6467.611943283418;6476.761619190404;6504.252011018793;5676.602637815478;6160.812911416383;6195.752169913153;6200.100985357189;6226.501879849692;5868.562202260303;6041.426064523863;6101.383133469545;6102.298235702773;6130.754769809336;5158.303629010185;6372.235331760218;6395.848747225544;6441.806745797634;6450.516211284079;3091.6908309168903;3882.9417558736077;4194.846417235285;4199.4330765346285;4210.494740631144;4996.2755400466;5576.247206627054;5690;5690.5163061140265;5695.658260504383;5073.746312684425;5466.5900057495055;5535.8892822144135;5538.639988400902;5542.503524048565;4808.095742342861;5232.869178270574;5521.944780552143;5589.77640894376;5605.5795815313195;4483.744551525578;5144.382674079135;5419.891602168013;5489.670619762827;5504.339479262514;4498.865034048984;4946.505349465168;5576.944230557642;5582.692951887685;5623.971880140573;4765.951490672047;5317.441668624893;5472.589555783412;5494.966862260989;5503.514051206232 11:28:17 INFO - PROCESS | 1665 | |5;yui.html;631.3458738106162;661.9304972977837;749.1684230504139;770.653206057274;805;14559.344829482672;14884.627884302885;14965.925170374147;15052.172130532816;15098.622534436645;13947.232902190375;14053.437862485489;14110.858891411082;14153.504627338045;14199.92900035501;747.1109379837975;767.3592550220573;921.0973246218693;936.410061661156;938.0947385772728;692.2661978303015;936.765808547863;938.6151677812098;939.0421769794839;939.7556635274809;947.1854205383365;990.9454979976099;993.1905497019942;993.5926270229207;997.8353571660667;779.4621711019379;948.5352177433077;953.7901661634464;983.4050399508302;987.4667679453087;688.215434404779;732.4433430592735;734.6179986407038;736.3483317264206;738.2580506590896;12301.938490307492;12312.876871231352;14897.553073407707;14978.1013139212;14988.47540336083;12230.755384892342;12282.14025018249;12394.008479321632;12518;12563.371831408393;9965.70102896907;9992.650257241034;10066;10467.476626168662;10885.727856803564;3558.395072837624;3641.908952276188;3650.014496086042;3722.8324725387424;3741.345264578688;73648.63175684141;76194.61902690507;76619.23380766177;77644.05889852742;79161.20838791596;9093.909060909305;9465.66870159541;9509.334346595671;9591.952040239754;9599.088086631758;20725.68911466299;20738.48153796137;20752.896235518725;20753.377398678065;20760.48098797512;6032.54755893301;7184.928150718426;7217.06178196831;7385.335319821242;7440.181580026193;4042.312806822847;4053.412255222976;4065.6950728695465;4076.9592304077173;4080.4083407906282;3398.660133986631;3469.444888817777;3469.809160496197;3470.670286322795;3475.94786078209;627.7740013595102;652.6736631684158;654.8722999015147;666.4734859460972;669.7454967112466;562.6427218716063;582.6974531760942;602.813127930343;617.2315467243311;628.8239292997968;7805.37556995439;8202.794930126794;8254.174582541698;8400.579971001547;8407.70689827296;467.886005954916;500.97996080157117;522.4801322683953;585.1427658480346;601.5007543738686;3750.287445385368;3899.727019108635;3995.7202995790017;4011.1576568920855;4111.753294802322;91903.62144567836;92798;97869.04261914722;98315.52526712105;99234.00765992247;83164;83499;84217.57891210505;84254.15745842586;85908;74323;74405.51188976299;75235.24764752392;75952.24047759452;76022.23977760151;8001.559914204542;8057.476264042818;8166.101728809945;8309.709160179607;8486.024107227748;40054;40750;42360.576394236894;43920.56079439165;46505;59485.7025714886;63925.78871833699;64935;65380;67097.3290267091;11030.338179709242;11058.060064894253;11063.114950803756;11096.5561377544;11560;10268.97310268997;11741.882581174079;11937.820932685843;11997.520099196283;12558.932490738389;8435.214509801903;11337.376444295644;11351.37567433799;11533.653990380302;11812;11309.830352544554;11315.660530184108;11329.71675708114;11347.659570212907;11679.708007299885;11255;11311;11339.659810205707;11474.885251147381;11586.304821710724;9533.285003624616;9629.374090684083;10099.04059114383;10371.94814025925;10584.682459526226;9822.312438129262;9868.111869931741;9875.259355548505;9889.604415823287;9918.801623967625 11:28:17 INFO - PROCESS | 1665 | __end_tp_report 11:28:17 INFO - PROCESS | 1665 | __start_cc_report 11:28:17 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,1221 11:28:17 INFO - PROCESS | 1665 | __end_cc_report 11:28:17 INFO - PROCESS | 1665 | __startTimestamp1461954497347__endTimestamp 11:28:17 INFO - PROCESS | 1665 | 11:28:17 INFO - PROCESS | 1665 | ------- Summary: start ------- 11:28:17 INFO - PROCESS | 1665 | Number of tests: 6 11:28:17 INFO - PROCESS | 1665 | 11:28:17 INFO - PROCESS | 1665 | [#0] dojo.html Cycles:165 Average:5682.74 Median:5844.21 stddev:620.69 (10.6%) stddev-sans-first:594.70 11:28:17 INFO - PROCESS | 1665 | Values: 3337.6 3390.5 3394.2 3418.9 3448.8 5554.5 5579.6 5592.8 5599.8 5601.5 5631.1 5662.1 5683.7 5770.0 5784.8 5124.3 5145.1 5159.4 5161.9 5257.3 5252.9 5257.4 5290.6 5304.8 5338.2 5132.7 5142.7 5170.6 5181.4 5192.4 5180.5 5184.4 5212.4 5254.1 5282.3 5154.9 5160.2 5167.7 5184.3 5245.4 5440.0 5537.5 5541.3 5551.4 5563.3 6113.6 6114.7 6128.4 6143.0 6144.7 6165.9 6222.7 6228.5 6233.2 6234.6 5541.9 5663.2 5706.5 5719.8 5764.2 6314.8 6340.2 6347.8 6353.0 6362.7 6051.4 6085.6 6087.0 6090.9 6093.8 6007.3 6111.1 6145.1 6229.1 6247.7 6099.9 6139.7 6140.2 6156.3 6157.9 6167.9 6174.4 6187.1 6188.3 6192.8 4757.4 4833.1 4835.6 4836.9 4920.4 4397.5 4402.2 4440.7 4449.3 4453.1 5585.1 5591.0 5594.9 5596.4 5605.5 6096.6 6126.5 6215.0 6222.8 6223.3 5613.1 5639.4 5648.4 5651.1 5664.1 5204.5 5296.2 5303.9 5311.2 5316.6 6241.2 6323.5 6329.0 6336.6 6346.8 6167.4 6184.8 6189.3 6197.3 6211.5 5220.5 6171.7 6211.9 6359.1 6371.1 6074.6 6123.3 6126.9 6129.4 6130.5 6202.7 6205.3 6205.4 6213.4 6217.8 5796.9 5881.3 5945.3 6001.8 6027.7 5979.2 5993.0 5997.2 6001.9 6013.7 5636.9 5794.1 5848.3 5856.6 5862.8 5789.6 5873.8 5979.3 5989.5 6030.1 5828.2 5838.8 5844.2 5844.8 5855.5 11:28:17 INFO - PROCESS | 1665 | 11:28:17 INFO - PROCESS | 1665 | [#1] ext.html Cycles:180 Average:65735.36 Median:18480.41 stddev:140740.68 (761.6%) stddev-sans-first:141050.26 11:28:17 INFO - PROCESS | 1665 | Values: 495.3 507.9 531.3 543.8 556.9 24561.5 38164.0 38944.6 38980.0 39046.8 42153.4 42754.1 42771.8 42777.0 42968.8 8568.6 8782.8 9392.0 9662.0 9663.5 8638.7 9546.8 11363.8 11620.1 11628.8 11517.1 11641.9 11648.0 11649.5 11651.0 8430.2 9370.7 11232.3 11614.0 11617.6 11387.5 11536.8 11546.6 11558.2 11565.8 37927.4 38676.0 38753.6 38790.0 38876.6 3199.3 3201.2 3212.0 3261.0 3445.3 27614.6 28877.9 30301.4 30317.5 30377.4 2494.7 2816.3 2847.9 2854.2 2923.2 448355.0 482878.6 487235.0 488267.0 490136.0 60224.0 60630.7 60915.4 60967.0 61049.7 65224.3 65499.0 65609.7 65639.0 65646.7 16932.1 17132.5 17134.3 17144.5 17152.0 11815.0 12013.5 12842.6 13253.0 13336.0 16358.7 16405.9 16418.9 16434.6 16455.8 6765.3 6765.8 6858.2 6864.9 6873.1 986.4 1055.7 1062.4 1063.8 1081.5 29323.0 29339.0 29727.0 30036.7 30108.2 964.2 1023.6 1118.3 1130.7 1174.9 14667.4 15150.9 15165.4 15183.4 15645.1 643271.0 648240.0 651819.0 651935.0 652820.0 60141.7 60372.7 60549.4 60596.0 60706.4 1138.6 1485.8 1488.0 1494.7 1541.6 28461.1 28706.7 29139.6 29204.4 29291.7 52025.0 53609.5 53628.0 53644.2 53706.9 416830.0 427196.0 427410.0 428001.9 428531.0 23017.7 25219.9 25250.2 25549.9 25745.7 36014.8 43465.0 43639.8 44524.0 44965.8 36000.8 37540.8 37570.6 37868.6 38067.8 30958.8 33440.7 36602.6 37435.3 37461.3 36591.8 36934.4 37380.3 37671.4 37745.4 30988.2 33164.3 33374.8 33431.0 33515.5 23293.2 24489.3 24591.0 25103.4 25163.5 11:28:17 INFO - PROCESS | 1665 | 11:28:17 INFO - PROCESS | 1665 | [#2] jquery.html Cycles:180 Average:35203.87 Median:14093.92 stddev:100107.80 (710.3%) stddev-sans-first:100354.49 11:28:17 INFO - PROCESS | 1665 | Values: 382.7 391.8 393.6 395.4 408.1 14796.5 19149.9 20100.1 20145.0 20248.1 18821.5 19293.8 20061.7 22144.0 22156.9 6035.4 6151.9 6223.9 6229.0 6245.2 5931.2 6095.5 6159.7 6171.0 6196.5 5918.9 6081.4 6111.5 6115.6 6121.0 5913.9 5979.3 6026.2 6028.8 6039.0 5084.1 5258.4 5287.4 5288.1 5296.0 25742.6 26324.3 26756.7 26782.7 26799.8 2230.6 2445.2 2648.7 2998.4 3111.6 12437.2 14003.9 15281.6 15501.2 15591.6 1668.1 1673.8 1722.2 1757.1 1784.9 84399.0 113045.0 114581.0 125175.0 125818.4 11646.9 11775.5 11809.8 11858.2 11930.2 15030.6 15141.2 15159.3 15180.7 15214.4 7124.0 8291.9 8600.3 8750.7 8758.5 8586.5 8605.1 8611.3 8712.0 8738.4 4555.2 4634.6 4645.7 4646.0 4678.0 1576.9 1811.6 2005.6 2011.7 2048.3 920.7 980.7 1018.6 1046.9 1047.1 19971.4 20069.8 20422.7 20581.4 20620.4 929.6 966.4 985.6 1002.6 1016.6 10511.1 10782.7 10823.8 10835.9 10842.2 584356.0 591362.0 599538.0 611671.0 612768.9 116151.0 122870.4 128862.0 129602.0 133923.7 997.4 1015.1 1036.0 1037.6 1051.3 17986.0 18291.6 18427.4 18611.8 18663.0 54977.7 56161.7 56491.2 57464.7 57812.7 81892.0 85039.0 85681.6 86306.0 86714.0 7725.7 7813.6 8031.6 8061.8 8083.5 9562.8 11100.7 12272.6 12623.2 12720.5 10370.4 10723.3 10947.5 10969.2 11146.3 5990.2 8635.0 10466.3 10467.3 10901.9 10732.9 10865.9 11064.4 11078.7 11123.9 7898.7 7944.1 7982.4 8006.8 8090.1 8252.8 10438.5 10792.2 11042.3 11333.0 11:28:17 INFO - PROCESS | 1665 | 11:28:17 INFO - PROCESS | 1665 | [#3] mootools.html Cycles:180 Average:5694.49 Median:4854.22 stddev:3200.58 (65.9%) stddev-sans-first:3193.51 11:28:17 INFO - PROCESS | 1665 | Values: 1430.1 1437.1 1590.6 1817.8 1986.3 7790.4 8557.0 8765.6 8767.7 8779.9 8440.7 8667.3 8670.1 8675.6 8689.0 2045.1 2381.3 2431.0 2456.4 2471.0 2160.2 2430.8 2448.0 2475.5 2484.2 2397.2 2429.3 2446.6 2447.2 2447.6 2089.6 2130.7 2305.7 2406.7 2434.0 2416.7 2447.3 2448.2 2448.6 2453.2 8557.0 8648.3 8648.9 8657.2 8679.5 5105.6 5380.5 5390.2 5403.7 5404.7 2941.3 2999.8 3491.2 3634.2 3640.5 1045.9 1046.7 1052.9 1055.9 1062.1 11528.4 11712.0 11720.4 11745.4 11772.6 4851.6 4864.6 4893.0 4943.0 4946.5 10044.1 10045.2 10051.2 10069.9 10101.1 5310.2 5399.9 5443.8 5452.3 5454.5 4420.8 4616.1 4801.2 4939.2 4971.7 3969.2 3998.4 4078.4 4116.7 4122.2 1331.7 1335.4 1338.5 1353.7 1356.2 905.7 926.0 929.5 953.4 974.8 5793.4 5938.7 5954.4 6077.1 6149.2 428.2 460.3 473.8 480.4 480.5 3946.2 3984.4 4031.0 4058.5 4082.5 10218.5 10677.9 10781.8 10785.1 10806.6 10604.3 10739.9 10745.3 10759.9 10766.5 8150.8 8213.8 8225.8 8230.1 8237.5 4971.6 5641.5 5850.2 5918.0 5946.3 9624.5 9825.7 9882.6 9936.6 9943.8 9625.0 10068.4 10154.4 10204.2 10209.5 6920.8 7135.8 7320.1 7438.1 7626.3 8343.9 8355.5 8448.3 8464.0 8464.0 7308.9 7311.2 7395.7 7572.8 7593.5 7044.8 7139.6 7219.7 7267.1 7429.4 6982.1 7002.5 7045.9 7057.0 7095.3 4563.7 4825.8 4856.8 4898.4 5091.5 4416.2 4892.5 4966.7 5017.4 5179.3 11:28:17 INFO - PROCESS | 1665 | 11:28:17 INFO - PROCESS | 1665 | [#4] prototype.html Cycles:180 Average:4617.00 Median:5084.27 stddev:1464.09 (28.8%) stddev-sans-first:1431.82 11:28:17 INFO - PROCESS | 1665 | Values: 295.5 315.3 323.6 324.3 331.0 4321.0 4340.4 4761.6 5160.1 5162.8 4502.9 4763.1 5179.5 5219.0 5250.4 3629.4 4036.7 4054.2 4054.6 4075.0 3651.8 3765.5 3896.0 4014.1 4039.3 3965.2 3993.1 4001.9 4003.4 4012.0 3805.4 4007.0 4007.5 4018.7 4031.4 3165.0 3391.0 3416.3 3429.6 3561.8 4199.7 4841.1 5012.6 5058.5 5094.8 4311.0 4593.8 4595.0 4626.4 4633.7 5097.5 5444.4 5501.3 5501.7 5505.9 3254.8 3849.0 3862.3 3864.6 3886.7 5577.2 5708.3 5708.8 5789.9 5806.4 3960.6 3968.9 3972.4 3981.4 3994.5 3080.0 3407.5 4024.6 4028.3 4040.5 4041.5 4375.9 4592.4 4612.5 4623.0 4660.9 5018.7 5555.8 5563.8 5595.2 1458.3 1460.8 1465.5 1467.9 1471.7 886.9 891.9 896.8 969.5 992.3 4791.1 5572.4 5602.5 5605.8 5609.7 5148.5 5658.0 6125.4 6199.7 6201.6 4456.8 5273.9 5564.6 5576.2 5596.2 2701.7 3112.1 3154.7 3223.4 3233.5 6477.4 6505.4 6505.9 6510.4 6523.9 4966.0 5558.6 6321.7 6396.9 6415.9 6415.5 6452.2 6467.6 6476.8 6504.3 5676.6 6160.8 6195.8 6200.1 6226.5 5868.6 6041.4 6101.4 6102.3 6130.8 5158.3 6372.2 6395.8 6441.8 6450.5 3091.7 3882.9 4194.8 4199.4 4210.5 4996.3 5576.2 5690.0 5690.5 5695.7 5073.7 5466.6 5535.9 5538.6 5542.5 4808.1 5232.9 5521.9 5589.8 5605.6 4483.7 5144.4 5419.9 5489.7 5504.3 4498.9 4946.5 5576.9 5582.7 5624.0 4766.0 5317.4 5472.6 5495.0 5503.5 11:28:17 INFO - PROCESS | 1665 | 11:28:17 INFO - PROCESS | 1665 | [#5] yui.html Cycles:180 Average:18241.84 Median:622.50 stddev:26059.94 (4186.3%) stddev-sans-first:26099.50 11:28:17 INFO - PROCESS | 1665 | Values: 631.3 661.9 749.2 770.7 805.0 14559.3 14884.6 14965.9 15052.2 15098.6 13947.2 14053.4 14110.9 14153.5 14199.9 747.1 767.4 921.1 936.4 938.1 692.3 936.8 938.6 939.0 939.8 947.2 990.9 993.2 993.6 997.8 779.5 948.5 953.8 983.4 987.5 688.2 732.4 734.6 736.3 738.3 12301.9 12312.9 14897.6 14978.1 14988.5 12230.8 12282.1 12394.0 12518.0 12563.4 9965.7 9992.7 10066.0 10467.5 10885.7 3558.4 3641.9 3650.0 3722.8 3741.3 73648.6 76194.6 76619.2 77644.1 79161.2 9093.9 9465.7 9509.3 9592.0 9599.1 20725.7 20738.5 20752.9 20753.4 20760.5 6032.5 7184.9 7217.1 7385.3 7440.2 4042.3 4053.4 4065.7 4077.0 4080.4 3398.7 3469.4 3469.8 3470.7 3475.9 627.8 652.7 654.9 666.5 669.7 562.6 582.7 602.8 617.2 628.8 7805.4 8202.8 8254.2 8400.6 8407.7 467.9 501.0 522.5 585.1 601.5 3750.3 3899.7 3995.7 4011.2 4111.8 91903.6 92798.0 97869.0 98315.5 99234.0 83164.0 83499.0 84217.6 84254.2 85908.0 74323.0 74405.5 75235.2 75952.2 76022.2 8001.6 8057.5 8166.1 8309.7 8486.0 40054.0 40750.0 42360.6 43920.6 46505.0 59485.7 63925.8 64935.0 65380.0 67097.3 11030.3 11058.1 11063.1 11096.6 11560.0 10269.0 11741.9 11937.8 11997.5 12558.9 8435.2 11337.4 11351.4 11533.7 11812.0 11309.8 11315.7 11329.7 11347.7 11679.7 11255.0 11311.0 11339.7 11474.9 11586.3 9533.3 9629.4 10099.0 10371.9 10584.7 9822.3 9868.1 9875.3 9889.6 9918.8 11:28:17 INFO - PROCESS | 1665 | -------- Summary: end -------- 11:28:17 INFO - PROCESS | 1665 | 11:28:17 INFO - TEST-INFO | 1665: exit 0 11:28:17 INFO - TEST-OK | dromaeo_css | took 1114801ms 11:28:17 INFO - TEST-START | kraken 11:28:17 INFO - operating with platform_type : mac_ 11:28:17 INFO - Initialising browser for kraken test... 11:28:17 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpxuDp_9/profile http://localhost:49275/getInfo.html) 11:28:19 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 11:28:19 INFO - PROCESS | 1672 | colorDepth:24 11:28:19 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 11:28:19 INFO - PROCESS | 1672 | __metrics 11:28:20 INFO - PROCESS | 1672 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:28:20 ERROR - PROCESS | 1672 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:28:20 INFO - TEST-INFO | 1672: exit 0 11:28:20 INFO - Browser initialized. 11:28:20 INFO - Running cycle 1/1 for kraken test... 11:28:20 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpxuDp_9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:28:32 INFO - PROCESS | 1674 | RSS: Main: 239353856 11:28:32 INFO - PROCESS | 1674 | 11:28:35 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 11:28:36 INFO - PROCESS | 1674 | RSS: Main: 287023104 11:28:36 INFO - PROCESS | 1674 | 11:28:38 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 11:28:39 INFO - PROCESS | 1674 | RSS: Main: 296144896 11:28:39 INFO - PROCESS | 1674 | 11:28:43 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 11:28:43 INFO - PROCESS | 1674 | RSS: Main: 381251584 11:28:43 INFO - PROCESS | 1674 | 11:28:45 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 11:28:46 INFO - PROCESS | 1674 | RSS: Main: 281022464 11:28:46 INFO - PROCESS | 1674 | 11:28:48 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:28:49 INFO - PROCESS | 1674 | RSS: Main: 286093312 11:28:49 INFO - PROCESS | 1674 | 11:28:52 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 11:28:52 INFO - PROCESS | 1674 | RSS: Main: 324427776 11:28:52 INFO - PROCESS | 1674 | 11:28:55 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 11:28:56 INFO - PROCESS | 1674 | RSS: Main: 326610944 11:28:56 INFO - PROCESS | 1674 | 11:28:58 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 11:28:59 INFO - PROCESS | 1674 | RSS: Main: 323850240 11:28:59 INFO - PROCESS | 1674 | 11:29:01 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:29:01 INFO - PROCESS | 1674 | RSS: Main: 315121664 11:29:01 INFO - PROCESS | 1674 | 11:29:03 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:29:04 INFO - PROCESS | 1674 | RSS: Main: 321728512 11:29:04 INFO - PROCESS | 1674 | 11:29:06 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:29:07 INFO - PROCESS | 1674 | RSS: Main: 323624960 11:29:07 INFO - PROCESS | 1674 | 11:29:09 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:29:10 INFO - PROCESS | 1674 | RSS: Main: 329154560 11:29:10 INFO - PROCESS | 1674 | 11:29:13 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:29:14 INFO - PROCESS | 1674 | RSS: Main: 326610944 11:29:14 INFO - PROCESS | 1674 | 11:29:16 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 11:29:16 INFO - PROCESS | 1674 | RSS: Main: 392155136 11:29:16 INFO - PROCESS | 1674 | 11:29:16 INFO - PROCESS | 1674 | __start_tp_report 11:29:16 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 11:29:16 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 11:29:16 INFO - PROCESS | 1674 | |i|pagename|runs| 11:29:16 INFO - PROCESS | 1674 | |0;ai-astar;113;114;109;113;114;113;114;113;105;113 11:29:16 INFO - PROCESS | 1674 | |1;audio-beat-detection;160;145;182;180;119;141;120;153;156;122 11:29:16 INFO - PROCESS | 1674 | |2;audio-dft;188;187;187;187;187;185;181;187;185;183 11:29:16 INFO - PROCESS | 1674 | |3;audio-fft;78;76;90;92;56;59;58;80;87;54 11:29:16 INFO - PROCESS | 1674 | |4;audio-oscillator;93;90;136;78;83;114;157;117;100;115 11:29:16 INFO - PROCESS | 1674 | |5;imaging-gaussian-blur;88;87;135;119;88;106;134;84;87;85 11:29:16 INFO - PROCESS | 1674 | |6;imaging-darkroom;92;93;95;93;94;92;93;94;93;93 11:29:16 INFO - PROCESS | 1674 | |7;imaging-desaturate;84;86;84;86;85;84;85;84;84;84 11:29:16 INFO - PROCESS | 1674 | |8;json-parse-financial;57;59;58;57;59;58;58;80;59;58 11:29:16 INFO - PROCESS | 1674 | |9;json-stringify-tinderbox;64;63;79;73;68;69;68;67;67;69 11:29:16 INFO - PROCESS | 1674 | |10;stanford-crypto-aes;81;83;82;83;82;82;82;96;108;105 11:29:16 INFO - PROCESS | 1674 | |11;stanford-crypto-ccm;135;135;143;146;142;134;135;135;180;166 11:29:16 INFO - PROCESS | 1674 | |12;stanford-crypto-pbkdf2;169;171;170;170;169;169;156;200;225;203 11:29:16 INFO - PROCESS | 1674 | |13;stanford-crypto-sha256-iterative;70;69;68;67;68;67;68;69;69;67 11:29:16 INFO - PROCESS | 1674 | __end_tp_report 11:29:16 INFO - PROCESS | 1674 | __start_cc_report 11:29:16 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,2080 11:29:16 INFO - PROCESS | 1674 | __end_cc_report 11:29:16 INFO - PROCESS | 1674 | __startTimestamp1461954556255__endTimestamp 11:29:16 INFO - PROCESS | 1674 | 11:29:16 INFO - PROCESS | 1674 | ------- Summary: start ------- 11:29:16 INFO - PROCESS | 1674 | Number of tests: 14 11:29:16 INFO - PROCESS | 1674 | 11:29:16 INFO - PROCESS | 1674 | [#0] ai-astar Cycles:10 Average:112.10 Median:113.00 stddev:2.88 (2.6%) stddev-sans-first:3.04 11:29:16 INFO - PROCESS | 1674 | Values: 113.0 114.0 109.0 113.0 114.0 113.0 114.0 113.0 105.0 113.0 11:29:16 INFO - PROCESS | 1674 | 11:29:16 INFO - PROCESS | 1674 | [#1] audio-beat-detection Cycles:10 Average:147.80 Median:154.50 stddev:23.03 (14.9%) stddev-sans-first:24.00 11:29:16 INFO - PROCESS | 1674 | Values: 160.0 145.0 182.0 180.0 119.0 141.0 120.0 153.0 156.0 122.0 11:29:16 INFO - PROCESS | 1674 | 11:29:16 INFO - PROCESS | 1674 | [#2] audio-dft Cycles:10 Average:185.70 Median:187.00 stddev:2.21 (1.2%) stddev-sans-first:2.19 11:29:16 INFO - PROCESS | 1674 | Values: 188.0 187.0 187.0 187.0 187.0 185.0 181.0 187.0 185.0 183.0 11:29:16 INFO - PROCESS | 1674 | 11:29:16 INFO - PROCESS | 1674 | [#3] audio-fft Cycles:10 Average:73.00 Median:79.00 stddev:14.91 (18.9%) stddev-sans-first:15.70 11:29:16 INFO - PROCESS | 1674 | Values: 78.0 76.0 90.0 92.0 56.0 59.0 58.0 80.0 87.0 54.0 11:29:16 INFO - PROCESS | 1674 | 11:29:16 INFO - PROCESS | 1674 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:117.50 stddev:24.69 (21.0%) stddev-sans-first:25.56 11:29:16 INFO - PROCESS | 1674 | Values: 93.0 90.0 136.0 78.0 83.0 114.0 157.0 117.0 100.0 115.0 11:29:16 INFO - PROCESS | 1674 | 11:29:16 INFO - PROCESS | 1674 | [#5] imaging-gaussian-blur Cycles:10 Average:101.30 Median:86.00 stddev:20.73 (24.1%) stddev-sans-first:21.42 11:29:16 INFO - PROCESS | 1674 | Values: 88.0 87.0 135.0 119.0 88.0 106.0 134.0 84.0 87.0 85.0 11:29:16 INFO - PROCESS | 1674 | 11:29:16 INFO - PROCESS | 1674 | [#6] imaging-darkroom Cycles:10 Average:93.20 Median:93.00 stddev:0.92 (1.0%) stddev-sans-first:0.87 11:29:16 INFO - PROCESS | 1674 | Values: 92.0 93.0 95.0 93.0 94.0 92.0 93.0 94.0 93.0 93.0 11:29:16 INFO - PROCESS | 1674 | 11:29:16 INFO - PROCESS | 1674 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:84.50 stddev:0.84 (1.0%) stddev-sans-first:0.87 11:29:16 INFO - PROCESS | 1674 | Values: 84.0 86.0 84.0 86.0 85.0 84.0 85.0 84.0 84.0 84.0 11:29:16 INFO - PROCESS | 1674 | 11:29:16 INFO - PROCESS | 1674 | [#8] json-parse-financial Cycles:10 Average:60.30 Median:58.50 stddev:6.96 (11.9%) stddev-sans-first:7.28 11:29:16 INFO - PROCESS | 1674 | Values: 57.0 59.0 58.0 57.0 59.0 58.0 58.0 80.0 59.0 58.0 11:29:16 INFO - PROCESS | 1674 | 11:29:16 INFO - PROCESS | 1674 | [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:68.50 stddev:4.55 (6.6%) stddev-sans-first:4.49 11:29:16 INFO - PROCESS | 1674 | Values: 64.0 63.0 79.0 73.0 68.0 69.0 68.0 67.0 67.0 69.0 11:29:16 INFO - PROCESS | 1674 | 11:29:16 INFO - PROCESS | 1674 | [#10] stanford-crypto-aes Cycles:10 Average:88.40 Median:82.00 stddev:10.51 (12.8%) stddev-sans-first:10.80 11:29:16 INFO - PROCESS | 1674 | Values: 81.0 83.0 82.0 83.0 82.0 82.0 82.0 96.0 108.0 105.0 11:29:16 INFO - PROCESS | 1674 | 11:29:16 INFO - PROCESS | 1674 | [#11] stanford-crypto-ccm Cycles:10 Average:145.10 Median:142.50 stddev:15.64 (11.0%) stddev-sans-first:16.15 11:29:16 INFO - PROCESS | 1674 | Values: 135.0 135.0 143.0 146.0 142.0 134.0 135.0 135.0 180.0 166.0 11:29:16 INFO - PROCESS | 1674 | 11:29:16 INFO - PROCESS | 1674 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.20 Median:170.50 stddev:21.53 (12.6%) stddev-sans-first:22.46 11:29:16 INFO - PROCESS | 1674 | Values: 169.0 171.0 170.0 170.0 169.0 169.0 156.0 200.0 225.0 203.0 11:29:16 INFO - PROCESS | 1674 | 11:29:16 INFO - PROCESS | 1674 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.50 stddev:1.03 (1.5%) stddev-sans-first:0.87 11:29:16 INFO - PROCESS | 1674 | Values: 70.0 69.0 68.0 67.0 68.0 67.0 68.0 69.0 69.0 67.0 11:29:16 INFO - PROCESS | 1674 | -------- Summary: end -------- 11:29:16 INFO - PROCESS | 1674 | 11:29:17 INFO - TEST-INFO | 1674: exit 0 11:29:17 INFO - TEST-OK | kraken | took 59129ms 11:29:17 INFO - SUITE-END | took 1173s 11:29:17 INFO - Completed test suite (00:19:34) 11:29:17 INFO - javascript benchmark 11:29:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3337.5828021497314, 3390.542276792632, 3394.202362444825, 3418.914527136823, 3448.7930724156536, 5554.50009499145, 5579.609427340083, 5592.832215033545, 5599.832005039845, 5601.52387047101, 5631.1271752878365, 5662.122371032487, 5683.715814209283, 5769.971150144243, 5784.82645520634, 5124.256982737501, 5145.099607568679, 5159.406668233145, 5161.922571161435, 5257.263983042358, 5252.947470525284, 5257.369115706101, 5290.629655924067, 5304.814331498398, 5338.225957236198, 5132.717700526469, 5142.6914385137015, 5170.6122040847085, 5181.35233095863, 5192.3769147702515, 5180.456052114511, 5184.403793563751, 5212.400573934008, 5254.106801843695, 5282.313299271109, 5154.896902061938, 5160.200168973777, 5167.689938603658, 5184.274201611777, 5245.423003469616, 5440.047991601454, 5537.501624853782, 5541.251930989305, 5551.3893471718075, 5563.332400112013, 6113.633182009094, 6114.724837382284, 6128.38716128388, 6143.020634992025, 6144.695739097839, 6165.907511387333, 6222.688865556749, 6228.532860035471, 6233.189685340877, 6234.625922444622, 5541.889162216733, 5663.1505274208375, 5706.457886500776, 5719.771209151588, 5764.193012978187, 6314.778982735674, 6340.207474065742, 6347.809565713036, 6353.047042943595, 6362.6500542469685, 6051.425114614105, 6085.6348619083, 6087.0, 6090.908636370458, 6093.75624974996, 6007.339192688801, 6111.075205202202, 6145.125736650364, 6229.065640154013, 6247.718852651642, 6099.8795552502925, 6139.706800529493, 6140.17107690465, 6156.322804491502, 6157.876842463125, 6167.907481387782, 6174.44430001302, 6187.133801267826, 6188.257409110935, 6192.845178870474, 4757.381540399726, 4833.081714474239, 4835.564799168022, 4836.854894353175, 4920.40955085392, 4397.516273209944, 4402.207602631493, 4440.666949978765, 4449.310356894686, 4453.1093781243235, 5585.134304182858, 5590.993621148233, 5594.86012849682, 5596.412376700469, 5605.523530499871, 6096.6476373754385, 6126.548209435026, 6214.9689251553455, 6222.81331560054, 6223.284322302902, 5613.129964855454, 5639.379668236491, 5648.378678345379, 5651.095824668033, 5664.122061080539, 5204.531592156724, 5296.179092240709, 5303.946960530422, 5311.203319502106, 5316.574674026068, 6241.157443745127, 6323.494120470351, 6328.968355158195, 6336.588121771978, 6346.841328966812, 6167.414095660905, 6184.793965176747, 6189.257289125334, 6197.25632924052, 6211.503079753518, 5220.477952204749, 6171.691415429121, 6211.9068213975925, 6359.077933699495, 6371.076193951943, 6074.635521868702, 6123.313124872426, 6126.9168432863735, 6129.389354848411, 6130.489860652556, 6202.658853763086, 6205.286392064971, 6205.441510264098, 6213.37866213375, 6217.751289948352, 5796.884062318814, 5881.264841894763, 5945.256842894638, 6001.849953751192, 6027.698615069141, 5979.1928089707335, 5992.970035149797, 5997.220361352996, 6001.939980600138, 6013.6692481913915, 5636.915446268227, 5794.1308803679785, 5848.327442344185, 5856.59003869725, 5862.7654893805475, 5789.594728368974, 5873.765049397976, 5979.252593425822, 5989.490893274121, 6030.095485677183, 5828.154917537018, 5838.795642152504, 5844.211031510692, 5844.824655260349, 5855.531557475307], "value": 5643.795240099244, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [495.28431416603013, 507.91111555477795, 531.3464438740349, 543.7743336515347, 556.9275994120763, 24561.508769824613, 38164.0, 38944.610553894454, 38980.0, 39046.82859514216, 42153.36769948453, 42754.14491710164, 42771.78614106925, 42777.0, 42968.78515607418, 8568.571571421435, 8782.780430489225, 9392.0, 9662.033796620351, 9663.5168241588, 8638.740837774845, 9546.809063818719, 11363.772724545504, 11620.07039436843, 11628.767424651502, 11517.078633709325, 11641.941790291037, 11648.009919156882, 11649.534018639244, 11651.0, 8430.199131082598, 9370.672026479075, 11232.269902456314, 11613.954744073075, 11617.593384231512, 11387.487563059682, 11536.769264614744, 11546.59586914454, 11558.248713833575, 11565.768684626344, 37927.431088533696, 38676.0, 38753.612463875565, 38790.0, 38876.61123388758, 3199.280161963563, 3201.2317043909525, 3211.951820722691, 3261.037993791837, 3445.328161008604, 27614.585781213296, 28877.85561072202, 30301.393972120655, 30317.545236821465, 30377.392452151053, 2494.7006359237007, 2816.324082220273, 2847.8893231639677, 2854.24362543926, 2923.1961210667023, 448355.0, 482878.5856070732, 487235.0, 488267.0, 490135.99999999645, 60224.0, 60630.696846515486, 60915.39084609186, 60967.0, 61049.69475152685, 65224.34775652277, 65499.0, 65609.67195163993, 65639.0, 65646.67176664087, 16932.06873621938, 17132.486025419257, 17134.314627414762, 17144.485665430057, 17152.0, 11815.0, 12013.519459221534, 12842.550510732079, 13253.006024548005, 13336.0, 16358.672826543641, 16405.91797041031, 16418.917905410395, 16434.616980537754, 16455.83544164567, 6765.274854911966, 6765.763198288037, 6858.245592984767, 6864.931350686529, 6873.1064961554675, 986.3736527305069, 1055.7466208109997, 1062.436908438529, 1063.776606912557, 1081.4940493022323, 29323.0, 29338.97313594014, 29727.0, 30036.69963300339, 30108.24729381783, 964.2141654551518, 1023.6417253961054, 1118.3122379736403, 1130.6834086455806, 1174.9412529373496, 14667.413303467954, 15150.924245378703, 15165.393384264506, 15183.392664293526, 15645.139517326428, 643271.0, 648240.0, 651819.0, 651935.0, 652820.0, 60141.69929150414, 60372.69813650904, 60549.39450605526, 60596.0, 60706.39293607096, 1138.5616537632905, 1485.7697056955756, 1487.9628009299638, 1494.6562290673205, 1541.5606552132588, 28461.146165615064, 28706.712932870403, 29139.562906556843, 29204.415911682074, 29291.707082928897, 52024.95950081053, 53609.46390536045, 53628.0, 53644.195337070756, 53706.92586148177, 416830.0, 427196.0, 427410.0, 428001.89985751815, 428531.0, 23017.65473517932, 25219.865106069905, 25250.242492725247, 25549.87225063863, 25745.742542575084, 36014.8199259002, 43465.0, 43639.781801090794, 44524.0, 44965.77517112524, 36000.81999589985, 37540.81229593835, 37570.624293757806, 37868.59182673573, 38067.80966095152, 30958.84520577383, 33440.665593344725, 36602.633973659926, 37435.25129497449, 37461.250774984896, 36591.817040914626, 36934.445983309735, 37380.25239495141, 37671.434928475544, 37745.433818492194, 30988.22529436692, 33164.33671326512, 33374.831880884056, 33430.997070087935, 33515.497267540515, 23293.18473853407, 24489.265322040366, 24591.0, 25103.372415689755, 25163.49673006566], "value": 19728.94738740482, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.67594124329815, 391.77864506553794, 393.6122918924859, 395.4226828829909, 408.10217521452813, 14796.482123125692, 19149.90425047876, 20100.09549570269, 20144.99999999998, 20248.08883600238, 18821.529461763428, 19293.807061929376, 20061.699074513857, 22144.0, 22156.88921555394, 6035.396460353952, 6151.938480615181, 6223.87552248957, 6228.96885515574, 6245.188125543673, 5931.169636250928, 6095.542834287424, 6159.692015399234, 6170.969145154268, 6196.504279657616, 5918.940810591882, 6081.422264884851, 6111.51107911366, 6115.571909966304, 6120.96939515304, 5913.852153696149, 5979.34227235006, 6026.186464827258, 6028.7588496460085, 6038.96980515099, 5084.059449001909, 5258.3689957205, 5287.41838397776, 5288.127458969266, 5296.0, 25742.613860792102, 26324.341891452674, 26756.732432675813, 26782.732172678414, 26799.79400926963, 2230.565039817236, 2445.2297526279344, 2648.695400029002, 2998.4003199360213, 3111.579936708538, 12437.191582547195, 14003.929980350134, 15281.61795955099, 15501.224938753017, 15591.610209744733, 1668.124234776752, 1673.8493535581856, 1722.1991773825107, 1757.0511923561262, 1784.9286028558972, 84399.0, 113045.0, 114581.0, 125175.0, 125818.3709081458, 11646.883531164749, 11775.470103845348, 11809.763804723858, 11858.16992810495, 11930.22453540517, 15030.624234394227, 15141.167235801917, 15159.317830697644, 15180.696386072217, 15214.391424342903, 7123.964380178066, 8291.875621865556, 8600.268977137013, 8750.737477875675, 8758.47449153053, 8586.527740974307, 8605.053444121142, 8611.268042216356, 8712.0, 8738.388312818042, 4555.248384016666, 4634.629229661619, 4645.72970029944, 4645.976770116195, 4677.976610116928, 1576.9119307677665, 1811.5652243461475, 2005.6089062632645, 2011.688188330811, 2048.313814872005, 920.7099763574587, 980.6910823090703, 1018.5721996761378, 1046.9214808889212, 1047.0785708576404, 19971.400857974284, 20069.799302007086, 20422.69365959512, 20581.38255852327, 20620.381388558366, 929.6467342409841, 966.3525437956586, 985.6353149334792, 1002.644061358222, 1016.6390931219458, 10511.054005139575, 10782.67651970442, 10823.783524329468, 10835.891641083488, 10842.186835987333, 584356.0, 591362.0, 599538.0, 611671.0, 612768.9361553253, 116151.0, 122870.38564807118, 128862.0, 129602.0, 133923.66076339112, 997.4464172384396, 1015.1168483419325, 1036.0002597493303, 1037.5538518436992, 1051.279873286801, 17986.0, 18291.63416731631, 18427.447176584723, 18611.81388186101, 18663.0, 54977.72511137419, 56161.71919140378, 56491.15263271136, 57464.71267643635, 57812.71093644505, 81892.0, 85039.0, 85681.57159214164, 86306.0, 86714.0, 7725.690972361042, 7813.648385822538, 8031.638576264199, 8061.758147255592, 8083.474574152661, 9562.760930976503, 11100.666979990614, 12272.570460033856, 12623.179493332904, 12720.491180353052, 10370.429626370622, 10723.30298530593, 10947.50736216888, 10969.177311701495, 11146.275492092987, 5990.161377407254, 8635.0, 10466.267361284637, 10467.319624224401, 10901.890981090404, 10732.946335268585, 10865.945670271598, 11064.391458469861, 11078.667639970814, 11123.888761112608, 7898.68405263783, 7944.086430060386, 7982.401319900914, 8006.799830004296, 8090.11008789021, 8252.752417427488, 10438.530266138194, 10792.244542881923, 11042.282251653616, 11333.036691881283], "value": 9683.23206846357, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1430.1419148510895, 1437.0802686280776, 1590.5705459525925, 1817.7818661760582, 1986.2849374225268, 7790.3767698584115, 8557.015943166538, 8765.649374025032, 8767.736967890958, 8779.868301975475, 8440.662373505053, 8667.306615470763, 8670.089640587727, 8675.60959756811, 8689.000764912036, 2045.0899349789274, 2381.3451300892307, 2430.9756902431013, 2456.4472993576483, 2471.0486462711897, 2160.1899287767087, 2430.7812296893276, 2448.0, 2475.504899020194, 2484.229888734489, 2397.160993652225, 2429.2712186344115, 2446.6085426331792, 2447.155731272708, 2447.571674956884, 2089.6238677038127, 2130.6803979403135, 2305.6772051912744, 2406.6630671705975, 2433.9634905476432, 2416.66166736657, 2447.2535876557645, 2448.24104527597, 2448.5959816630234, 2453.2272334214845, 8556.957215213884, 8648.264897483721, 8648.870266946002, 8657.177568131017, 8679.522626255553, 5105.642605017651, 5380.515753582196, 5390.21841832932, 5403.675779453206, 5404.675719456845, 2941.3234955960247, 2999.760019198459, 3491.2319289756215, 3634.182308980485, 3640.4721315409383, 1045.9163266938626, 1046.6859942017363, 1052.921030922684, 1055.9313644613153, 1062.1078294232882, 11528.423578821026, 11712.004479619243, 11720.413979301002, 11745.354005529607, 11772.587959421464, 4851.611871050308, 4864.635152363587, 4893.021395720799, 4943.0, 4946.530079642428, 10044.096031357212, 10045.19638428924, 10051.195904327637, 10069.899301007043, 10101.090901818872, 5310.176922577007, 5399.946000540023, 5443.755031023614, 5452.318460192476, 5454.509094181463, 4420.84527041552, 4616.053708989649, 4801.231802911518, 4939.234418665113, 4971.7016978980655, 3969.2061587682, 3998.4402183694306, 4078.4290199372113, 4116.670666346685, 4122.216778812016, 1331.7136815584695, 1335.4124185358412, 1338.4713038349992, 1353.708952575201, 1356.2066191278016, 905.7328088213993, 925.9768505787409, 929.5491686532026, 953.4088864903804, 974.770928831724, 5793.449622285876, 5938.673372964442, 5954.374790647006, 6077.118817771398, 6149.200603921461, 428.2355994549714, 460.34630824229674, 473.836526398392, 480.41149591750525, 480.49787971569793, 3946.230485055444, 3984.4023396490757, 4030.9798451008146, 4058.5332686741403, 4082.4896887889013, 10218.540165692562, 10677.89322106769, 10781.784364312669, 10785.13718902486, 10806.621768238074, 10604.257701960789, 10739.892601074045, 10745.301555398873, 10759.946200268949, 10766.461676916122, 8150.75547733569, 8213.79465513355, 8225.83548329042, 8230.09468958414, 8237.546934918517, 4971.602271818174, 5641.5204707600315, 5850.151727999501, 5918.0, 5946.316173639913, 9624.470654114091, 9825.656102036395, 9882.555285012335, 9936.602535898772, 9943.751406214902, 9625.0, 10068.44623545712, 10154.441505717257, 10204.2346823987, 10209.54057067419, 6920.757773477904, 7135.750248741269, 7320.1215854097845, 7438.107427108782, 7626.275503827128, 8343.874841877498, 8355.456895301786, 8448.281896038905, 8463.957680211559, 8464.0, 7308.926910731037, 7311.195768465358, 7395.741149059757, 7572.8485430292185, 7593.468457207942, 7044.823879403056, 7139.607321597362, 7219.675114619749, 7267.127944646676, 7429.405647548291, 6982.057422247932, 7002.544834585736, 7045.929540704732, 7057.0, 7095.325944035309, 4563.657725670521, 4825.782839772289, 4856.8300109495995, 4898.436679781871, 5091.465396133501, 4416.227160247008, 4892.535209155125, 4966.652334336562, 5017.422996355466, 5179.274901513866], "value": 4515.299193755676, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.4814300901917, 315.34251086484676, 323.61328212785713, 324.34967889381795, 330.95366648669176, 4321.018497236908, 4340.370646256291, 4761.571458568728, 5160.071187186305, 5162.767675454605, 4502.896790286384, 4763.071201115784, 5179.482051794818, 5218.973905130469, 5250.422453530108, 3629.3687076869323, 4036.6789096269617, 4054.1688953764556, 4054.5539990600937, 4075.0, 3651.7626354286886, 3765.5104836371233, 3896.0, 4014.0767623446623, 4039.2527382434196, 3965.1673148638674, 3993.101552150772, 4001.939001414274, 4003.3994900764974, 4011.9799401002956, 3805.3721136012523, 4007.0, 4007.5190977082643, 4018.6985976051765, 4031.4154447605224, 3164.971384300112, 3390.9830450847835, 3416.3167366526545, 3429.554157959474, 3561.7684850484634, 4199.706020578561, 4841.080194762983, 5012.573931215815, 5058.519440653132, 5094.78376906047, 4310.956890431087, 4593.793279302439, 4594.95405045952, 4626.375439315683, 4633.652476064275, 5097.515736005073, 5444.366689992986, 5501.257330260403, 5501.669899805985, 5505.889882202334, 3254.8047117173046, 3848.960780589225, 3862.2661694278, 3864.574896761354, 3886.747361421527, 5577.239266563077, 5708.316046766173, 5708.828735137952, 5789.88420231593, 5806.393624352112, 3960.6039396060164, 3968.940465893014, 3972.3644216925154, 3981.3629819228786, 3994.463515667572, 3080.0, 3407.522946787452, 4024.63778259958, 4028.315186418316, 4040.4747382840633, 4041.5150181977765, 4375.890602734893, 4592.402987611589, 4612.5156858530045, 4623.0, 4660.906781864412, 5018.749062546858, 5555.805546805843, 5563.777448902079, 5595.160725891067, 1458.3364569121024, 1460.8393076761547, 1465.4724299252262, 1467.8752306054105, 1471.683588028579, 886.866969954512, 891.9018907920124, 896.7982204004047, 969.5297780576415, 992.270681049428, 4791.113643975876, 5572.414896435897, 5602.52378547828, 5605.80379686709, 5609.691466969356, 5148.536631703165, 5658.009848276535, 6125.387461253839, 6199.659018754011, 6201.56589038772, 4456.77716114193, 5273.868153296122, 5564.554835613141, 5576.191452239403, 5596.188552659842, 2701.729827017322, 3112.097491727419, 3154.747620190379, 3223.3714425687235, 3233.4503134467195, 6477.352264773579, 6505.381988711065, 6505.934940650627, 6510.446612037935, 6523.934760652428, 4965.950340496621, 5558.638688485235, 6321.747130114744, 6396.904046439307, 6415.871682566416, 6415.541198866836, 6452.161219041494, 6467.611943283418, 6476.761619190404, 6504.252011018793, 5676.602637815478, 6160.812911416383, 6195.752169913153, 6200.100985357189, 6226.501879849692, 5868.562202260303, 6041.426064523863, 6101.383133469545, 6102.298235702773, 6130.754769809336, 5158.303629010185, 6372.235331760218, 6395.848747225544, 6441.806745797634, 6450.516211284079, 3091.6908309168903, 3882.9417558736077, 4194.846417235285, 4199.4330765346285, 4210.494740631144, 4996.2755400466, 5576.247206627054, 5690.0, 5690.5163061140265, 5695.658260504383, 5073.746312684425, 5466.5900057495055, 5535.8892822144135, 5538.639988400902, 5542.503524048565, 4808.095742342861, 5232.869178270574, 5521.944780552143, 5589.77640894376, 5605.5795815313195, 4483.744551525578, 5144.382674079135, 5419.891602168013, 5489.670619762827, 5504.339479262514, 4498.865034048984, 4946.505349465168, 5576.944230557642, 5582.692951887685, 5623.971880140573, 4765.951490672047, 5317.441668624893, 5472.589555783412, 5494.966862260989, 5503.514051206232], "value": 4165.169714366902, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [631.3458738106162, 661.9304972977837, 749.1684230504139, 770.653206057274, 805.0, 14559.344829482672, 14884.627884302885, 14965.925170374147, 15052.172130532816, 15098.622534436645, 13947.232902190375, 14053.437862485489, 14110.858891411082, 14153.504627338045, 14199.92900035501, 747.1109379837975, 767.3592550220573, 921.0973246218693, 936.410061661156, 938.0947385772728, 692.2661978303015, 936.765808547863, 938.6151677812098, 939.0421769794839, 939.7556635274809, 947.1854205383365, 990.9454979976099, 993.1905497019942, 993.5926270229207, 997.8353571660667, 779.4621711019379, 948.5352177433077, 953.7901661634464, 983.4050399508302, 987.4667679453087, 688.215434404779, 732.4433430592735, 734.6179986407038, 736.3483317264206, 738.2580506590896, 12301.938490307492, 12312.876871231352, 14897.553073407707, 14978.1013139212, 14988.47540336083, 12230.755384892342, 12282.14025018249, 12394.008479321632, 12518.0, 12563.371831408393, 9965.70102896907, 9992.650257241034, 10066.0, 10467.476626168662, 10885.727856803564, 3558.395072837624, 3641.908952276188, 3650.014496086042, 3722.8324725387424, 3741.345264578688, 73648.63175684141, 76194.61902690507, 76619.23380766177, 77644.05889852742, 79161.20838791596, 9093.909060909305, 9465.66870159541, 9509.334346595671, 9591.952040239754, 9599.088086631758, 20725.68911466299, 20738.48153796137, 20752.896235518725, 20753.377398678065, 20760.48098797512, 6032.54755893301, 7184.928150718426, 7217.06178196831, 7385.335319821242, 7440.181580026193, 4042.312806822847, 4053.412255222976, 4065.6950728695465, 4076.9592304077173, 4080.4083407906282, 3398.660133986631, 3469.444888817777, 3469.809160496197, 3470.670286322795, 3475.94786078209, 627.7740013595102, 652.6736631684158, 654.8722999015147, 666.4734859460972, 669.7454967112466, 562.6427218716063, 582.6974531760942, 602.813127930343, 617.2315467243311, 628.8239292997968, 7805.37556995439, 8202.794930126794, 8254.174582541698, 8400.579971001547, 8407.70689827296, 467.886005954916, 500.97996080157117, 522.4801322683953, 585.1427658480346, 601.5007543738686, 3750.287445385368, 3899.727019108635, 3995.7202995790017, 4011.1576568920855, 4111.753294802322, 91903.62144567836, 92798.0, 97869.04261914722, 98315.52526712105, 99234.00765992247, 83164.0, 83499.0, 84217.57891210505, 84254.15745842586, 85908.0, 74323.0, 74405.51188976299, 75235.24764752392, 75952.24047759452, 76022.23977760151, 8001.559914204542, 8057.476264042818, 8166.101728809945, 8309.709160179607, 8486.024107227748, 40054.0, 40750.0, 42360.576394236894, 43920.56079439165, 46505.0, 59485.7025714886, 63925.78871833699, 64935.0, 65380.0, 67097.3290267091, 11030.338179709242, 11058.060064894253, 11063.114950803756, 11096.5561377544, 11560.0, 10268.97310268997, 11741.882581174079, 11937.820932685843, 11997.520099196283, 12558.932490738389, 8435.214509801903, 11337.376444295644, 11351.37567433799, 11533.653990380302, 11812.0, 11309.830352544554, 11315.660530184108, 11329.71675708114, 11347.659570212907, 11679.708007299885, 11255.0, 11311.0, 11339.659810205707, 11474.885251147381, 11586.304821710724, 9533.285003624616, 9629.374090684083, 10099.04059114383, 10371.94814025925, 10584.682459526226, 9822.312438129262, 9868.111869931741, 9875.259355548505, 9889.604415823287, 9918.801623967625], "value": 6861.365729752726, "unit": "score"}], "name": "dromaeo_css", "value": 7198.551983359315, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 109.0, 113.0, 114.0, 113.0, 114.0, 113.0, 105.0, 113.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 145.0, 182.0, 180.0, 119.0, 141.0, 120.0, 153.0, 156.0, 122.0], "value": 147.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 187.0, 187.0, 187.0, 187.0, 185.0, 181.0, 187.0, 185.0, 183.0], "value": 185.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 90.0, 92.0, 56.0, 59.0, 58.0, 80.0, 87.0, 54.0], "value": 73.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 90.0, 136.0, 78.0, 83.0, 114.0, 157.0, 117.0, 100.0, 115.0], "value": 108.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 135.0, 119.0, 88.0, 106.0, 134.0, 84.0, 87.0, 85.0], "value": 101.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 95.0, 93.0, 94.0, 92.0, 93.0, 94.0, 93.0, 93.0], "value": 93.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 84.0, 86.0, 85.0, 84.0, 85.0, 84.0, 84.0, 84.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 59.0, 58.0, 57.0, 59.0, 58.0, 58.0, 80.0, 59.0, 58.0], "value": 60.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 79.0, 73.0, 68.0, 69.0, 68.0, 67.0, 67.0, 69.0], "value": 68.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 82.0, 83.0, 82.0, 82.0, 82.0, 96.0, 108.0, 105.0], "value": 88.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 135.0, 143.0, 146.0, 142.0, 134.0, 135.0, 135.0, 180.0, 166.0], "value": 145.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 171.0, 170.0, 170.0, 169.0, 169.0, 156.0, 200.0, 225.0, 203.0], "value": 180.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 68.0, 67.0, 68.0, 67.0, 68.0, 69.0, 69.0, 67.0], "value": 68.2, "unit": "score"}], "name": "kraken", "value": 1516.8999999999999, "alertThreshold": 2.0}]} 11:29:17 INFO - Return code: 0 11:29:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:29:17 ERROR - # TBPL SUCCESS # 11:29:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:29:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:29:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:29:17 INFO - 2016-04-29 11:29:17.576 screenresolution[1678:10189] starting screenresolution argv=screenresolution get 11:29:17 INFO - 2016-04-29 11:29:17.579 screenresolution[1678:10189] Display 0: 1600x1200x32@60 11:29:17 INFO - 2016-04-29 11:29:17.585 screenresolution[1679:10192] starting screenresolution argv=screenresolution list 11:29:17 INFO - Available Modes on Display 0 11:29:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:29:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:29:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:29:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:29:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:29:17 INFO - Intel Iris: 11:29:17 INFO - Chipset Model: Intel Iris 11:29:17 INFO - Type: GPU 11:29:17 INFO - Bus: Built-In 11:29:17 INFO - VRAM (Dynamic, Max): 1536 MB 11:29:17 INFO - Vendor: Intel (0x8086) 11:29:17 INFO - Device ID: 0x0a2e 11:29:17 INFO - Revision ID: 0x0009 11:29:17 INFO - Displays: 11:29:17 INFO - Display: 11:29:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:29:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:29:17 INFO - Display Serial Number: 1600x1200 60 11:29:17 INFO - Main Display: Yes 11:29:17 INFO - Mirror: Off 11:29:17 INFO - Online: Yes 11:29:17 INFO - Rotation: Supported 11:29:17 INFO - Return code: 0 11:29:17 INFO - Running post-action listener: _resource_record_post_action 11:29:17 INFO - Running post-run listener: _resource_record_post_run 11:29:18 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 37975552; Write bytes: 696159232; Read time: 391; Write time: 2432 11:29:18 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 402123264; Write bytes: 398907392; Read time: 29577; Write time: 760 11:29:18 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 30871040; Write bytes: 296244224; Read time: 306; Write time: 1668 11:29:18 INFO - Running post-run listener: _upload_blobber_files 11:29:18 INFO - Blob upload gear active. 11:29:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:29:18 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 11:29:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:29:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:29:19 INFO - (blobuploader) - INFO - Open directory for files ... 11:29:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:29:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:29:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:29:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:29:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:29:20 INFO - (blobuploader) - INFO - Done attempting. 11:29:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:29:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:29:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:29:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:29:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:29:21 INFO - (blobuploader) - INFO - Done attempting. 11:29:21 INFO - (blobuploader) - INFO - Iteration through files over. 11:29:21 INFO - Return code: 0 11:29:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:29:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:29:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c9f9ff65dda34bb5cd5ef3da011d56435111d09be808ec35812263a2bc36ac812fe145cba7da56b7b43556bdd145980ef9b6dfe16c5888620b4ab6af22f5f583", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/58b41f2995a38afd50d37b28e2c3d08e3f0482946f31f713fa59cffaecffb735f096a8ad59db10ec1e2d42ed041394f0ec4877870903fc6273c4275a515f055c"} 11:29:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:29:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:29:21 INFO - Contents: 11:29:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c9f9ff65dda34bb5cd5ef3da011d56435111d09be808ec35812263a2bc36ac812fe145cba7da56b7b43556bdd145980ef9b6dfe16c5888620b4ab6af22f5f583", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/58b41f2995a38afd50d37b28e2c3d08e3f0482946f31f713fa59cffaecffb735f096a8ad59db10ec1e2d42ed041394f0ec4877870903fc6273c4275a515f055c"} 11:29:21 INFO - Running post-run listener: copy_logs_to_upload_dir 11:29:21 INFO - Copying logs to upload dir... 11:29:21 INFO - mkdir: /builds/slave/test/build/upload/logs 11:29:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.071134 ========= master_lag: 0.16 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-04-29 11:29:21.223038) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 11:29:21.226550) ========= 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.96Swecb1pE/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.iGkMjyUzY9/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c9f9ff65dda34bb5cd5ef3da011d56435111d09be808ec35812263a2bc36ac812fe145cba7da56b7b43556bdd145980ef9b6dfe16c5888620b4ab6af22f5f583", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/58b41f2995a38afd50d37b28e2c3d08e3f0482946f31f713fa59cffaecffb735f096a8ad59db10ec1e2d42ed041394f0ec4877870903fc6273c4275a515f055c"} build_url:https://queue.taskcluster.net/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011148 build_url: 'https://queue.taskcluster.net/v1/task/SlZtjUGJRECV5URuWoTk8g/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c9f9ff65dda34bb5cd5ef3da011d56435111d09be808ec35812263a2bc36ac812fe145cba7da56b7b43556bdd145980ef9b6dfe16c5888620b4ab6af22f5f583", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/58b41f2995a38afd50d37b28e2c3d08e3f0482946f31f713fa59cffaecffb735f096a8ad59db10ec1e2d42ed041394f0ec4877870903fc6273c4275a515f055c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 11:29:21.254659) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 11:29:21.254953) ========= 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.96Swecb1pE/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.iGkMjyUzY9/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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-04-29 11:29:21.302776) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 11:29:21.303098) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 11:29:21.303465) ========= ========= Total master_lag: 1.20 =========