builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0071 starttime: 1461197875.05 results: success (0) buildid: 20160420145812 builduid: 0196ae12dcc544b9abb2c818bb34b6f2 revision: a6623a30d98d63a54ac754b28e55e986643e6c93 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 17:17:55.046089) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 17:17:55.046475) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-04-20 17:17:55.047757) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-04-20 17:17:56.422264) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-20 17:17:56.422561) ========= 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.jfa69A3mRL/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.Xnfh5pzcmv/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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-20 17:17:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 28.2M=0s 2016-04-20 17:17:56 (28.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.549299 ========= master_lag: 0.79 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-20 17:17:57.758477) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-04-20 17:17:57.758776) ========= 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.jfa69A3mRL/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.Xnfh5pzcmv/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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.026864 ========= master_lag: 1.97 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-04-20 17:17:59.751701) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-20 17:17:59.752000) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a6623a30d98d63a54ac754b28e55e986643e6c93 --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 a6623a30d98d63a54ac754b28e55e986643e6c93 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.jfa69A3mRL/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.Xnfh5pzcmv/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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-20 17:17:59,829 truncating revision to first 12 chars 2016-04-20 17:17:59,829 Setting DEBUG logging. 2016-04-20 17:17:59,829 attempt 1/10 2016-04-20 17:17:59,829 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a6623a30d98d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-20 17:18:01,850 unpacking tar archive at: fx-team-a6623a30d98d/testing/mozharness/ program finished with exit code 0 elapsedTime=2.266729 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-20 17:18:02.050506) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 17:18:02.050881) ========= script_repo_revision: a6623a30d98d63a54ac754b28e55e986643e6c93 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 17:18:02.051396) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 17:18:02.051850) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 17:18:02.087385) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-04-20 17:18:02.087736) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.jfa69A3mRL/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.Xnfh5pzcmv/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 17:18:02 INFO - MultiFileLogger online at 20160420 17:18:02 in /builds/slave/test 17:18:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:18:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:18:02 INFO - {'append_to_log': False, 17:18:02 INFO - 'base_work_dir': '/builds/slave/test', 17:18:02 INFO - 'blob_upload_branch': 'Fx-Team', 17:18:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:18:02 INFO - 'branch': 'Fx-Team', 17:18:02 INFO - 'buildbot_json_path': 'buildprops.json', 17:18:02 INFO - 'config_files': ('talos/mac_config.py',), 17:18:02 INFO - 'default_actions': ('clobber', 17:18:02 INFO - 'read-buildbot-config', 17:18:02 INFO - 'download-and-extract', 17:18:02 INFO - 'populate-webroot', 17:18:02 INFO - 'create-virtualenv', 17:18:02 INFO - 'install', 17:18:02 INFO - 'run-tests'), 17:18:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:18:02 INFO - 'download_minidump_stackwalk': True, 17:18:02 INFO - 'download_symbols': 'ondemand', 17:18:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:18:02 INFO - 'tooltool.py': '/tools/tooltool.py', 17:18:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:18:02 INFO - '/tools/misc-python/virtualenv.py')}, 17:18:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:18:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:18:02 INFO - 'installer_path': 'installer.exe', 17:18:02 INFO - 'log_level': 'info', 17:18:02 INFO - 'log_name': 'talos', 17:18:02 INFO - 'log_to_console': True, 17:18:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:18:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:18:02 INFO - 'opt_config_files': (), 17:18:02 INFO - 'pip_index': False, 17:18:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:18:02 INFO - 'cmd': ('bash', 17:18:02 INFO - '-c', 17:18:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:18:02 INFO - 'enabled': True, 17:18:02 INFO - 'halt_on_failure': False, 17:18:02 INFO - 'name': 'check_screen_resolution'},), 17:18:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:18:02 INFO - 'cmd': ('bash', 17:18:02 INFO - '-c', 17:18:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:18:02 INFO - 'enabled': True, 17:18:02 INFO - 'halt_on_failure': False, 17:18:02 INFO - 'name': 'check_screen_resolution'},), 17:18:02 INFO - 'run_cmd_checks_enabled': True, 17:18:02 INFO - 'sps_profile': False, 17:18:02 INFO - 'sps_profile_interval': 0, 17:18:02 INFO - 'suite': 'dromaeojs-e10s', 17:18:02 INFO - 'system_bits': '32', 17:18:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:18:02 INFO - 'title': 't-yosemite-r7-0071', 17:18:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:18:02 INFO - 'use_talos_json': True, 17:18:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:18:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:18:02 INFO - 'work_dir': 'build'} 17:18:02 INFO - ##### 17:18:02 INFO - ##### Running clobber step. 17:18:02 INFO - ##### 17:18:02 INFO - Running pre-action listener: _resource_record_pre_action 17:18:02 INFO - Running main action method: clobber 17:18:02 INFO - rmtree: /builds/slave/test/build 17:18:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:18:03 INFO - Running post-action listener: _resource_record_post_action 17:18:03 INFO - ##### 17:18:03 INFO - ##### Running read-buildbot-config step. 17:18:03 INFO - ##### 17:18:03 INFO - Running pre-action listener: _resource_record_pre_action 17:18:03 INFO - Running main action method: read_buildbot_config 17:18:03 INFO - Using buildbot properties: 17:18:03 INFO - { 17:18:03 INFO - "project": "", 17:18:03 INFO - "product": "firefox", 17:18:03 INFO - "script_repo_revision": "production", 17:18:03 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 17:18:03 INFO - "repository": "", 17:18:03 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 17:18:03 INFO - "buildid": "20160420145812", 17:18:03 INFO - "pgo_build": "False", 17:18:03 INFO - "basedir": "/builds/slave/test", 17:18:03 INFO - "buildnumber": 710, 17:18:03 INFO - "slavename": "t-yosemite-r7-0071", 17:18:03 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 17:18:03 INFO - "platform": "yosemite_r7", 17:18:03 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 17:18:03 INFO - "branch": "fx-team", 17:18:03 INFO - "repo_path": "integration/fx-team", 17:18:03 INFO - "revision": "a6623a30d98d63a54ac754b28e55e986643e6c93", 17:18:03 INFO - "stage_platform": "macosx64", 17:18:03 INFO - "builduid": "0196ae12dcc544b9abb2c818bb34b6f2", 17:18:03 INFO - "slavebuilddir": "test" 17:18:03 INFO - } 17:18:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 17:18:03 INFO - Running post-action listener: _resource_record_post_action 17:18:03 INFO - ##### 17:18:03 INFO - ##### Running download-and-extract step. 17:18:03 INFO - ##### 17:18:03 INFO - Running pre-action listener: _resource_record_pre_action 17:18:03 INFO - Running main action method: download_and_extract 17:18:03 INFO - mkdir: /builds/slave/test/build/tests 17:18:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:03 INFO - https://queue.taskcluster.net/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 17:18:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 17:18:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 17:18:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 17:18:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 17:18:05 INFO - Downloaded 1199 bytes. 17:18:05 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 17:18:05 INFO - Using the following test package requirements: 17:18:05 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 17:18:05 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:18:05 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 17:18:05 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:18:05 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 17:18:05 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:18:05 INFO - u'jsshell-mac.zip'], 17:18:05 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:18:05 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 17:18:05 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 17:18:05 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:18:05 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 17:18:05 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:18:05 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 17:18:05 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:18:05 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 17:18:05 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:18:05 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 17:18:05 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:18:05 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')]} 17:18:05 INFO - https://queue.taskcluster.net/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:18:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:18:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:18:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:18:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:18:08 INFO - Downloaded 18099652 bytes. 17:18:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:18:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 17:18:11 INFO - Return code: 0 17:18:11 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 17:18:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:11 INFO - https://queue.taskcluster.net/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:18:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:18:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:18:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:18:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:18:12 INFO - Downloaded 18099652 bytes. 17:18:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:18:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 17:18:16 INFO - Return code: 0 17:18:16 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')]} 17:18:16 INFO - https://queue.taskcluster.net/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 17:18:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 17:18:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 17:18:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 17:18:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:18:17 INFO - Downloaded 10845952 bytes. 17:18:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:18:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 17:18:17 INFO - Return code: 0 17:18:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:17 INFO - https://queue.taskcluster.net/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 17:18:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 17:18:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 17:18:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 17:18:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 17:18:22 INFO - Downloaded 110036674 bytes. 17:18:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 17:18:22 INFO - mkdir: /builds/slave/test/properties 17:18:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:18:22 INFO - Writing to file /builds/slave/test/properties/build_url 17:18:22 INFO - Contents: 17:18:22 INFO - build_url:https://queue.taskcluster.net/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 17:18:23 INFO - Running post-action listener: _resource_record_post_action 17:18:23 INFO - Running post-action listener: set_extra_try_arguments 17:18:23 INFO - ##### 17:18:23 INFO - ##### Running populate-webroot step. 17:18:23 INFO - ##### 17:18:23 INFO - Running pre-action listener: _resource_record_pre_action 17:18:23 INFO - Running main action method: populate_webroot 17:18:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:18:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:18:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:18:23 INFO - '--tppagecycles', 17:18:23 INFO - '7'], 17:18:23 INFO - 'tests': ['tsvgm']}}, 17:18:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:18:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:18:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:18:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:18:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:18:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:18:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:18:23 INFO - 'talos_options': ['--disable-e10s'], 17:18:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:18:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:18:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:18:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:18:23 INFO - 'talos_options': ['--disable-e10s'], 17:18:23 INFO - 'tests': ['damp', 'tps']}, 17:18:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:18:23 INFO - 'tests': ['damp', 'tps']}, 17:18:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:18:23 INFO - 'tests': ['dromaeo_dom']}, 17:18:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:18:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:18:23 INFO - 'tests': ['a11yr', 17:18:23 INFO - 'ts_paint', 17:18:23 INFO - 'tpaint', 17:18:23 INFO - 'sessionrestore', 17:18:23 INFO - 'sessionrestore_no_auto_restore', 17:18:23 INFO - 'tabpaint']}, 17:18:23 INFO - 'other-e10s': {'tests': ['a11yr', 17:18:23 INFO - 'ts_paint', 17:18:23 INFO - 'tpaint', 17:18:23 INFO - 'sessionrestore', 17:18:23 INFO - 'sessionrestore_no_auto_restore', 17:18:23 INFO - 'tabpaint']}, 17:18:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:18:23 INFO - 'ts_paint', 17:18:23 INFO - 'tpaint', 17:18:23 INFO - 'sessionrestore', 17:18:23 INFO - 'sessionrestore_no_auto_restore', 17:18:23 INFO - 'tabpaint']}, 17:18:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:18:23 INFO - 'ts_paint', 17:18:23 INFO - 'tpaint', 17:18:23 INFO - 'sessionrestore', 17:18:23 INFO - 'sessionrestore_no_auto_restore', 17:18:23 INFO - 'tabpaint']}, 17:18:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:18:23 INFO - 'tests': ['a11yr', 17:18:23 INFO - 'ts_paint', 17:18:23 INFO - 'tpaint', 17:18:23 INFO - 'sessionrestore', 17:18:23 INFO - 'sessionrestore_no_auto_restore', 17:18:23 INFO - 'tabpaint']}, 17:18:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:18:23 INFO - 'tests': ['a11yr', 17:18:23 INFO - 'ts_paint', 17:18:23 INFO - 'tpaint', 17:18:23 INFO - 'sessionrestore', 17:18:23 INFO - 'sessionrestore_no_auto_restore', 17:18:23 INFO - 'tabpaint']}, 17:18:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:18:23 INFO - 'tests': ['tsvgx', 17:18:23 INFO - 'tsvgr_opacity', 17:18:23 INFO - 'tart', 17:18:23 INFO - 'tscrollx', 17:18:23 INFO - 'cart']}, 17:18:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:18:23 INFO - 'tsvgr_opacity', 17:18:23 INFO - 'tart', 17:18:23 INFO - 'tscrollx', 17:18:23 INFO - 'cart']}, 17:18:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:18:23 INFO - 'talos_options': ['--disable-e10s'], 17:18:23 INFO - 'tests': ['tp5o']}, 17:18:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:18:23 INFO - 'tests': ['tp5o']}, 17:18:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:18:23 INFO - 'talos_options': ['--disable-e10s', 17:18:23 INFO - '--xperf_path', 17:18:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:18:23 INFO - 'tests': ['tp5n']}, 17:18:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:18:23 INFO - 'talos_options': ['--xperf_path', 17:18:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:18:23 INFO - 'tests': ['tp5n']}}, 17:18:23 INFO - 'talos.zip': {'path': '', 17:18:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:18:23 INFO - Running post-action listener: _resource_record_post_action 17:18:23 INFO - ##### 17:18:23 INFO - ##### Running create-virtualenv step. 17:18:23 INFO - ##### 17:18:23 INFO - Running pre-action listener: _resource_record_pre_action 17:18:23 INFO - Running main action method: create_virtualenv 17:18:23 INFO - Creating virtualenv /builds/slave/test/build/venv 17:18:23 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 17:18:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:18:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:18:24 INFO - Using real prefix '/tools/python27' 17:18:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:18:24 INFO - Installing distribute.............................................................................................................................................................................................done. 17:18:27 INFO - Installing pip.................done. 17:18:27 INFO - Return code: 0 17:18:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:18: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')]} 17:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18: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')]} 17:18:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:27 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 0x10c6fca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c70c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae7a589010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c59be00>, '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 0x10c404db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c596b20>, '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.jfa69A3mRL/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.Xnfh5pzcmv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 17:18:27 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 17:18:27 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 17:18:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jfa69A3mRL/Render', 17:18:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:18:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:18:27 INFO - 'HOME': '/Users/cltbld', 17:18:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:18:27 INFO - 'LOGNAME': 'cltbld', 17:18:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:27 INFO - 'MOZ_NO_REMOTE': '1', 17:18:27 INFO - 'NO_EM_RESTART': '1', 17:18:27 INFO - 'PAGER': '/bin/cat', 17:18:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:18:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:27 INFO - 'PWD': '/builds/slave/test', 17:18:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:18:27 INFO - 'SHELL': '/bin/bash', 17:18:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xnfh5pzcmv/Listeners', 17:18:27 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 17:18:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:18:27 INFO - 'USER': 'cltbld', 17:18:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:18:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:18:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:27 INFO - 'XPC_FLAGS': '0x0', 17:18:27 INFO - 'XPC_SERVICE_NAME': '0', 17:18:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:18:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:27 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 17:18:27 INFO - Cleaning up... 17:18:27 INFO - Return code: 0 17:18:27 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:18: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')]} 17:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18: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')]} 17:18:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:27 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 0x10c6fca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c70c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae7a589010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c59be00>, '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 0x10c404db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c596b20>, '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.jfa69A3mRL/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.Xnfh5pzcmv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 17:18:27 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 17:18:27 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 17:18:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jfa69A3mRL/Render', 17:18:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:18:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:18:27 INFO - 'HOME': '/Users/cltbld', 17:18:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:18:27 INFO - 'LOGNAME': 'cltbld', 17:18:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:27 INFO - 'MOZ_NO_REMOTE': '1', 17:18:27 INFO - 'NO_EM_RESTART': '1', 17:18:27 INFO - 'PAGER': '/bin/cat', 17:18:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:18:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:27 INFO - 'PWD': '/builds/slave/test', 17:18:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:18:27 INFO - 'SHELL': '/bin/bash', 17:18:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xnfh5pzcmv/Listeners', 17:18:27 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 17:18:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:18:27 INFO - 'USER': 'cltbld', 17:18:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:18:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:18:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:27 INFO - 'XPC_FLAGS': '0x0', 17:18:27 INFO - 'XPC_SERVICE_NAME': '0', 17:18:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:18:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:28 INFO - Downloading/unpacking psutil>=0.7.1 17:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:18:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:18:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:18:31 INFO - Installing collected packages: psutil 17:18:31 INFO - Running setup.py install for psutil 17:18:31 INFO - building 'psutil._psutil_osx' extension 17:18:31 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 17:18:32 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 17:18:32 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 17:18:32 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 17:18:32 INFO - building 'psutil._psutil_posix' extension 17:18:32 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 17:18:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:18:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:18:32 INFO - ^ 17:18:32 INFO - 1 warning generated. 17:18:32 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 17:18:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:18:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:18:32 INFO - Successfully installed psutil 17:18:32 INFO - Cleaning up... 17:18:32 INFO - Return code: 0 17:18:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:18:32 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')]} 17:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:32 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')]} 17:18:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:32 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 0x10c6fca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c70c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae7a589010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c59be00>, '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 0x10c404db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c596b20>, '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.jfa69A3mRL/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.Xnfh5pzcmv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 17:18:32 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 17:18:32 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 17:18:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jfa69A3mRL/Render', 17:18:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:18:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:18:32 INFO - 'HOME': '/Users/cltbld', 17:18:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:18:32 INFO - 'LOGNAME': 'cltbld', 17:18:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:32 INFO - 'MOZ_NO_REMOTE': '1', 17:18:32 INFO - 'NO_EM_RESTART': '1', 17:18:32 INFO - 'PAGER': '/bin/cat', 17:18:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:18:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:32 INFO - 'PWD': '/builds/slave/test', 17:18:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:18:32 INFO - 'SHELL': '/bin/bash', 17:18:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xnfh5pzcmv/Listeners', 17:18:32 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 17:18:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:18:32 INFO - 'USER': 'cltbld', 17:18:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:18:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:18:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:32 INFO - 'XPC_FLAGS': '0x0', 17:18:32 INFO - 'XPC_SERVICE_NAME': '0', 17:18:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:18:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:18:33 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 17:18:33 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 17:18:33 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 17:18:33 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 17:18:33 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 17:18:33 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 17:18:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:18:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:18:35 INFO - Installing collected packages: mozsystemmonitor 17:18:35 INFO - Running setup.py install for mozsystemmonitor 17:18:35 INFO - Successfully installed mozsystemmonitor 17:18:35 INFO - Cleaning up... 17:18:35 INFO - Return code: 0 17:18:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:35 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 0x10c6fca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c70c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae7a589010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c59be00>, '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 0x10c404db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c596b20>, '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.jfa69A3mRL/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.Xnfh5pzcmv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 17:18:35 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 17:18:35 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 17:18:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jfa69A3mRL/Render', 17:18:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:18:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:18:35 INFO - 'HOME': '/Users/cltbld', 17:18:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:18:35 INFO - 'LOGNAME': 'cltbld', 17:18:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:35 INFO - 'MOZ_NO_REMOTE': '1', 17:18:35 INFO - 'NO_EM_RESTART': '1', 17:18:35 INFO - 'PAGER': '/bin/cat', 17:18:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:18:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:35 INFO - 'PWD': '/builds/slave/test', 17:18:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:18:35 INFO - 'SHELL': '/bin/bash', 17:18:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xnfh5pzcmv/Listeners', 17:18:35 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 17:18:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:18:35 INFO - 'USER': 'cltbld', 17:18:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:18:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:18:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:35 INFO - 'XPC_FLAGS': '0x0', 17:18:35 INFO - 'XPC_SERVICE_NAME': '0', 17:18:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:18:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:36 INFO - Downloading/unpacking blobuploader==1.2.4 17:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:38 INFO - Downloading blobuploader-1.2.4.tar.gz 17:18:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:18:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:18:38 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 17:18:38 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 17:18:38 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 17:18:38 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 17:18:38 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 17:18:38 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 17:18:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:18:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:18:39 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 17:18:39 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 17:18:39 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 17:18:39 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 17:18:39 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 17:18:39 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 17:18:39 INFO - Downloading docopt-0.6.1.tar.gz 17:18:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:18:39 INFO - Installing collected packages: blobuploader, requests, docopt 17:18:39 INFO - Running setup.py install for blobuploader 17:18:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:18:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:18:40 INFO - Running setup.py install for requests 17:18:40 INFO - Running setup.py install for docopt 17:18:40 INFO - Successfully installed blobuploader requests docopt 17:18:40 INFO - Cleaning up... 17:18:40 INFO - Return code: 0 17:18:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:18:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:40 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 0x10c6fca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c70c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae7a589010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c59be00>, '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 0x10c404db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c596b20>, '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.jfa69A3mRL/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.Xnfh5pzcmv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 17:18:40 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 17:18:40 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 17:18:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jfa69A3mRL/Render', 17:18:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:18:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:18:40 INFO - 'HOME': '/Users/cltbld', 17:18:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:18:40 INFO - 'LOGNAME': 'cltbld', 17:18:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:40 INFO - 'MOZ_NO_REMOTE': '1', 17:18:40 INFO - 'NO_EM_RESTART': '1', 17:18:40 INFO - 'PAGER': '/bin/cat', 17:18:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:18:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:40 INFO - 'PWD': '/builds/slave/test', 17:18:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:18:40 INFO - 'SHELL': '/bin/bash', 17:18:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xnfh5pzcmv/Listeners', 17:18:40 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 17:18:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:18:40 INFO - 'USER': 'cltbld', 17:18:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:18:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:18:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:40 INFO - 'XPC_FLAGS': '0x0', 17:18:40 INFO - 'XPC_SERVICE_NAME': '0', 17:18:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:18:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:18:41 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-QEge7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:18:41 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-1rmV8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:18:41 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-WDYEpJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:18:41 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-9zrq5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:18:41 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-rW99xl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:18:41 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-K6iEAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:18:41 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-14pNS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:18:41 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-FxaQzt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:18:41 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-HDcAPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:18:42 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-GuGvam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:18:42 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-2ASdja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:18:42 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-28yDpr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:18:42 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-gh2dw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:18:42 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-U_zaYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:18:42 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-18NA0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:18:42 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-523KF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:18:42 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-7P0syn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:18:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:18:42 INFO - Running setup.py install for manifestparser 17:18:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:18:42 INFO - Running setup.py install for mozcrash 17:18:43 INFO - Running setup.py install for mozdebug 17:18:43 INFO - Running setup.py install for mozdevice 17:18:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:18:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:18:43 INFO - Running setup.py install for mozfile 17:18:43 INFO - Running setup.py install for mozhttpd 17:18:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:18:43 INFO - Running setup.py install for mozinfo 17:18:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:18:43 INFO - Running setup.py install for mozInstall 17:18:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:18:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:18:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:18:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:18:44 INFO - Running setup.py install for mozleak 17:18:44 INFO - Running setup.py install for mozlog 17:18:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:18:44 INFO - Running setup.py install for moznetwork 17:18:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:18:44 INFO - Running setup.py install for mozprocess 17:18:44 INFO - Running setup.py install for mozprofile 17:18:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:18:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:18:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:18:44 INFO - Running setup.py install for mozrunner 17:18:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:18:44 INFO - Running setup.py install for mozscreenshot 17:18:45 INFO - Running setup.py install for moztest 17:18:45 INFO - Running setup.py install for mozversion 17:18:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:18:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:18:45 INFO - Cleaning up... 17:18:45 INFO - Return code: 0 17:18:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:18:45 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')]} 17:18:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:45 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')]} 17:18:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:45 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 0x10c6fca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c70c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae7a589010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c59be00>, '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 0x10c404db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c596b20>, '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.jfa69A3mRL/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.Xnfh5pzcmv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 17:18:45 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 17:18:45 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 17:18:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jfa69A3mRL/Render', 17:18:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:18:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:18:45 INFO - 'HOME': '/Users/cltbld', 17:18:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:18:45 INFO - 'LOGNAME': 'cltbld', 17:18:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:45 INFO - 'MOZ_NO_REMOTE': '1', 17:18:45 INFO - 'NO_EM_RESTART': '1', 17:18:45 INFO - 'PAGER': '/bin/cat', 17:18:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:18:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:45 INFO - 'PWD': '/builds/slave/test', 17:18:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:18:45 INFO - 'SHELL': '/bin/bash', 17:18:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xnfh5pzcmv/Listeners', 17:18:45 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 17:18:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:18:45 INFO - 'USER': 'cltbld', 17:18:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:18:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:18:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:45 INFO - 'XPC_FLAGS': '0x0', 17:18:45 INFO - 'XPC_SERVICE_NAME': '0', 17:18:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:18:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:18:45 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-awRCoC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:18:45 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)) 17:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:18:45 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-qRc7fV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:18:45 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)) 17:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:18:45 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-t7TD7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:18:46 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)) 17:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:18:46 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-8vCagk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:18:46 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)) 17:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:18:46 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-0J9tzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:18:46 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)) 17:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:18:46 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-2vzQl2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:18:46 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)) 17:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:18:46 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-LIgvK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:18:46 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)) 17:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:18:46 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-Ubl7z6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:18:46 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)) 17:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:18:46 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-BSmkju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:18:46 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)) 17:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:18:46 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-4uXaxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:18:46 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)) 17:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:18:46 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-r99MIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:18:46 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)) 17:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:18:46 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-Wb02d0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:18:46 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)) 17:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:18:46 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-22coAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:18:47 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)) 17:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:18:47 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-52oXPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:18:47 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)) 17:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:18:47 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-7t01ak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:18:47 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)) 17:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:18:47 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-G7_OAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:18:47 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)) 17:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:18:47 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-DzF9Ji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:18:47 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)) 17:18:47 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)) 17:18:47 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)) 17:18:47 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)) 17:18:47 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)) 17:18:47 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)) 17:18:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:49 INFO - Downloading blessings-1.6.tar.gz 17:18:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:18:50 INFO - Installing collected packages: blessings 17:18:50 INFO - Running setup.py install for blessings 17:18:50 INFO - Successfully installed blessings 17:18:50 INFO - Cleaning up... 17:18:50 INFO - Return code: 0 17:18:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:18:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:18:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:18:50 INFO - Reading from file tmpfile_stdout 17:18:50 INFO - Current package versions: 17:18:50 INFO - blessings == 1.6 17:18:50 INFO - blobuploader == 1.2.4 17:18:50 INFO - docopt == 0.6.1 17:18:50 INFO - manifestparser == 1.1 17:18:50 INFO - mozInstall == 1.12 17:18:50 INFO - mozcrash == 0.17 17:18:50 INFO - mozdebug == 0.1 17:18:50 INFO - mozdevice == 0.48 17:18:50 INFO - mozfile == 1.2 17:18:50 INFO - mozhttpd == 0.7 17:18:50 INFO - mozinfo == 0.9 17:18:50 INFO - mozleak == 0.1 17:18:50 INFO - mozlog == 3.1 17:18:50 INFO - moznetwork == 0.27 17:18:50 INFO - mozprocess == 0.22 17:18:50 INFO - mozprofile == 0.28 17:18:50 INFO - mozrunner == 6.11 17:18:50 INFO - mozscreenshot == 0.1 17:18:50 INFO - mozsystemmonitor == 0.0 17:18:50 INFO - moztest == 0.7 17:18:50 INFO - mozversion == 1.4 17:18:50 INFO - psutil == 3.1.1 17:18:50 INFO - requests == 1.2.3 17:18:50 INFO - wsgiref == 0.1.2 17:18:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:50 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 0x10c6fca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c70c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae7a589010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c59be00>, '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 0x10c404db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c596b20>, '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.jfa69A3mRL/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.Xnfh5pzcmv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 17:18:50 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 17:18:50 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 17:18:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jfa69A3mRL/Render', 17:18:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:18:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:18:50 INFO - 'HOME': '/Users/cltbld', 17:18:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:18:50 INFO - 'LOGNAME': 'cltbld', 17:18:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:50 INFO - 'MOZ_NO_REMOTE': '1', 17:18:50 INFO - 'NO_EM_RESTART': '1', 17:18:50 INFO - 'PAGER': '/bin/cat', 17:18:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:18:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:50 INFO - 'PWD': '/builds/slave/test', 17:18:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:18:50 INFO - 'SHELL': '/bin/bash', 17:18:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xnfh5pzcmv/Listeners', 17:18:50 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 17:18:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:18:50 INFO - 'USER': 'cltbld', 17:18:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:18:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:50 INFO - 'XPC_FLAGS': '0x0', 17:18:50 INFO - 'XPC_SERVICE_NAME': '0', 17:18:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:18:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:50 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)) 17:18:50 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)) 17:18:50 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)) 17:18:50 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)) 17:18:50 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)) 17:18:50 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)) 17:18:50 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)) 17:18:50 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)) 17:18:50 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)) 17:18:50 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)) 17:18:50 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)) 17:18:50 INFO - Cleaning up... 17:18:50 INFO - Return code: 0 17:18:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:50 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 0x10c6fca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c70c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae7a589010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c59be00>, '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 0x10c404db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c596b20>, '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.jfa69A3mRL/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.Xnfh5pzcmv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 17:18:50 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 17:18:50 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 17:18:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jfa69A3mRL/Render', 17:18:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:18:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:18:50 INFO - 'HOME': '/Users/cltbld', 17:18:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:18:50 INFO - 'LOGNAME': 'cltbld', 17:18:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:50 INFO - 'MOZ_NO_REMOTE': '1', 17:18:50 INFO - 'NO_EM_RESTART': '1', 17:18:50 INFO - 'PAGER': '/bin/cat', 17:18:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:18:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:50 INFO - 'PWD': '/builds/slave/test', 17:18:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:18:50 INFO - 'SHELL': '/bin/bash', 17:18:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xnfh5pzcmv/Listeners', 17:18:50 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 17:18:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:18:50 INFO - 'USER': 'cltbld', 17:18:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:18:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:50 INFO - 'XPC_FLAGS': '0x0', 17:18:50 INFO - 'XPC_SERVICE_NAME': '0', 17:18:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:18:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:51 INFO - Downloading/unpacking jsonschema 17:18:51 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 17:18:51 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 17:18:51 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 17:18:51 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 17:18:51 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 17:18:51 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 17:18:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:18:53 INFO - Downloading/unpacking functools32 (from jsonschema) 17:18:53 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 17:18:53 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 17:18:53 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 17:18:53 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 17:18:53 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 17:18:53 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 17:18:53 INFO - Downloading functools32-3.2.3-2.tar.gz 17:18:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:18:53 INFO - warning: no files found matching '*.txt' 17:18:53 INFO - no previously-included directories found matching 'build' 17:18:53 INFO - no previously-included directories found matching 'dist' 17:18:53 INFO - no previously-included directories found matching '.git*' 17:18:53 INFO - Installing collected packages: jsonschema, functools32 17:18:54 INFO - Running setup.py install for functools32 17:18:54 INFO - warning: no files found matching '*.txt' 17:18:54 INFO - no previously-included directories found matching 'build' 17:18:54 INFO - no previously-included directories found matching 'dist' 17:18:54 INFO - no previously-included directories found matching '.git*' 17:18:54 INFO - Successfully installed jsonschema functools32 17:18:54 INFO - Cleaning up... 17:18:54 INFO - Return code: 0 17:18:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:18: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')]} 17:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18: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')]} 17:18:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:54 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 0x10c6fca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c70c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae7a589010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c59be00>, '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 0x10c404db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c596b20>, '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.jfa69A3mRL/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.Xnfh5pzcmv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 17:18:54 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 17:18:54 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 17:18:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jfa69A3mRL/Render', 17:18:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:18:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:18:54 INFO - 'HOME': '/Users/cltbld', 17:18:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:18:54 INFO - 'LOGNAME': 'cltbld', 17:18:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:54 INFO - 'MOZ_NO_REMOTE': '1', 17:18:54 INFO - 'NO_EM_RESTART': '1', 17:18:54 INFO - 'PAGER': '/bin/cat', 17:18:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:18:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:54 INFO - 'PWD': '/builds/slave/test', 17:18:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:18:54 INFO - 'SHELL': '/bin/bash', 17:18:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xnfh5pzcmv/Listeners', 17:18:54 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 17:18:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:18:54 INFO - 'USER': 'cltbld', 17:18:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:18:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:18:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:54 INFO - 'XPC_FLAGS': '0x0', 17:18:54 INFO - 'XPC_SERVICE_NAME': '0', 17:18:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:18:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:54 INFO - Downloading/unpacking flake8 17:18:54 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 17:18:54 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 17:18:54 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 17:18:54 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 17:18:54 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 17:18:54 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 17:18:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:18:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:18: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 17:18: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 17:18: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 17:18: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 17:18: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 17:18: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 17:18:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:18:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:18:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:18:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:18:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:18:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:18:58 INFO - no previously-included directories found matching 'docs/_build' 17:18:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:18:58 INFO - Running setup.py install for pep8 17:18:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:18:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:18:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:18:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:18:58 INFO - no previously-included directories found matching 'docs/_build' 17:18:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:18:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:18:58 INFO - Cleaning up... 17:18:58 INFO - Return code: 0 17:18:58 INFO - Running post-action listener: _resource_record_post_action 17:18:58 INFO - Running post-action listener: _start_resource_monitoring 17:18:58 INFO - Starting resource monitoring. 17:18:58 INFO - ##### 17:18:58 INFO - ##### Running install step. 17:18:58 INFO - ##### 17:18:58 INFO - Running pre-action listener: _resource_record_pre_action 17:18:58 INFO - Running main action method: install 17:18:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:18:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:18:58 INFO - Reading from file tmpfile_stdout 17:18:58 INFO - Detecting whether we're running mozinstall >=1.0... 17:18:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:18:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:18:58 INFO - Reading from file tmpfile_stdout 17:18:58 INFO - Output received: 17:18:58 INFO - Usage: mozinstall [options] installer 17:18:58 INFO - Options: 17:18:58 INFO - -h, --help show this help message and exit 17:18:58 INFO - -d DEST, --destination=DEST 17:18:58 INFO - Directory to install application into. [default: 17:18:58 INFO - "/builds/slave/test"] 17:18:58 INFO - --app=APP Application being installed. [default: firefox] 17:18:58 INFO - mkdir: /builds/slave/test/build/application 17:18:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:18:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 17:19:32 INFO - Reading from file tmpfile_stdout 17:19:32 INFO - Output received: 17:19:32 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:19:32 INFO - Running post-action listener: _resource_record_post_action 17:19:32 INFO - ##### 17:19:32 INFO - ##### Running run-tests step. 17:19:32 INFO - ##### 17:19:32 INFO - Running pre-action listener: _resource_record_pre_action 17:19:32 INFO - Running main action method: run_tests 17:19:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:19:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:19:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:19:32 INFO - 2016-04-20 17:19:32.390 screenresolution[1643:8001] starting screenresolution argv=screenresolution get 17:19:32 INFO - 2016-04-20 17:19:32.393 screenresolution[1643:8001] Display 0: 1600x1200x32@60 17:19:32 INFO - 2016-04-20 17:19:32.398 screenresolution[1644:8003] starting screenresolution argv=screenresolution list 17:19:32 INFO - Available Modes on Display 0 17:19:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:19:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:19:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:19:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:19:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:19:32 INFO - Intel Iris: 17:19:32 INFO - Chipset Model: Intel Iris 17:19:32 INFO - Type: GPU 17:19:32 INFO - Bus: Built-In 17:19:32 INFO - VRAM (Dynamic, Max): 1536 MB 17:19:32 INFO - Vendor: Intel (0x8086) 17:19:32 INFO - Device ID: 0x0a2e 17:19:32 INFO - Revision ID: 0x0009 17:19:32 INFO - Displays: 17:19:32 INFO - Display: 17:19:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:19:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:19:32 INFO - Display Serial Number: 1600x1200 60 17:19:32 INFO - Main Display: Yes 17:19:32 INFO - Mirror: Off 17:19:32 INFO - Online: Yes 17:19:32 INFO - Rotation: Supported 17:19:32 INFO - Return code: 0 17:19:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:19:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:19:32 INFO - Python 2.7.3 17:19:32 INFO - Return code: 0 17:19:32 INFO - grabbing minidump binary from tooltool 17:19:32 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')]} 17:19:32 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 0x10c59be00>, '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 0x10c404db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c596b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:19:32 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 17:19:32 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 17:19:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:19:32 INFO - Return code: 0 17:19:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:19:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:19:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:19:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:19:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:19:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:19:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:19:33 INFO - Return code: 0 17:19:33 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-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0071', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:19:33 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-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0071 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:19:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jfa69A3mRL/Render', 17:19:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:19:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:19:33 INFO - 'HOME': '/Users/cltbld', 17:19:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:19:33 INFO - 'LOGNAME': 'cltbld', 17:19:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:19:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:19:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:19:33 INFO - 'MOZ_NO_REMOTE': '1', 17:19:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:19:33 INFO - 'NO_EM_RESTART': '1', 17:19:33 INFO - 'PAGER': '/bin/cat', 17:19:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:19:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:19:33 INFO - 'PWD': '/builds/slave/test', 17:19:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:19:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:19:33 INFO - 'SHELL': '/bin/bash', 17:19:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xnfh5pzcmv/Listeners', 17:19:33 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 17:19:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:19:33 INFO - 'USER': 'cltbld', 17:19:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:19:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:19:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:19:33 INFO - 'XPC_FLAGS': '0x0', 17:19:33 INFO - 'XPC_SERVICE_NAME': '0', 17:19:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:19:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0071', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:19:34 INFO - mozversion application_buildid: 20160420145812 17:19:34 INFO - mozversion application_changeset: a6623a30d98d63a54ac754b28e55e986643e6c93 17:19:34 INFO - mozversion application_display_name: Nightly 17:19:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:19:34 INFO - mozversion application_name: Firefox 17:19:34 INFO - mozversion application_remotingname: firefox 17:19:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:19:34 INFO - mozversion application_vendor: Mozilla 17:19:34 INFO - mozversion application_version: 48.0a1 17:19:34 INFO - mozversion platform_buildid: 20160420145812 17:19:34 INFO - mozversion platform_changeset: a6623a30d98d63a54ac754b28e55e986643e6c93 17:19:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:19:34 INFO - mozversion platform_version: 48.0a1 17:19:34 INFO - using testdate: 1461197974 17:19:34 INFO - actual date: 1461197974 17:19:34 INFO - starting webserver on 'localhost:49276' 17:19:34 INFO - SUITE-START | Running 2 tests 17:19:34 INFO - TEST-START | dromaeo_css 17:19:34 INFO - operating with platform_type : mac_ 17:19:34 INFO - Initialising browser for dromaeo_css test... 17:19:34 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmpc5Tj3n/profile http://localhost:49276/getInfo.html) 17:19:37 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 17:19:37 INFO - PROCESS | 1662 | colorDepth:24 17:19:37 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 17:19:37 INFO - PROCESS | 1662 | __metrics 17:19:37 ERROR - PROCESS | 1662 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 17:19:37 INFO - TEST-INFO | 1662: exit 0 17:19:37 INFO - Browser initialized. 17:19:37 INFO - Running cycle 1/1 for dromaeo_css test... 17:19:37 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmpc5Tj3n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:19:49 INFO - PROCESS | 1665 | RSS: Main: 247644160 17:19:49 INFO - PROCESS | 1665 | 17:20:39 INFO - PROCESS | 1665 | 1461198039352 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] 17:22:50 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 17:22:51 INFO - PROCESS | 1665 | RSS: Main: 260317184 17:22:51 INFO - PROCESS | 1665 | 17:25:54 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 17:25:54 INFO - PROCESS | 1665 | RSS: Main: 272240640 17:25:54 INFO - PROCESS | 1665 | 17:28:56 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 17:28:57 INFO - PROCESS | 1665 | RSS: Main: 273592320 17:28:57 INFO - PROCESS | 1665 | 17:31:59 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 17:31:59 INFO - PROCESS | 1665 | RSS: Main: 275435520 17:31:59 INFO - PROCESS | 1665 | 17:35:02 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 17:35:03 INFO - PROCESS | 1665 | RSS: Main: 278290432 17:35:03 INFO - PROCESS | 1665 | 17:38:05 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 17:38:05 INFO - PROCESS | 1665 | RSS: Main: 279314432 17:38:05 INFO - PROCESS | 1665 | 17:38:05 INFO - PROCESS | 1665 | __start_tp_report 17:38:05 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 17:38:05 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 17:38:05 INFO - PROCESS | 1665 | |i|pagename|runs| 17:38:05 INFO - PROCESS | 1665 | |0;dojo.html;3297.9340413191735;3477.182862027424;3526.400511912976;3542.256126213495;3593.8562457501685;5751.856203594907;5828.562857785661;5852.414758524151;5909.615874968129;5961.821145365646;5765.884682306351;5859.091840764689;5873.676947767871;5953.821385358436;6038.215032045828;5279.340082489698;5335.626506144552;5374.516293533581;5397.892042159155;5414.648047876895;238.417808946977;5353.063213937565;5401.243825864382;5409.702466364349;5514.751836167362;5366.409694933554;5366.731663416853;5398.109311963541;5398.2712333834825;5407.080796264644;5305.310309659758;5423.430539793304;5440.809571664972;5444.292242008553;5474.507294343488;4391.736495810262;5279.260903473517;5289.259503669489;5365.382980957201;5375.274337964363;5675.233843431125;5745.08078707409;5770.653760774367;5861.677607731573;5872.647641141545;6168.8766224675255;6180.412860778219;6199.132121502993;6276.560640755149;6278.591891527036;6235.282942461584;6265.843353916143;6274.811755647338;6277.7175027123885;6305;5143.408508021551;5856.414358564152;6001.969990150065;6016.578839481194;6019.097135429721;6229.7508099676415;6283.43449089575;6353.428191462698;6354.332795056545;6362.77730279438;6101.908471372933;6131.437835141539;6155.753769849156;6157.230346206724;6161.938380616137;6247.9062814057825;6262.53031022666;6267.905981410283;6288.52836037299;6291.465225455888;6199.256089269316;6230.968845155836;6248.9062664060075;6314.71583778731;6350.364963503705;6203.4416902479;6243.656598887105;6246.656433896089;6283.905741413882;6309.33751956038;5026.949730502722;5057.31726216956;5082.898342033212;5083.974580127149;5086.64393492452;4420.823167073346;4431.556844315543;4562.520935301812;4624.791884365211;4662.997455547006;5924.526037916957;5936.614120082181;6013.128096426081;6025.9096113558335;6055.364186760415;6279.843003924939;6291.213598300213;6299.937000630027;6301.054841773771;6309.14826498426;5845.824625261249;5962.165296858443;5977.581569290108;6052.273727152769;6106.511479081662;5525.198846167364;5530.723463826793;5535.750891209906;5535.916961245504;5545.528630066409;6412.9679351602945;6475.773347932894;6476.4495017924;6491.026346048036;6514.348565143448;6213.471854892385;6236.875262494816;6276.529260305404;6295.9370406297185;6315.652639104709;6413.679316034273;6446.226452825691;6447.580907241015;6481.773137940149;6557.049227862029;5030.421501527371;6338.207724034496;6340.1440805490665;6350.396712312323;6358.554901156875;6213.409726076015;6256.593321434092;6314.589551679126;6316.810495685137;6324.3991820776955;4616.891945933019;5243.793927396644;5413.729313534386;5971.686229029607;6238.906416403667;5026.472220416804;5103.591712663052;6101.5118790497545;6272.2159730033745;6286.622802631857;6064.760996353585;6073.180120683651;6120;6161.476274516716;6168.383161683796;5714.485696287354;6118.174046503665;6222.191115155001;6231.937680623136;6261.092141639346;6071.908921366271;6117.908231376444;6126.884121540821;6203.2556093269095;6208.81373558794 17:38:05 INFO - PROCESS | 1665 | |1;ext.html;519.2341296587532;528.255160224084;534.254714673031;549.3188446326557;602.6113157013724;29192.416151676982;38167.42748858762;38179.42730859039;38418.61581384192;38508.807455962684;40519;41099;41106.38340424889;41161.970950726245;41182.58817411825;8164.7550573482895;9297.907020929806;9514.096160864707;9544.856827147598;9550.761230969212;8150.470219435747;9428.905710942905;9527.09492598202;9669.371490853107;9681.177099946513;9510.429374237534;9616.663416780415;9651.613935442574;9664.4201347919;9689.854652180224;9620.807583848318;9678.854817177747;9707.029297070307;9712.902870971271;9727.708168754949;9497.24022078239;9556.522173891277;9588.232941364675;9676.080772326617;9696.46669433181;39401;39768;39805.20389592221;39839.40240896389;39874.60752354868;2618.332325257047;2884.7259510346485;2889.6965818589165;3057.5260834570677;3147.905562833119;25677.358066048313;25780;25838.74161258382;26583.867080664666;26592.069277575385;2499.212747984379;2625.2649258207734;2626.304029432202;2626.54035543781;2673.131232349475;392223;393175;394853;395175;395952.99999999715;34159.48760768591;34647.65352346495;34696.13259668478;34731.4790278146;35288.64711352905;34074.829625851715;34781.9565413038;35577.8221108898;35711.64288357135;35781.64218357783;15017.849821501644;15278.618034549003;15285.465008724863;15293.317735049135;15305.00517466361;12972.545960891512;12976.221426714239;12978.675533111747;12987.480500779862;13115.081944264;7152.642367881585;8124.959375203086;8130.512169269863;8224.218699223564;8270.8345833083;3410.3349846780134;3417.6069751978343;3440.82795860206;3449.6032956209856;3474.965250347515;981.4454833019321;1092.4974511724695;1101.146611376174;1133.3709791065874;1167.7080729817546;30121.548176777367;30167.245818854703;30599.388012240077;30625;31502.84248578788;1003.9397636141855;1031.7317497450717;1066.7919755647574;1096.4682129167347;1153.5270539079106;14229.075110117808;15052.54842354731;15080.622984425478;15297.694046119015;15382.153981530899;605914;622451;622848;623882;627111;60526.69736651288;60785.696071520244;61253.38746612477;61312.69343653253;61594.69202653958;1427.150845247097;1458.7593047147313;1483.9183844888635;1489.508462207469;1494.7757836324638;26806.525641089927;29868.253293667833;30156.246093846952;30629.846850765603;31066.68933310638;58210.70894645499;58218;59554.70222648859;59666.40333596782;59766.10350844828;484893;575520;576812.5071870483;581015;582281;41367.29395529409;42486.36270455884;42573.787131065386;42680.5731942689;43425.782871085445;43272;43345.133097337246;44054.3391849129;44748.55251447574;44772;36123.63876361308;36350;36451.81774091112;36762.448563271035;37159.071023224635;37185.628143719296;40708.38937415882;41188;41358.759237222934;41863.37204941989;37140.88577342684;38217.617823821405;39969.00077498086;40206.798966004986;40599;37705.81147094247;39018;39481;40474.797626011685;41439;30324.393512130075;30361;30418.39163216679;30472.542911855897;30818.38363232678 17:38:05 INFO - PROCESS | 1665 | |2;jquery.html;398.53172522286326;402.3702904953749;403.326444837122;403.84250142444444;412.50499400719127;19645.31241406551;20385.388438346836;21017.159313627457;21140.89429552852;21490;18313.626478014136;19810.801891981075;20221.898890505527;20345.084471198796;20585.485362865897;4943.9258411123865;5253.763580638881;5276.970990656823;5440.863978400552;5520.530754885839;3912.158885839544;4874.902501949959;5400.594955378343;5466.453354664522;6015.518758499309;5934.1098835174635;6142.8464288392925;6150.6924653767355;6155.784547540837;6156.076588511714;4731.36126622905;5571.470710282537;5971.880562388771;6039.969800150993;6094.207752992105;4393.428854248959;4920.6801557898625;5704.087346024658;6046.516278697693;6088.117223002684;13517.391717372742;13712.520061797888;13765.587032389045;14156.50452234167;20534;2014.9597008059757;2044.2436298569623;2097.5385415208784;2102.8948552572465;2157.6224160771803;8224.917750822475;9967.90032099677;10248.436336001518;12033.51865925362;14281.285935703174;1672.5066105498906;1753.36002359138;1758.7361895715617;1761.1810508113788;1789.973150402745;113011;115809;116311.41844290809;119367.40316298362;121636;11540.94229528847;11550.537978480934;11792.646220613395;11823.408829558488;12399.876001240053;15154.787616990614;15254.618634534225;15271.541853744406;15278.770818437732;15348.23258837076;8842.646294148162;8912.688055918012;8916.73249802507;8918.331125165509;9036.186743193144;7130.429565634737;8731.388802783871;8815.955920220485;8913.732588022369;8950;4623.398958135421;4668.953310466852;4673.929891051637;4708.105459962596;4735.810567577328;1893.7916829148783;1958.5005823515198;1977.159707124495;2053.774084850665;2056.5784014277037;811.8213992921548;897.2507955856802;931.5109567477128;1044.185535282481;1066.5627092891878;19727.40817775469;20661.690074648894;20877.26929557458;20936.43014702214;20967.47581310449;937.9390339627903;959.8704174936295;978.1196922769565;1042.207921979301;1058.751193469534;10384.42885641297;10647.680569582924;10945.233833631728;10959.780804383867;10984.176186786022;253055;253737.19394209102;533637;602230;615800;110423.44788276168;126450.20649380534;128272;130542.34728826296;132024;1024.2215915903967;1031.6853359725355;1061.2518174686827;1064.0423618743193;1076.9515371808288;14459.638509036937;17095.059771712677;18245;18349.08254587292;18377.90811045936;48809.5119048805;52527.737361312946;53470.465295348105;54371.912561749334;54474.727626361615;77783.61108194423;78095.65713028618;79563.60218198872;79811.60094199491;81724;6062.939370606237;7171.426285897011;7200.639968001684;7421.3691836192365;7769.689212431439;11252.887471125512;11849.229800062969;11866.762664746484;12108.939455302667;12513.562025329069;9872.851907221253;10417.791644167226;10533.104686101768;10895.400752958663;11076.833847492455;8727.432716873636;9619.27855410833;10726.302790318605;10733.731656708333;10871.565137394417;10905;11014.39420831862;11033.337999720043;11203.943980280046;11339.036181924628;8073.273405393543;8196.713115040944;8259.917400825914;8302.128276530877;8448.577571121543;10491.580336786443;11040.447977601249;11080.889191107986;11155.498002590066;11213.439328033728 17:38:05 INFO - PROCESS | 1665 | |3;mootools.html;1606.3735143294114;1612.8467795559422;1902.2961504243433;1990.6217818614462;1994.8005199480062;7919.7624071277805;8530.146985301466;8670.73987780366;8902.955485222581;8943.821123577525;8544.615492302846;8593.785155371119;8713.477191368522;8727.738167854974;8733.475991440519;2425.6240282756203;2474.035126300744;2478.429961108946;2481.2928315430104;2488.029668429305;2413.336332508565;2443.2425947956103;2448.167623008177;2448.4490989527303;2487.2289590227088;2088.342172215755;2447.070113356922;2465.9753402466013;2469.2098528470897;2492.8130390220717;2410.3371572817614;2411.409204744831;2414.0343862454984;2451.4361696809747;2461.965974290802;2099.9475013124643;2434.6591477193206;2443.2792326263616;2467;2467.8272520923542;8763.693270735557;8796.780080498038;8808.515531645757;8810;8810.38327317088;5257.579393648499;5430.864228394283;5437.864053398657;5452.345718513764;5482.780688772445;2998.055612482061;3526.453399723047;3564.82175891207;3579.427291633326;3644.471551625026;1031.6073301043607;1050.7058023753361;1054.9841752373643;1069.9518521666544;1075.542894269932;11490.36802975836;11507.597234096851;11665.825012624817;11701;11725.472353744102;3885.3589157789215;4732.100900828831;4806.086843499724;4950.727709975986;4959.950400496021;10102.848457273147;10117.494125293706;10161.136303414292;10193.490325483695;10201.489925503844;5415.296011518478;5442.6462279951675;5445.319335083114;5472.671639701631;5503.779848806083;3986.5216174059296;4420.381146639473;4946.554810067111;5012.172991456368;5044.016416798689;3328.700416962485;3867.0719027433215;4052.2908491013955;4069.4148259738436;4188.727732697365;1340.7251513439721;1369.137443410645;1371.8422381426265;1374.1411617738913;1383.5157694806737;659.350539718377;816.5917041479261;901.9233365164034;911.2300106410073;940.3370623710268;5636.915446268309;5865;5889.204957330706;5907.409259074144;5996.920554300268;998.006983051868;1001.3841487485145;1006.4665727164614;1011.8077565262577;1011.8482227665762;3496.8251587421037;3739.6634302912867;3869.032741814546;3871.032241939515;3933.7639741615594;10428.791424171473;10493.790124197474;10856.511456984455;10869.293495922899;10953;10855.67432977012;10868.945655271831;10878.238523303293;10886.129109671207;10920.2901811382;8157.265846073882;8181.509109453333;8256.545889975989;8275;8360.874586881202;5722.055860782924;5813.186153938536;5826.533877289891;5837.182794408871;5905.734241959208;9851.802963940825;9898.158656514277;10143.746406339606;10192.847107293544;10208.846867296848;9910.851337229804;10127.89872101299;10292.330998485075;10299.691009269434;10312.793744125225;6393.776217832354;6629;6872;6914.446844252348;7052.506324557232;8215.507069575844;8235.95882020586;8316.62575184106;8321.916780832114;8328.417010809186;7280.490365674352;7303.342699157101;7436.144843342869;7491.9625401872645;7649.617519124133;7312.15910170316;7315.926840731525;7365.926340736524;7409.518381305198;7461.4030877528585;7021.368076873106;7027;7122.60825654594;7132.607706576188;7150.356467917913;4677.228257337501;4757.4062688999575;4861.222204447272;4932.679375840702;5075.365579302587;4877.146499362669;4923.236898280772;4954.9752251238515;4968.205087186033;5107.233914912793 17:38:05 INFO - PROCESS | 1665 | |4;prototype.html;319.39315300928234;321.58194347348456;328.6040321412698;328.70745036917134;333.899830050985;4665;5113.51421614947;5384.973075134629;5576;6198.504119670427;5186.481351864812;6208.441240288374;6275.278342990558;6280.371962803717;6283.057541368786;4388.639521748269;4409.603135717777;4545.250033744444;4666.570070997814;4701.318308845215;4063.674906007527;4584.793684284198;4665.533446655324;4686.554777296152;4701.976490117561;4036.1725846201457;4356.607905288523;4444.444444444444;4583.8998640326245;4669.066186762644;4296.419983302246;4589.954100458986;4594.471635761896;4620.861374158781;4633.698809577367;3886.980565097185;3908.55051669056;3920.3923391874305;3930;3930.8034598269974;5157.7936882524655;5214.374275086976;5831.416858314177;6061.3029501607;6064.028061619646;4568.383268258809;5162.199859021857;5248.53041148479;5326.866828329284;5351.812686555991;5724.713764311768;5762.423757624246;6560.114384558071;6561.3438656134485;6575.178102737158;3650.361186792301;4023.195360927826;4206.26390381685;4350.564943505656;4351.0862718829085;6508.479321654257;6662.86674266512;6912.239653638096;7062.54093483927;7150.785476435715;3813.779590531059;4335.934960975588;4445.555444455593;4451.330750968387;4459.487158976759;3910.3743401056263;3993.4608827807874;4331.155424692155;4494.955050449519;4511.751853648016;5341.278927344836;5346.358436987509;5356.035913535601;5367.919481207785;5373.731313434391;6352.618842869442;6697.866042679217;6707.798766037026;6711.255073680781;6754.797356079227;1363.8431580368185;1491.9328630211667;1534.8388419216044;1549.3492733052144;1551.7905082813675;917.6604656277086;967.5936106835146;985.6648739428629;998.6119294181094;1003.8243307421172;5368.8657783554945;6063.81755557662;6197.752089916353;6226.097215903759;6229.127922090911;6357.760236753788;6612.206535215805;6818.454523638097;6876.381125698711;6924.688389022506;4875.146849301358;5667.319921609434;5841.707914604252;6177.62934223948;6239.563230573907;2925.590417341574;3164.3829453256853;3600.837962291703;3626.8549258029384;3657.9451308230396;6701.2189941173865;6850.691718872663;6927.480438967098;7370.815729606696;7394.297541733635;6167.515353825074;7134.464915131386;7210.170830354471;7262.527935684164;7311.341979221896;6621.748605474162;6981.860362792817;7267.238449389199;7288.890666640004;7393.334599886036;6968.895466567904;6994.370506654425;7012.1935977363255;7034.311765176423;7049;6663.300353463011;6840.965795170992;6868.828279292858;6915.239323674492;6925.68834402443;7208.855822883408;7317.000029987679;7318.890216646861;7324.707011719472;7329.230430804689;4167.2082304362075;4396.142752163298;4439.334099885043;4474.888127796831;4483.574060464251;6860.348266914635;6869.896951545631;6879.862402752017;6930.3961939790015;6955.513114081966;6288.748450061947;6454.031520386327;6688.230853451721;6741.629210393476;6747.291534388818;5816.604015036445;6425;6662.267150613332;6670.066190733204;6678.666066696743;6231.532635052298;6327.746890124344;6529.67351632407;6533.8693226136165;6560.245571759308;6638.601683898982;6707.262201157966;6726.495512836459;6745.4266387355665;6756.358145976124;4778.928316075192;6551.624158926679;6568.277489476058;6586;6649.63427011519 17:38:05 INFO - PROCESS | 1665 | |5;yui.html;666.167290886392;676.7056330496234;692.6502116431202;725.4160400877291;743.8809790433528;14718;14803.481878134267;14929.626759331022;14994.47519336822;15005.774913376308;13455.73088538231;13921.860781392208;13928.860711392883;13958.302084895766;13988.510402135928;751.6016511249047;914.7438717159206;936.2182577547738;943.9292053096011;952.9523523823816;939.037486576258;942.0626476655738;943.6084025129563;943.7923656795494;945.6926498887855;955.9187469065138;987.1017374189489;994.1698681600872;1000.7548150703088;1002.1381611813835;967.7241986033981;986.4081551069373;989.0653332600731;992.6376872441579;993.6472552243922;709.7799682098566;718.8526352097807;724.9275072492761;747.3236720767713;748.1620584944897;15057.472988445461;15135.545933622008;15212.011219270822;15212.847871521253;15215.847841521554;10383.376997380181;12455;12595.685107872285;12623.305718185497;12769.744605107939;9638.566264518113;9683.467409292556;9866.210703143803;9976.451295178835;9979.850302245472;3406.8296585170892;3429.8285085745615;3469.809160496172;3479.1823921378455;3509.1051781795477;54664.18003729947;78172;78513.21486785173;78544.60727696324;83855;9391.248700104112;9465.148136667594;9626.326157169071;9708.611655533841;10087.899121008842;19147.71278430797;21533.67699484509;21536.138554457648;21558.784412155677;21597.784022159893;7637.732679356307;7699.576523291273;7766.865270988429;7883.881741773878;8010.599470026592;4111.938320925188;4123.690723195712;4134.607212314825;4142.5857414258335;4172.895677608084;3598.946015809765;3692.040069581928;3705.6109108543756;3705.7591256568235;3729.3473642113063;667.0760996020449;672.1329484964439;680.904673345732;682.0928165539821;683.1904193530683;532.3691425660604;562.5752556819657;594.3759052994425;594.4145017158096;618.4217756397693;7923.16806735296;7994.80012999668;8003.31971782405;8143.104258531557;8195.34437245019;557.5288880895637;586.1237450012259;593.4540222994855;600.441589321926;608.8796614229839;3716.832742526593;3844.750091244116;3907.433422153772;3999.1801680655394;4061.2080644274083;88157;89311.21377572411;90364;90712.09287907036;90761;64047.67976160089;67296.32703672901;76521.17394130271;77928.05179870436;78406;68987.31012689808;69704.3991309371;69923.60152796915;69947.95078073833;69968.60062798817;7018.5788852669;7551.320381165721;7701.075870895528;7722.111957125003;7832.608369581612;29052.128436146948;34642.9214247146;41322.58677413307;41376.96557586084;42064.36903446512;40225.99435014148;55422;57058.7147064262;57346;58354.7082264586;9828.606855725691;9878.209743220381;9920.751981200528;10193.898061019296;10230.693079207636;10654.946725266323;10696.090832279344;10857.83713244286;10870.347779133277;11630.33227382273;9953.502324883872;10097.949510252402;10282.794344112926;10369.688909332732;10572.36565806054;10047.09576138151;10061.446620435947;10310;10472.424016679155;10516.316439431412;9960.1533869619;10417.374957502574;10430.843537347098;10497.632582859564;10522.210834187314;8445.577721114043;8726.956365218133;8746.693865714924;8795.076516965883;8837.513936733541;9102.362834601514;9503.287253455881;9865.704028879145;9922.553485093333;10066.748331291776 17:38:05 INFO - PROCESS | 1665 | __end_tp_report 17:38:05 INFO - PROCESS | 1665 | __start_cc_report 17:38:05 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,392 17:38:05 INFO - PROCESS | 1665 | __end_cc_report 17:38:05 INFO - PROCESS | 1665 | __startTimestamp1461199085806__endTimestamp 17:38:05 INFO - PROCESS | 1665 | 17:38:05 INFO - PROCESS | 1665 | ------- Summary: start ------- 17:38:05 INFO - PROCESS | 1665 | Number of tests: 6 17:38:05 INFO - PROCESS | 1665 | 17:38:05 INFO - PROCESS | 1665 | [#0] dojo.html Cycles:165 Average:5784.96 Median:6064.76 stddev:774.96 (12.8%) stddev-sans-first:752.38 17:38:05 INFO - PROCESS | 1665 | Values: 3297.9 3477.2 3526.4 3542.3 3593.9 5751.9 5828.6 5852.4 5909.6 5961.8 5765.9 5859.1 5873.7 5953.8 6038.2 5279.3 5335.6 5374.5 5397.9 5414.6 238.4 5353.1 5401.2 5409.7 5514.8 5366.4 5366.7 5398.1 5398.3 5407.1 5305.3 5423.4 5440.8 5444.3 5474.5 4391.7 5279.3 5289.3 5365.4 5375.3 5675.2 5745.1 5770.7 5861.7 5872.6 6168.9 6180.4 6199.1 6276.6 6278.6 6235.3 6265.8 6274.8 6277.7 6305.0 5143.4 5856.4 6002.0 6016.6 6019.1 6229.8 6283.4 6353.4 6354.3 6362.8 6101.9 6131.4 6155.8 6157.2 6161.9 6247.9 6262.5 6267.9 6288.5 6291.5 6199.3 6231.0 6248.9 6314.7 6350.4 6203.4 6243.7 6246.7 6283.9 6309.3 5026.9 5057.3 5082.9 5084.0 5086.6 4420.8 4431.6 4562.5 4624.8 4663.0 5924.5 5936.6 6013.1 6025.9 6055.4 6279.8 6291.2 6299.9 6301.1 6309.1 5845.8 5962.2 5977.6 6052.3 6106.5 5525.2 5530.7 5535.8 5535.9 5545.5 6413.0 6475.8 6476.4 6491.0 6514.3 6213.5 6236.9 6276.5 6295.9 6315.7 6413.7 6446.2 6447.6 6481.8 6557.0 5030.4 6338.2 6340.1 6350.4 6358.6 6213.4 6256.6 6314.6 6316.8 6324.4 4616.9 5243.8 5413.7 5971.7 6238.9 5026.5 5103.6 6101.5 6272.2 6286.6 6064.8 6073.2 6120.0 6161.5 6168.4 5714.5 6118.2 6222.2 6231.9 6261.1 6071.9 6117.9 6126.9 6203.3 6208.8 17:38:05 INFO - PROCESS | 1665 | 17:38:05 INFO - PROCESS | 1665 | [#1] ext.html Cycles:180 Average:65368.04 Median:216288.00 stddev:142844.49 (66.0%) stddev-sans-first:143162.23 17:38:05 INFO - PROCESS | 1665 | Values: 519.2 528.3 534.3 549.3 602.6 29192.4 38167.4 38179.4 38418.6 38508.8 40519.0 41099.0 41106.4 41162.0 41182.6 8164.8 9297.9 9514.1 9544.9 9550.8 8150.5 9428.9 9527.1 9669.4 9681.2 9510.4 9616.7 9651.6 9664.4 9689.9 9620.8 9678.9 9707.0 9712.9 9727.7 9497.2 9556.5 9588.2 9676.1 9696.5 39401.0 39768.0 39805.2 39839.4 39874.6 2618.3 2884.7 2889.7 3057.5 3147.9 25677.4 25780.0 25838.7 26583.9 26592.1 2499.2 2625.3 2626.3 2626.5 2673.1 392223.0 393175.0 394853.0 395175.0 395953.0 34159.5 34647.7 34696.1 34731.5 35288.6 34074.8 34782.0 35577.8 35711.6 35781.6 15017.8 15278.6 15285.5 15293.3 15305.0 12972.5 12976.2 12978.7 12987.5 13115.1 7152.6 8125.0 8130.5 8224.2 8270.8 3410.3 3417.6 3440.8 3449.6 3475.0 981.4 1092.5 1101.1 1133.4 1167.7 30121.5 30167.2 30599.4 30625.0 31502.8 1003.9 1031.7 1066.8 1096.5 1153.5 14229.1 15052.5 15080.6 15297.7 15382.2 605914.0 622451.0 622848.0 623882.0 627111.0 60526.7 60785.7 61253.4 61312.7 61594.7 1427.2 1458.8 1483.9 1489.5 1494.8 26806.5 29868.3 30156.2 30629.8 31066.7 58210.7 58218.0 59554.7 59666.4 59766.1 484893.0 575520.0 576812.5 581015.0 582281.0 41367.3 42486.4 42573.8 42680.6 43425.8 43272.0 43345.1 44054.3 44748.6 44772.0 36123.6 36350.0 36451.8 36762.4 37159.1 37185.6 40708.4 41188.0 41358.8 41863.4 37140.9 38217.6 39969.0 40206.8 40599.0 37705.8 39018.0 39481.0 40474.8 41439.0 30324.4 30361.0 30418.4 30472.5 30818.4 17:38:05 INFO - PROCESS | 1665 | 17:38:05 INFO - PROCESS | 1665 | [#2] jquery.html Cycles:180 Average:30503.92 Median:20906.85 stddev:81817.44 (391.3%) stddev-sans-first:82015.73 17:38:05 INFO - PROCESS | 1665 | Values: 398.5 402.4 403.3 403.8 412.5 19645.3 20385.4 21017.2 21140.9 21490.0 18313.6 19810.8 20221.9 20345.1 20585.5 4943.9 5253.8 5277.0 5440.9 5520.5 3912.2 4874.9 5400.6 5466.5 6015.5 5934.1 6142.8 6150.7 6155.8 6156.1 4731.4 5571.5 5971.9 6040.0 6094.2 4393.4 4920.7 5704.1 6046.5 6088.1 13517.4 13712.5 13765.6 14156.5 20534.0 2015.0 2044.2 2097.5 2102.9 2157.6 8224.9 9967.9 10248.4 12033.5 14281.3 1672.5 1753.4 1758.7 1761.2 1790.0 113011.0 115809.0 116311.4 119367.4 121636.0 11540.9 11550.5 11792.6 11823.4 12399.9 15154.8 15254.6 15271.5 15278.8 15348.2 8842.6 8912.7 8916.7 8918.3 9036.2 7130.4 8731.4 8816.0 8913.7 8950.0 4623.4 4669.0 4673.9 4708.1 4735.8 1893.8 1958.5 1977.2 2053.8 2056.6 811.8 897.3 931.5 1044.2 1066.6 19727.4 20661.7 20877.3 20936.4 20967.5 937.9 959.9 978.1 1042.2 1058.8 10384.4 10647.7 10945.2 10959.8 10984.2 253055.0 253737.2 533637.0 602230.0 615800.0 110423.4 126450.2 128272.0 130542.3 132024.0 1024.2 1031.7 1061.3 1064.0 1077.0 14459.6 17095.1 18245.0 18349.1 18377.9 48809.5 52527.7 53470.5 54371.9 54474.7 77783.6 78095.7 79563.6 79811.6 81724.0 6062.9 7171.4 7200.6 7421.4 7769.7 11252.9 11849.2 11866.8 12108.9 12513.6 9872.9 10417.8 10533.1 10895.4 11076.8 8727.4 9619.3 10726.3 10733.7 10871.6 10905.0 11014.4 11033.3 11203.9 11339.0 8073.3 8196.7 8259.9 8302.1 8448.6 10491.6 11040.4 11080.9 11155.5 11213.4 17:38:05 INFO - PROCESS | 1665 | 17:38:05 INFO - PROCESS | 1665 | [#3] mootools.html Cycles:180 Average:5721.27 Median:4744.75 stddev:3196.95 (67.4%) stddev-sans-first:3190.97 17:38:05 INFO - PROCESS | 1665 | Values: 1606.4 1612.8 1902.3 1990.6 1994.8 7919.8 8530.1 8670.7 8903.0 8943.8 8544.6 8593.8 8713.5 8727.7 8733.5 2425.6 2474.0 2478.4 2481.3 2488.0 2413.3 2443.2 2448.2 2448.4 2487.2 2088.3 2447.1 2466.0 2469.2 2492.8 2410.3 2411.4 2414.0 2451.4 2462.0 2099.9 2434.7 2443.3 2467.0 2467.8 8763.7 8796.8 8808.5 8810.0 8810.4 5257.6 5430.9 5437.9 5452.3 5482.8 2998.1 3526.5 3564.8 3579.4 3644.5 1031.6 1050.7 1055.0 1070.0 1075.5 11490.4 11507.6 11665.8 11701.0 11725.5 3885.4 4732.1 4806.1 4950.7 4960.0 10102.8 10117.5 10161.1 10193.5 10201.5 5415.3 5442.6 5445.3 5472.7 5503.8 3986.5 4420.4 4946.6 5012.2 5044.0 3328.7 3867.1 4052.3 4069.4 4188.7 1340.7 1369.1 1371.8 1374.1 1383.5 659.4 816.6 901.9 911.2 940.3 5636.9 5865.0 5889.2 5907.4 5996.9 998.0 1001.4 1006.5 1011.8 1011.8 3496.8 3739.7 3869.0 3871.0 3933.8 10428.8 10493.8 10856.5 10869.3 10953.0 10855.7 10868.9 10878.2 10886.1 10920.3 8157.3 8181.5 8256.5 8275.0 8360.9 5722.1 5813.2 5826.5 5837.2 5905.7 9851.8 9898.2 10143.7 10192.8 10208.8 9910.9 10127.9 10292.3 10299.7 10312.8 6393.8 6629.0 6872.0 6914.4 7052.5 8215.5 8236.0 8316.6 8321.9 8328.4 7280.5 7303.3 7436.1 7492.0 7649.6 7312.2 7315.9 7365.9 7409.5 7461.4 7021.4 7027.0 7122.6 7132.6 7150.4 4677.2 4757.4 4861.2 4932.7 5075.4 4877.1 4923.2 4955.0 4968.2 5107.2 17:38:05 INFO - PROCESS | 1665 | 17:38:05 INFO - PROCESS | 1665 | [#4] prototype.html Cycles:180 Average:5352.33 Median:6172.57 stddev:1751.60 (28.4%) stddev-sans-first:1715.29 17:38:05 INFO - PROCESS | 1665 | Values: 319.4 321.6 328.6 328.7 333.9 4665.0 5113.5 5385.0 5576.0 6198.5 5186.5 6208.4 6275.3 6280.4 6283.1 4388.6 4409.6 4545.3 4666.6 4701.3 4063.7 4584.8 4665.5 4686.6 4702.0 4036.2 4356.6 4444.4 4583.9 4669.1 4296.4 4590.0 4594.5 4620.9 4633.7 3887.0 3908.6 3920.4 3930.0 3930.8 5157.8 5214.4 5831.4 6061.3 6064.0 4568.4 5162.2 5248.5 5326.9 5351.8 5724.7 5762.4 6560.1 6561.3 6575.2 3650.4 4023.2 4206.3 4350.6 4351.1 6508.5 6662.9 6912.2 7062.5 7150.8 3813.8 4335.9 4445.6 4451.3 4459.5 3910.4 3993.5 4331.2 4495.0 4511.8 5341.3 5346.4 5356.0 5367.9 5373.7 6352.6 6697.9 6707.8 6711.3 6754.8 1363.8 1491.9 1534.8 1549.3 1551.8 917.7 967.6 985.7 998.6 1003.8 5368.9 6063.8 6197.8 6226.1 6229.1 6357.8 6612.2 6818.5 6876.4 6924.7 4875.1 5667.3 5841.7 6177.6 6239.6 2925.6 3164.4 3600.8 3626.9 3657.9 6701.2 6850.7 6927.5 7370.8 7394.3 6167.5 7134.5 7210.2 7262.5 7311.3 6621.7 6981.9 7267.2 7288.9 7393.3 6968.9 6994.4 7012.2 7034.3 7049.0 6663.3 6841.0 6868.8 6915.2 6925.7 7208.9 7317.0 7318.9 7324.7 7329.2 4167.2 4396.1 4439.3 4474.9 4483.6 6860.3 6869.9 6879.9 6930.4 6955.5 6288.7 6454.0 6688.2 6741.6 6747.3 5816.6 6425.0 6662.3 6670.1 6678.7 6231.5 6327.7 6529.7 6533.9 6560.2 6638.6 6707.3 6726.5 6745.4 6756.4 4778.9 6551.6 6568.3 6586.0 6649.6 17:38:05 INFO - PROCESS | 1665 | 17:38:05 INFO - PROCESS | 1665 | [#5] yui.html Cycles:180 Average:16975.54 Median:32356.92 stddev:23843.31 (73.7%) stddev-sans-first:23878.75 17:38:05 INFO - PROCESS | 1665 | Values: 666.2 676.7 692.7 725.4 743.9 14718.0 14803.5 14929.6 14994.5 15005.8 13455.7 13921.9 13928.9 13958.3 13988.5 751.6 914.7 936.2 943.9 953.0 939.0 942.1 943.6 943.8 945.7 955.9 987.1 994.2 1000.8 1002.1 967.7 986.4 989.1 992.6 993.6 709.8 718.9 724.9 747.3 748.2 15057.5 15135.5 15212.0 15212.8 15215.8 10383.4 12455.0 12595.7 12623.3 12769.7 9638.6 9683.5 9866.2 9976.5 9979.9 3406.8 3429.8 3469.8 3479.2 3509.1 54664.2 78172.0 78513.2 78544.6 83855.0 9391.2 9465.1 9626.3 9708.6 10087.9 19147.7 21533.7 21536.1 21558.8 21597.8 7637.7 7699.6 7766.9 7883.9 8010.6 4111.9 4123.7 4134.6 4142.6 4172.9 3598.9 3692.0 3705.6 3705.8 3729.3 667.1 672.1 680.9 682.1 683.2 532.4 562.6 594.4 594.4 618.4 7923.2 7994.8 8003.3 8143.1 8195.3 557.5 586.1 593.5 600.4 608.9 3716.8 3844.8 3907.4 3999.2 4061.2 88157.0 89311.2 90364.0 90712.1 90761.0 64047.7 67296.3 76521.2 77928.1 78406.0 68987.3 69704.4 69923.6 69948.0 69968.6 7018.6 7551.3 7701.1 7722.1 7832.6 29052.1 34642.9 41322.6 41377.0 42064.4 40226.0 55422.0 57058.7 57346.0 58354.7 9828.6 9878.2 9920.8 10193.9 10230.7 10654.9 10696.1 10857.8 10870.3 11630.3 9953.5 10097.9 10282.8 10369.7 10572.4 10047.1 10061.4 10310.0 10472.4 10516.3 9960.2 10417.4 10430.8 10497.6 10522.2 8445.6 8727.0 8746.7 8795.1 8837.5 9102.4 9503.3 9865.7 9922.6 10066.7 17:38:05 INFO - PROCESS | 1665 | -------- Summary: end -------- 17:38:05 INFO - PROCESS | 1665 | 17:38:06 INFO - TEST-INFO | 1665: exit 0 17:38:06 INFO - TEST-OK | dromaeo_css | took 1112348ms 17:38:06 INFO - TEST-START | kraken 17:38:06 INFO - operating with platform_type : mac_ 17:38:06 INFO - Initialising browser for kraken test... 17:38:06 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmpephJDq/profile http://localhost:49276/getInfo.html) 17:38:09 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 17:38:09 INFO - PROCESS | 1675 | colorDepth:24 17:38:09 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 17:38:09 INFO - PROCESS | 1675 | __metrics 17:38:09 ERROR - PROCESS | 1675 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 17:38:10 INFO - TEST-INFO | 1675: exit 0 17:38:10 INFO - Browser initialized. 17:38:10 INFO - Running cycle 1/1 for kraken test... 17:38:10 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmpephJDq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:38:21 INFO - PROCESS | 1678 | RSS: Main: 248029184 17:38:21 INFO - PROCESS | 1678 | 17:38:24 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 17:38:25 INFO - PROCESS | 1678 | RSS: Main: 260042752 17:38:25 INFO - PROCESS | 1678 | 17:38:28 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 17:38:28 INFO - PROCESS | 1678 | RSS: Main: 269107200 17:38:28 INFO - PROCESS | 1678 | 17:38:32 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 17:38:33 INFO - PROCESS | 1678 | RSS: Main: 272306176 17:38:33 INFO - PROCESS | 1678 | 17:38:34 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 17:38:35 INFO - PROCESS | 1678 | RSS: Main: 273100800 17:38:35 INFO - PROCESS | 1678 | 17:38:37 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:38:38 INFO - PROCESS | 1678 | RSS: Main: 274837504 17:38:38 INFO - PROCESS | 1678 | 17:38:41 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 17:38:41 INFO - PROCESS | 1678 | RSS: Main: 274788352 17:38:41 INFO - PROCESS | 1678 | 17:38:44 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 17:38:45 INFO - PROCESS | 1678 | RSS: Main: 274833408 17:38:45 INFO - PROCESS | 1678 | 17:38:48 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 17:38:49 INFO - PROCESS | 1678 | RSS: Main: 275312640 17:38:49 INFO - PROCESS | 1678 | 17:38:50 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:38:51 INFO - PROCESS | 1678 | RSS: Main: 274825216 17:38:51 INFO - PROCESS | 1678 | 17:38:53 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:38:53 INFO - PROCESS | 1678 | RSS: Main: 274960384 17:38:53 INFO - PROCESS | 1678 | 17:38:55 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:38:56 INFO - PROCESS | 1678 | RSS: Main: 275230720 17:38:56 INFO - PROCESS | 1678 | 17:38:59 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:39:00 INFO - PROCESS | 1678 | RSS: Main: 275292160 17:39:00 INFO - PROCESS | 1678 | 17:39:03 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:39:03 INFO - PROCESS | 1678 | RSS: Main: 275251200 17:39:03 INFO - PROCESS | 1678 | 17:39:05 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 17:39:06 INFO - PROCESS | 1678 | RSS: Main: 276922368 17:39:06 INFO - PROCESS | 1678 | 17:39:06 INFO - PROCESS | 1678 | __start_tp_report 17:39:06 INFO - PROCESS | 1678 | _x_x_mozilla_page_load 17:39:06 INFO - PROCESS | 1678 | _x_x_mozilla_page_load_details 17:39:06 INFO - PROCESS | 1678 | |i|pagename|runs| 17:39:06 INFO - PROCESS | 1678 | |0;ai-astar;116;111;169;119;118;131;125;170;122;131 17:39:06 INFO - PROCESS | 1678 | |1;audio-beat-detection;196;135;149;168;138;140;144;151;159;106 17:39:06 INFO - PROCESS | 1678 | |2;audio-dft;196;195;209;237;197;196;205;193;280;283 17:39:06 INFO - PROCESS | 1678 | |3;audio-fft;67;79;72;133;56;59;65;61;77;56 17:39:06 INFO - PROCESS | 1678 | |4;audio-oscillator;80;79;122;78;83;84;121;81;80;118 17:39:06 INFO - PROCESS | 1678 | |5;imaging-gaussian-blur;88;102;88;85;89;85;88;87;88;101 17:39:06 INFO - PROCESS | 1678 | |6;imaging-darkroom;94;95;94;95;111;150;124;95;124;154 17:39:06 INFO - PROCESS | 1678 | |7;imaging-desaturate;126;140;97;111;130;90;85;148;151;91 17:39:06 INFO - PROCESS | 1678 | |8;json-parse-financial;62;63;61;62;62;61;62;75;64;61 17:39:06 INFO - PROCESS | 1678 | |9;json-stringify-tinderbox;64;72;84;67;79;73;70;64;65;67 17:39:06 INFO - PROCESS | 1678 | |10;stanford-crypto-aes;83;81;83;85;84;83;83;85;85;84 17:39:06 INFO - PROCESS | 1678 | |11;stanford-crypto-ccm;131;164;155;166;140;139;137;150;232;204 17:39:06 INFO - PROCESS | 1678 | |12;stanford-crypto-pbkdf2;235;178;173;191;242;173;177;173;175;167 17:39:06 INFO - PROCESS | 1678 | |13;stanford-crypto-sha256-iterative;70;70;65;71;64;96;100;100;70;69 17:39:06 INFO - PROCESS | 1678 | __end_tp_report 17:39:06 INFO - PROCESS | 1678 | __start_cc_report 17:39:06 INFO - PROCESS | 1678 | _x_x_mozilla_cycle_collect,1018 17:39:06 INFO - PROCESS | 1678 | __end_cc_report 17:39:06 INFO - PROCESS | 1678 | __startTimestamp1461199146007__endTimestamp 17:39:06 INFO - PROCESS | 1678 | 17:39:06 INFO - PROCESS | 1678 | ------- Summary: start ------- 17:39:06 INFO - PROCESS | 1678 | Number of tests: 14 17:39:06 INFO - PROCESS | 1678 | 17:39:06 INFO - PROCESS | 1678 | [#0] ai-astar Cycles:10 Average:131.20 Median:128.00 stddev:21.13 (16.5%) stddev-sans-first:21.69 17:39:06 INFO - PROCESS | 1678 | Values: 116.0 111.0 169.0 119.0 118.0 131.0 125.0 170.0 122.0 131.0 17:39:06 INFO - PROCESS | 1678 | 17:39:06 INFO - PROCESS | 1678 | [#1] audio-beat-detection Cycles:10 Average:148.60 Median:150.00 stddev:23.44 (15.6%) stddev-sans-first:17.49 17:39:06 INFO - PROCESS | 1678 | Values: 196.0 135.0 149.0 168.0 138.0 140.0 144.0 151.0 159.0 106.0 17:39:06 INFO - PROCESS | 1678 | 17:39:06 INFO - PROCESS | 1678 | [#2] audio-dft Cycles:10 Average:219.10 Median:207.00 stddev:35.33 (17.1%) stddev-sans-first:36.47 17:39:06 INFO - PROCESS | 1678 | Values: 196.0 195.0 209.0 237.0 197.0 196.0 205.0 193.0 280.0 283.0 17:39:06 INFO - PROCESS | 1678 | 17:39:06 INFO - PROCESS | 1678 | [#3] audio-fft Cycles:10 Average:72.50 Median:66.00 stddev:22.78 (34.5%) stddev-sans-first:24.07 17:39:06 INFO - PROCESS | 1678 | Values: 67.0 79.0 72.0 133.0 56.0 59.0 65.0 61.0 77.0 56.0 17:39:06 INFO - PROCESS | 1678 | 17:39:06 INFO - PROCESS | 1678 | [#4] audio-oscillator Cycles:10 Average:92.60 Median:80.00 stddev:19.24 (24.1%) stddev-sans-first:19.86 17:39:06 INFO - PROCESS | 1678 | Values: 80.0 79.0 122.0 78.0 83.0 84.0 121.0 81.0 80.0 118.0 17:39:06 INFO - PROCESS | 1678 | 17:39:06 INFO - PROCESS | 1678 | [#5] imaging-gaussian-blur Cycles:10 Average:90.10 Median:88.00 stddev:6.15 (7.0%) stddev-sans-first:6.48 17:39:06 INFO - PROCESS | 1678 | Values: 88.0 102.0 88.0 85.0 89.0 85.0 88.0 87.0 88.0 101.0 17:39:06 INFO - PROCESS | 1678 | 17:39:06 INFO - PROCESS | 1678 | [#6] imaging-darkroom Cycles:10 Average:113.60 Median:94.00 stddev:23.54 (25.0%) stddev-sans-first:23.87 17:39:06 INFO - PROCESS | 1678 | Values: 94.0 95.0 94.0 95.0 111.0 150.0 124.0 95.0 124.0 154.0 17:39:06 INFO - PROCESS | 1678 | 17:39:06 INFO - PROCESS | 1678 | [#7] imaging-desaturate Cycles:10 Average:116.90 Median:118.00 stddev:25.30 (21.4%) stddev-sans-first:26.62 17:39:06 INFO - PROCESS | 1678 | Values: 126.0 140.0 97.0 111.0 130.0 90.0 85.0 148.0 151.0 91.0 17:39:06 INFO - PROCESS | 1678 | 17:39:06 INFO - PROCESS | 1678 | [#8] json-parse-financial Cycles:10 Average:63.30 Median:62.00 stddev:4.22 (6.8%) stddev-sans-first:4.45 17:39:06 INFO - PROCESS | 1678 | Values: 62.0 63.0 61.0 62.0 62.0 61.0 62.0 75.0 64.0 61.0 17:39:06 INFO - PROCESS | 1678 | 17:39:06 INFO - PROCESS | 1678 | [#9] json-stringify-tinderbox Cycles:10 Average:70.50 Median:71.00 stddev:6.69 (9.4%) stddev-sans-first:6.67 17:39:06 INFO - PROCESS | 1678 | Values: 64.0 72.0 84.0 67.0 79.0 73.0 70.0 64.0 65.0 67.0 17:39:06 INFO - PROCESS | 1678 | 17:39:06 INFO - PROCESS | 1678 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:84.00 stddev:1.26 (1.5%) stddev-sans-first:1.32 17:39:06 INFO - PROCESS | 1678 | Values: 83.0 81.0 83.0 85.0 84.0 83.0 83.0 85.0 85.0 84.0 17:39:06 INFO - PROCESS | 1678 | 17:39:06 INFO - PROCESS | 1678 | [#11] stanford-crypto-ccm Cycles:10 Average:161.80 Median:159.50 stddev:32.45 (20.3%) stddev-sans-first:32.45 17:39:06 INFO - PROCESS | 1678 | Values: 131.0 164.0 155.0 166.0 140.0 139.0 137.0 150.0 232.0 204.0 17:39:06 INFO - PROCESS | 1678 | 17:39:06 INFO - PROCESS | 1678 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:188.40 Median:177.50 stddev:27.16 (15.3%) stddev-sans-first:22.98 17:39:06 INFO - PROCESS | 1678 | Values: 235.0 178.0 173.0 191.0 242.0 173.0 177.0 173.0 175.0 167.0 17:39:06 INFO - PROCESS | 1678 | 17:39:06 INFO - PROCESS | 1678 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.50 Median:70.00 stddev:14.82 (21.2%) stddev-sans-first:15.47 17:39:06 INFO - PROCESS | 1678 | Values: 70.0 70.0 65.0 71.0 64.0 96.0 100.0 100.0 70.0 69.0 17:39:06 INFO - PROCESS | 1678 | -------- Summary: end -------- 17:39:06 INFO - PROCESS | 1678 | 17:39:06 INFO - TEST-INFO | 1678: exit 0 17:39:06 INFO - TEST-OK | kraken | took 60275ms 17:39:06 INFO - SUITE-END | took 1172s 17:39:07 INFO - Completed test suite (00:19:33) 17:39:07 INFO - javascript benchmark 17:39:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3297.9340413191735, 3477.182862027424, 3526.400511912976, 3542.256126213495, 3593.8562457501685, 5751.856203594907, 5828.562857785661, 5852.414758524151, 5909.615874968129, 5961.821145365646, 5765.884682306351, 5859.091840764689, 5873.676947767871, 5953.821385358436, 6038.215032045828, 5279.340082489698, 5335.626506144552, 5374.516293533581, 5397.892042159155, 5414.648047876895, 238.417808946977, 5353.063213937565, 5401.243825864382, 5409.702466364349, 5514.751836167362, 5366.409694933554, 5366.731663416853, 5398.109311963541, 5398.2712333834825, 5407.080796264644, 5305.310309659758, 5423.430539793304, 5440.809571664972, 5444.292242008553, 5474.507294343488, 4391.736495810262, 5279.260903473517, 5289.259503669489, 5365.382980957201, 5375.274337964363, 5675.233843431125, 5745.08078707409, 5770.653760774367, 5861.677607731573, 5872.647641141545, 6168.8766224675255, 6180.412860778219, 6199.132121502993, 6276.560640755149, 6278.591891527036, 6235.282942461584, 6265.843353916143, 6274.811755647338, 6277.7175027123885, 6305.0, 5143.408508021551, 5856.414358564152, 6001.969990150065, 6016.578839481194, 6019.097135429721, 6229.7508099676415, 6283.43449089575, 6353.428191462698, 6354.332795056545, 6362.77730279438, 6101.908471372933, 6131.437835141539, 6155.753769849156, 6157.230346206724, 6161.938380616137, 6247.9062814057825, 6262.53031022666, 6267.905981410283, 6288.52836037299, 6291.465225455888, 6199.256089269316, 6230.968845155836, 6248.9062664060075, 6314.71583778731, 6350.364963503705, 6203.4416902479, 6243.656598887105, 6246.656433896089, 6283.905741413882, 6309.33751956038, 5026.949730502722, 5057.31726216956, 5082.898342033212, 5083.974580127149, 5086.64393492452, 4420.823167073346, 4431.556844315543, 4562.520935301812, 4624.791884365211, 4662.997455547006, 5924.526037916957, 5936.614120082181, 6013.128096426081, 6025.9096113558335, 6055.364186760415, 6279.843003924939, 6291.213598300213, 6299.937000630027, 6301.054841773771, 6309.14826498426, 5845.824625261249, 5962.165296858443, 5977.581569290108, 6052.273727152769, 6106.511479081662, 5525.198846167364, 5530.723463826793, 5535.750891209906, 5535.916961245504, 5545.528630066409, 6412.9679351602945, 6475.773347932894, 6476.4495017924, 6491.026346048036, 6514.348565143448, 6213.471854892385, 6236.875262494816, 6276.529260305404, 6295.9370406297185, 6315.652639104709, 6413.679316034273, 6446.226452825691, 6447.580907241015, 6481.773137940149, 6557.049227862029, 5030.421501527371, 6338.207724034496, 6340.1440805490665, 6350.396712312323, 6358.554901156875, 6213.409726076015, 6256.593321434092, 6314.589551679126, 6316.810495685137, 6324.3991820776955, 4616.891945933019, 5243.793927396644, 5413.729313534386, 5971.686229029607, 6238.906416403667, 5026.472220416804, 5103.591712663052, 6101.5118790497545, 6272.2159730033745, 6286.622802631857, 6064.760996353585, 6073.180120683651, 6120.0, 6161.476274516716, 6168.383161683796, 5714.485696287354, 6118.174046503665, 6222.191115155001, 6231.937680623136, 6261.092141639346, 6071.908921366271, 6117.908231376444, 6126.884121540821, 6203.2556093269095, 6208.81373558794], "value": 5741.473433322781, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [519.2341296587532, 528.255160224084, 534.254714673031, 549.3188446326557, 602.6113157013724, 29192.416151676982, 38167.42748858762, 38179.42730859039, 38418.61581384192, 38508.807455962684, 40519.0, 41099.0, 41106.38340424889, 41161.970950726245, 41182.58817411825, 8164.7550573482895, 9297.907020929806, 9514.096160864707, 9544.856827147598, 9550.761230969212, 8150.470219435747, 9428.905710942905, 9527.09492598202, 9669.371490853107, 9681.177099946513, 9510.429374237534, 9616.663416780415, 9651.613935442574, 9664.4201347919, 9689.854652180224, 9620.807583848318, 9678.854817177747, 9707.029297070307, 9712.902870971271, 9727.708168754949, 9497.24022078239, 9556.522173891277, 9588.232941364675, 9676.080772326617, 9696.46669433181, 39401.0, 39768.0, 39805.20389592221, 39839.40240896389, 39874.60752354868, 2618.332325257047, 2884.7259510346485, 2889.6965818589165, 3057.5260834570677, 3147.905562833119, 25677.358066048313, 25780.0, 25838.74161258382, 26583.867080664666, 26592.069277575385, 2499.212747984379, 2625.2649258207734, 2626.304029432202, 2626.54035543781, 2673.131232349475, 392223.0, 393175.0, 394853.0, 395175.0, 395952.99999999715, 34159.48760768591, 34647.65352346495, 34696.13259668478, 34731.4790278146, 35288.64711352905, 34074.829625851715, 34781.9565413038, 35577.8221108898, 35711.64288357135, 35781.64218357783, 15017.849821501644, 15278.618034549003, 15285.465008724863, 15293.317735049135, 15305.00517466361, 12972.545960891512, 12976.221426714239, 12978.675533111747, 12987.480500779862, 13115.081944264, 7152.642367881585, 8124.959375203086, 8130.512169269863, 8224.218699223564, 8270.8345833083, 3410.3349846780134, 3417.6069751978343, 3440.82795860206, 3449.6032956209856, 3474.965250347515, 981.4454833019321, 1092.4974511724695, 1101.146611376174, 1133.3709791065874, 1167.7080729817546, 30121.548176777367, 30167.245818854703, 30599.388012240077, 30625.0, 31502.84248578788, 1003.9397636141855, 1031.7317497450717, 1066.7919755647574, 1096.4682129167347, 1153.5270539079106, 14229.075110117808, 15052.54842354731, 15080.622984425478, 15297.694046119015, 15382.153981530899, 605914.0, 622451.0, 622848.0, 623882.0, 627111.0, 60526.69736651288, 60785.696071520244, 61253.38746612477, 61312.69343653253, 61594.69202653958, 1427.150845247097, 1458.7593047147313, 1483.9183844888635, 1489.508462207469, 1494.7757836324638, 26806.525641089927, 29868.253293667833, 30156.246093846952, 30629.846850765603, 31066.68933310638, 58210.70894645499, 58218.0, 59554.70222648859, 59666.40333596782, 59766.10350844828, 484893.0, 575520.0, 576812.5071870483, 581015.0, 582281.0, 41367.29395529409, 42486.36270455884, 42573.787131065386, 42680.5731942689, 43425.782871085445, 43272.0, 43345.133097337246, 44054.3391849129, 44748.55251447574, 44772.0, 36123.63876361308, 36350.0, 36451.81774091112, 36762.448563271035, 37159.071023224635, 37185.628143719296, 40708.38937415882, 41188.0, 41358.759237222934, 41863.37204941989, 37140.88577342684, 38217.617823821405, 39969.00077498086, 40206.798966004986, 40599.0, 37705.81147094247, 39018.0, 39481.0, 40474.797626011685, 41439.0, 30324.393512130075, 30361.0, 30418.39163216679, 30472.542911855897, 30818.38363232678], "value": 18601.168255676585, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.53172522286326, 402.3702904953749, 403.326444837122, 403.84250142444444, 412.50499400719127, 19645.31241406551, 20385.388438346836, 21017.159313627457, 21140.89429552852, 21490.0, 18313.626478014136, 19810.801891981075, 20221.898890505527, 20345.084471198796, 20585.485362865897, 4943.9258411123865, 5253.763580638881, 5276.970990656823, 5440.863978400552, 5520.530754885839, 3912.158885839544, 4874.902501949959, 5400.594955378343, 5466.453354664522, 6015.518758499309, 5934.1098835174635, 6142.8464288392925, 6150.6924653767355, 6155.784547540837, 6156.076588511714, 4731.36126622905, 5571.470710282537, 5971.880562388771, 6039.969800150993, 6094.207752992105, 4393.428854248959, 4920.6801557898625, 5704.087346024658, 6046.516278697693, 6088.117223002684, 13517.391717372742, 13712.520061797888, 13765.587032389045, 14156.50452234167, 20534.0, 2014.9597008059757, 2044.2436298569623, 2097.5385415208784, 2102.8948552572465, 2157.6224160771803, 8224.917750822475, 9967.90032099677, 10248.436336001518, 12033.51865925362, 14281.285935703174, 1672.5066105498906, 1753.36002359138, 1758.7361895715617, 1761.1810508113788, 1789.973150402745, 113011.0, 115809.0, 116311.41844290809, 119367.40316298362, 121636.0, 11540.94229528847, 11550.537978480934, 11792.646220613395, 11823.408829558488, 12399.876001240053, 15154.787616990614, 15254.618634534225, 15271.541853744406, 15278.770818437732, 15348.23258837076, 8842.646294148162, 8912.688055918012, 8916.73249802507, 8918.331125165509, 9036.186743193144, 7130.429565634737, 8731.388802783871, 8815.955920220485, 8913.732588022369, 8950.0, 4623.398958135421, 4668.953310466852, 4673.929891051637, 4708.105459962596, 4735.810567577328, 1893.7916829148783, 1958.5005823515198, 1977.159707124495, 2053.774084850665, 2056.5784014277037, 811.8213992921548, 897.2507955856802, 931.5109567477128, 1044.185535282481, 1066.5627092891878, 19727.40817775469, 20661.690074648894, 20877.26929557458, 20936.43014702214, 20967.47581310449, 937.9390339627903, 959.8704174936295, 978.1196922769565, 1042.207921979301, 1058.751193469534, 10384.42885641297, 10647.680569582924, 10945.233833631728, 10959.780804383867, 10984.176186786022, 253055.0, 253737.19394209102, 533637.0, 602230.0, 615800.0, 110423.44788276168, 126450.20649380534, 128272.0, 130542.34728826296, 132024.0, 1024.2215915903967, 1031.6853359725355, 1061.2518174686827, 1064.0423618743193, 1076.9515371808288, 14459.638509036937, 17095.059771712677, 18245.0, 18349.08254587292, 18377.90811045936, 48809.5119048805, 52527.737361312946, 53470.465295348105, 54371.912561749334, 54474.727626361615, 77783.61108194423, 78095.65713028618, 79563.60218198872, 79811.60094199491, 81724.0, 6062.939370606237, 7171.426285897011, 7200.639968001684, 7421.3691836192365, 7769.689212431439, 11252.887471125512, 11849.229800062969, 11866.762664746484, 12108.939455302667, 12513.562025329069, 9872.851907221253, 10417.791644167226, 10533.104686101768, 10895.400752958663, 11076.833847492455, 8727.432716873636, 9619.27855410833, 10726.302790318605, 10733.731656708333, 10871.565137394417, 10905.0, 11014.39420831862, 11033.337999720043, 11203.943980280046, 11339.036181924628, 8073.273405393543, 8196.713115040944, 8259.917400825914, 8302.128276530877, 8448.577571121543, 10491.580336786443, 11040.447977601249, 11080.889191107986, 11155.498002590066, 11213.439328033728], "value": 9266.12722338573, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1606.3735143294114, 1612.8467795559422, 1902.2961504243433, 1990.6217818614462, 1994.8005199480062, 7919.7624071277805, 8530.146985301466, 8670.73987780366, 8902.955485222581, 8943.821123577525, 8544.615492302846, 8593.785155371119, 8713.477191368522, 8727.738167854974, 8733.475991440519, 2425.6240282756203, 2474.035126300744, 2478.429961108946, 2481.2928315430104, 2488.029668429305, 2413.336332508565, 2443.2425947956103, 2448.167623008177, 2448.4490989527303, 2487.2289590227088, 2088.342172215755, 2447.070113356922, 2465.9753402466013, 2469.2098528470897, 2492.8130390220717, 2410.3371572817614, 2411.409204744831, 2414.0343862454984, 2451.4361696809747, 2461.965974290802, 2099.9475013124643, 2434.6591477193206, 2443.2792326263616, 2467.0, 2467.8272520923542, 8763.693270735557, 8796.780080498038, 8808.515531645757, 8810.0, 8810.38327317088, 5257.579393648499, 5430.864228394283, 5437.864053398657, 5452.345718513764, 5482.780688772445, 2998.055612482061, 3526.453399723047, 3564.82175891207, 3579.427291633326, 3644.471551625026, 1031.6073301043607, 1050.7058023753361, 1054.9841752373643, 1069.9518521666544, 1075.542894269932, 11490.36802975836, 11507.597234096851, 11665.825012624817, 11701.0, 11725.472353744102, 3885.3589157789215, 4732.100900828831, 4806.086843499724, 4950.727709975986, 4959.950400496021, 10102.848457273147, 10117.494125293706, 10161.136303414292, 10193.490325483695, 10201.489925503844, 5415.296011518478, 5442.6462279951675, 5445.319335083114, 5472.671639701631, 5503.779848806083, 3986.5216174059296, 4420.381146639473, 4946.554810067111, 5012.172991456368, 5044.016416798689, 3328.700416962485, 3867.0719027433215, 4052.2908491013955, 4069.4148259738436, 4188.727732697365, 1340.7251513439721, 1369.137443410645, 1371.8422381426265, 1374.1411617738913, 1383.5157694806737, 659.350539718377, 816.5917041479261, 901.9233365164034, 911.2300106410073, 940.3370623710268, 5636.915446268309, 5865.0, 5889.204957330706, 5907.409259074144, 5996.920554300268, 998.006983051868, 1001.3841487485145, 1006.4665727164614, 1011.8077565262577, 1011.8482227665762, 3496.8251587421037, 3739.6634302912867, 3869.032741814546, 3871.032241939515, 3933.7639741615594, 10428.791424171473, 10493.790124197474, 10856.511456984455, 10869.293495922899, 10953.0, 10855.67432977012, 10868.945655271831, 10878.238523303293, 10886.129109671207, 10920.2901811382, 8157.265846073882, 8181.509109453333, 8256.545889975989, 8275.0, 8360.874586881202, 5722.055860782924, 5813.186153938536, 5826.533877289891, 5837.182794408871, 5905.734241959208, 9851.802963940825, 9898.158656514277, 10143.746406339606, 10192.847107293544, 10208.846867296848, 9910.851337229804, 10127.89872101299, 10292.330998485075, 10299.691009269434, 10312.793744125225, 6393.776217832354, 6629.0, 6872.0, 6914.446844252348, 7052.506324557232, 8215.507069575844, 8235.95882020586, 8316.62575184106, 8321.916780832114, 8328.417010809186, 7280.490365674352, 7303.342699157101, 7436.144843342869, 7491.9625401872645, 7649.617519124133, 7312.15910170316, 7315.926840731525, 7365.926340736524, 7409.518381305198, 7461.4030877528585, 7021.368076873106, 7027.0, 7122.60825654594, 7132.607706576188, 7150.356467917913, 4677.228257337501, 4757.4062688999575, 4861.222204447272, 4932.679375840702, 5075.365579302587, 4877.146499362669, 4923.236898280772, 4954.9752251238515, 4968.205087186033, 5107.233914912793], "value": 4620.3254394772775, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.39315300928234, 321.58194347348456, 328.6040321412698, 328.70745036917134, 333.899830050985, 4665.0, 5113.51421614947, 5384.973075134629, 5576.0, 6198.504119670427, 5186.481351864812, 6208.441240288374, 6275.278342990558, 6280.371962803717, 6283.057541368786, 4388.639521748269, 4409.603135717777, 4545.250033744444, 4666.570070997814, 4701.318308845215, 4063.674906007527, 4584.793684284198, 4665.533446655324, 4686.554777296152, 4701.976490117561, 4036.1725846201457, 4356.607905288523, 4444.444444444444, 4583.8998640326245, 4669.066186762644, 4296.419983302246, 4589.954100458986, 4594.471635761896, 4620.861374158781, 4633.698809577367, 3886.980565097185, 3908.55051669056, 3920.3923391874305, 3930.0, 3930.8034598269974, 5157.7936882524655, 5214.374275086976, 5831.416858314177, 6061.3029501607, 6064.028061619646, 4568.383268258809, 5162.199859021857, 5248.53041148479, 5326.866828329284, 5351.812686555991, 5724.713764311768, 5762.423757624246, 6560.114384558071, 6561.3438656134485, 6575.178102737158, 3650.361186792301, 4023.195360927826, 4206.26390381685, 4350.564943505656, 4351.0862718829085, 6508.479321654257, 6662.86674266512, 6912.239653638096, 7062.54093483927, 7150.785476435715, 3813.779590531059, 4335.934960975588, 4445.555444455593, 4451.330750968387, 4459.487158976759, 3910.3743401056263, 3993.4608827807874, 4331.155424692155, 4494.955050449519, 4511.751853648016, 5341.278927344836, 5346.358436987509, 5356.035913535601, 5367.919481207785, 5373.731313434391, 6352.618842869442, 6697.866042679217, 6707.798766037026, 6711.255073680781, 6754.797356079227, 1363.8431580368185, 1491.9328630211667, 1534.8388419216044, 1549.3492733052144, 1551.7905082813675, 917.6604656277086, 967.5936106835146, 985.6648739428629, 998.6119294181094, 1003.8243307421172, 5368.8657783554945, 6063.81755557662, 6197.752089916353, 6226.097215903759, 6229.127922090911, 6357.760236753788, 6612.206535215805, 6818.454523638097, 6876.381125698711, 6924.688389022506, 4875.146849301358, 5667.319921609434, 5841.707914604252, 6177.62934223948, 6239.563230573907, 2925.590417341574, 3164.3829453256853, 3600.837962291703, 3626.8549258029384, 3657.9451308230396, 6701.2189941173865, 6850.691718872663, 6927.480438967098, 7370.815729606696, 7394.297541733635, 6167.515353825074, 7134.464915131386, 7210.170830354471, 7262.527935684164, 7311.341979221896, 6621.748605474162, 6981.860362792817, 7267.238449389199, 7288.890666640004, 7393.334599886036, 6968.895466567904, 6994.370506654425, 7012.1935977363255, 7034.311765176423, 7049.0, 6663.300353463011, 6840.965795170992, 6868.828279292858, 6915.239323674492, 6925.68834402443, 7208.855822883408, 7317.000029987679, 7318.890216646861, 7324.707011719472, 7329.230430804689, 4167.2082304362075, 4396.142752163298, 4439.334099885043, 4474.888127796831, 4483.574060464251, 6860.348266914635, 6869.896951545631, 6879.862402752017, 6930.3961939790015, 6955.513114081966, 6288.748450061947, 6454.031520386327, 6688.230853451721, 6741.629210393476, 6747.291534388818, 5816.604015036445, 6425.0, 6662.267150613332, 6670.066190733204, 6678.666066696743, 6231.532635052298, 6327.746890124344, 6529.67351632407, 6533.8693226136165, 6560.245571759308, 6638.601683898982, 6707.262201157966, 6726.495512836459, 6745.4266387355665, 6756.358145976124, 4778.928316075192, 6551.624158926679, 6568.277489476058, 6586.0, 6649.63427011519], "value": 4778.100346672171, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [666.167290886392, 676.7056330496234, 692.6502116431202, 725.4160400877291, 743.8809790433528, 14718.0, 14803.481878134267, 14929.626759331022, 14994.47519336822, 15005.774913376308, 13455.73088538231, 13921.860781392208, 13928.860711392883, 13958.302084895766, 13988.510402135928, 751.6016511249047, 914.7438717159206, 936.2182577547738, 943.9292053096011, 952.9523523823816, 939.037486576258, 942.0626476655738, 943.6084025129563, 943.7923656795494, 945.6926498887855, 955.9187469065138, 987.1017374189489, 994.1698681600872, 1000.7548150703088, 1002.1381611813835, 967.7241986033981, 986.4081551069373, 989.0653332600731, 992.6376872441579, 993.6472552243922, 709.7799682098566, 718.8526352097807, 724.9275072492761, 747.3236720767713, 748.1620584944897, 15057.472988445461, 15135.545933622008, 15212.011219270822, 15212.847871521253, 15215.847841521554, 10383.376997380181, 12455.0, 12595.685107872285, 12623.305718185497, 12769.744605107939, 9638.566264518113, 9683.467409292556, 9866.210703143803, 9976.451295178835, 9979.850302245472, 3406.8296585170892, 3429.8285085745615, 3469.809160496172, 3479.1823921378455, 3509.1051781795477, 54664.18003729947, 78172.0, 78513.21486785173, 78544.60727696324, 83855.0, 9391.248700104112, 9465.148136667594, 9626.326157169071, 9708.611655533841, 10087.899121008842, 19147.71278430797, 21533.67699484509, 21536.138554457648, 21558.784412155677, 21597.784022159893, 7637.732679356307, 7699.576523291273, 7766.865270988429, 7883.881741773878, 8010.599470026592, 4111.938320925188, 4123.690723195712, 4134.607212314825, 4142.5857414258335, 4172.895677608084, 3598.946015809765, 3692.040069581928, 3705.6109108543756, 3705.7591256568235, 3729.3473642113063, 667.0760996020449, 672.1329484964439, 680.904673345732, 682.0928165539821, 683.1904193530683, 532.3691425660604, 562.5752556819657, 594.3759052994425, 594.4145017158096, 618.4217756397693, 7923.16806735296, 7994.80012999668, 8003.31971782405, 8143.104258531557, 8195.34437245019, 557.5288880895637, 586.1237450012259, 593.4540222994855, 600.441589321926, 608.8796614229839, 3716.832742526593, 3844.750091244116, 3907.433422153772, 3999.1801680655394, 4061.2080644274083, 88157.0, 89311.21377572411, 90364.0, 90712.09287907036, 90761.0, 64047.67976160089, 67296.32703672901, 76521.17394130271, 77928.05179870436, 78406.0, 68987.31012689808, 69704.3991309371, 69923.60152796915, 69947.95078073833, 69968.60062798817, 7018.5788852669, 7551.320381165721, 7701.075870895528, 7722.111957125003, 7832.608369581612, 29052.128436146948, 34642.9214247146, 41322.58677413307, 41376.96557586084, 42064.36903446512, 40225.99435014148, 55422.0, 57058.7147064262, 57346.0, 58354.7082264586, 9828.606855725691, 9878.209743220381, 9920.751981200528, 10193.898061019296, 10230.693079207636, 10654.946725266323, 10696.090832279344, 10857.83713244286, 10870.347779133277, 11630.33227382273, 9953.502324883872, 10097.949510252402, 10282.794344112926, 10369.688909332732, 10572.36565806054, 10047.09576138151, 10061.446620435947, 10310.0, 10472.424016679155, 10516.316439431412, 9960.1533869619, 10417.374957502574, 10430.843537347098, 10497.632582859564, 10522.210834187314, 8445.577721114043, 8726.956365218133, 8746.693865714924, 8795.076516965883, 8837.513936733541, 9102.362834601514, 9503.287253455881, 9865.704028879145, 9922.553485093333, 10066.748331291776], "value": 6687.962145207509, "unit": "score"}], "name": "dromaeo_css", "value": 7257.493988710931, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 111.0, 169.0, 119.0, 118.0, 131.0, 125.0, 170.0, 122.0, 131.0], "value": 131.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 135.0, 149.0, 168.0, 138.0, 140.0, 144.0, 151.0, 159.0, 106.0], "value": 148.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 195.0, 209.0, 237.0, 197.0, 196.0, 205.0, 193.0, 280.0, 283.0], "value": 219.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 79.0, 72.0, 133.0, 56.0, 59.0, 65.0, 61.0, 77.0, 56.0], "value": 72.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 122.0, 78.0, 83.0, 84.0, 121.0, 81.0, 80.0, 118.0], "value": 92.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 102.0, 88.0, 85.0, 89.0, 85.0, 88.0, 87.0, 88.0, 101.0], "value": 90.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 111.0, 150.0, 124.0, 95.0, 124.0, 154.0], "value": 113.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 140.0, 97.0, 111.0, 130.0, 90.0, 85.0, 148.0, 151.0, 91.0], "value": 116.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 61.0, 62.0, 62.0, 61.0, 62.0, 75.0, 64.0, 61.0], "value": 63.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 72.0, 84.0, 67.0, 79.0, 73.0, 70.0, 64.0, 65.0, 67.0], "value": 70.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 83.0, 85.0, 84.0, 83.0, 83.0, 85.0, 85.0, 84.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 164.0, 155.0, 166.0, 140.0, 139.0, 137.0, 150.0, 232.0, 204.0], "value": 161.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [235.0, 178.0, 173.0, 191.0, 242.0, 173.0, 177.0, 173.0, 175.0, 167.0], "value": 188.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 65.0, 71.0, 64.0, 96.0, 100.0, 100.0, 70.0, 69.0], "value": 77.5, "unit": "score"}], "name": "kraken", "value": 1629.7, "alertThreshold": 2.0}]} 17:39:07 INFO - Return code: 0 17:39:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:39:07 ERROR - # TBPL SUCCESS # 17:39:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:39:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:39:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:39:07 INFO - 2016-04-20 17:39:07.334 screenresolution[1683:10963] starting screenresolution argv=screenresolution get 17:39:07 INFO - 2016-04-20 17:39:07.337 screenresolution[1683:10963] Display 0: 1600x1200x32@60 17:39:07 INFO - 2016-04-20 17:39:07.343 screenresolution[1684:10966] starting screenresolution argv=screenresolution list 17:39:07 INFO - Available Modes on Display 0 17:39:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:39:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:39:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:39:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:39:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:39:07 INFO - Intel Iris: 17:39:07 INFO - Chipset Model: Intel Iris 17:39:07 INFO - Type: GPU 17:39:07 INFO - Bus: Built-In 17:39:07 INFO - VRAM (Dynamic, Max): 1536 MB 17:39:07 INFO - Vendor: Intel (0x8086) 17:39:07 INFO - Device ID: 0x0a2e 17:39:07 INFO - Revision ID: 0x0009 17:39:07 INFO - Displays: 17:39:07 INFO - Display: 17:39:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:39:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:39:07 INFO - Display Serial Number: 1600x1200 60 17:39:07 INFO - Main Display: Yes 17:39:07 INFO - Mirror: Off 17:39:07 INFO - Online: Yes 17:39:07 INFO - Rotation: Supported 17:39:07 INFO - Return code: 0 17:39:07 INFO - Running post-action listener: _resource_record_post_action 17:39:07 INFO - Running post-run listener: _resource_record_post_run 17:39:08 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 32488960; Write bytes: 696605184; Read time: 326; Write time: 2101 17:39:08 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 379924992; Write bytes: 374097408; Read time: 28251; Write time: 714 17:39:08 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 31567360; Write bytes: 299402240; Read time: 313; Write time: 1340 17:39:08 INFO - Running post-run listener: _upload_blobber_files 17:39:08 INFO - Blob upload gear active. 17:39:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:39:08 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 17:39:08 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'] 17:39:08 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 17:39:09 INFO - (blobuploader) - INFO - Open directory for files ... 17:39:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:39:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:39:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:39:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:39:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:39:10 INFO - (blobuploader) - INFO - Done attempting. 17:39:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:39:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:39:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:39:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:39:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:39:11 INFO - (blobuploader) - INFO - Done attempting. 17:39:11 INFO - (blobuploader) - INFO - Iteration through files over. 17:39:11 INFO - Return code: 0 17:39:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:39:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:39:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7ac1c25cba7d42bd056ff482242abab53631457003a13d1f3f05a67f96abf0454d130c12e49f752db7b7f4a07a91dcf04f3cb8cb40ae67190bbdcb123a37870a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/56f10d8a397b879254928db22e756f9e1e586712b4793aaa3088d0886352abb49b45b66ce5a8bc716dc05144e35afd68069deb9bbe7bf4c682992c0d272998a1"} 17:39:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:39:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:39:11 INFO - Contents: 17:39:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7ac1c25cba7d42bd056ff482242abab53631457003a13d1f3f05a67f96abf0454d130c12e49f752db7b7f4a07a91dcf04f3cb8cb40ae67190bbdcb123a37870a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/56f10d8a397b879254928db22e756f9e1e586712b4793aaa3088d0886352abb49b45b66ce5a8bc716dc05144e35afd68069deb9bbe7bf4c682992c0d272998a1"} 17:39:11 INFO - Running post-run listener: copy_logs_to_upload_dir 17:39:11 INFO - Copying logs to upload dir... 17:39:11 INFO - mkdir: /builds/slave/test/build/upload/logs 17:39:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.236627 ========= master_lag: 6.34 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-04-20 17:39:17.663902) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-04-20 17:39:17.673157) ========= 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.jfa69A3mRL/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.Xnfh5pzcmv/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7ac1c25cba7d42bd056ff482242abab53631457003a13d1f3f05a67f96abf0454d130c12e49f752db7b7f4a07a91dcf04f3cb8cb40ae67190bbdcb123a37870a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/56f10d8a397b879254928db22e756f9e1e586712b4793aaa3088d0886352abb49b45b66ce5a8bc716dc05144e35afd68069deb9bbe7bf4c682992c0d272998a1"} build_url:https://queue.taskcluster.net/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010999 build_url: 'https://queue.taskcluster.net/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7ac1c25cba7d42bd056ff482242abab53631457003a13d1f3f05a67f96abf0454d130c12e49f752db7b7f4a07a91dcf04f3cb8cb40ae67190bbdcb123a37870a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/56f10d8a397b879254928db22e756f9e1e586712b4793aaa3088d0886352abb49b45b66ce5a8bc716dc05144e35afd68069deb9bbe7bf4c682992c0d272998a1"}' ========= master_lag: 1.36 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-04-20 17:39:19.039169) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 17:39:19.039526) ========= 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.jfa69A3mRL/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.Xnfh5pzcmv/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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.005117 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 17:39:19.093464) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 17:39:19.093848) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 17:39:19.104924) ========= ========= Total master_lag: 10.53 =========