builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0114 starttime: 1462528083.91 results: success (0) buildid: 20160506002422 builduid: 34aef8f5bc594344aea19174b0e81e63 revision: e65c3c2186710e9ee1dfb3f254bd45019ea34c80 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 02:48:03.906756) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 02:48:03.907215) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 02:48:03.907498) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 02:48:03.925982) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 02:48:03.926254) ========= 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.pp2NEngb2h/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.UQv9SAorFM/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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-05-06 02:48:04-- 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% 148M=0s 2016-05-06 02:48:04 (148 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124025 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 02:48:04.066493) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 02:48:04.066801) ========= 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.pp2NEngb2h/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.UQv9SAorFM/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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.020368 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 02:48:04.117480) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 02:48:04.117792) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e65c3c2186710e9ee1dfb3f254bd45019ea34c80 --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 e65c3c2186710e9ee1dfb3f254bd45019ea34c80 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pp2NEngb2h/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.UQv9SAorFM/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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-05-06 02:48:04,367 truncating revision to first 12 chars 2016-05-06 02:48:04,367 Setting DEBUG logging. 2016-05-06 02:48:04,367 attempt 1/10 2016-05-06 02:48:04,367 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e65c3c218671?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-06 02:48:05,027 unpacking tar archive at: fx-team-e65c3c218671/testing/mozharness/ program finished with exit code 0 elapsedTime=0.939693 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 02:48:05.079058) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 02:48:05.079413) ========= script_repo_revision: e65c3c2186710e9ee1dfb3f254bd45019ea34c80 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 02:48:05.079840) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 02:48:05.080125) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 02:48:05.096476) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-05-06 02:48:05.096752) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pp2NEngb2h/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.UQv9SAorFM/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 02:48:05 INFO - MultiFileLogger online at 20160506 02:48:05 in /builds/slave/test 02:48:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:48:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:48:05 INFO - {'append_to_log': False, 02:48:05 INFO - 'base_work_dir': '/builds/slave/test', 02:48:05 INFO - 'blob_upload_branch': 'Fx-Team', 02:48:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:48:05 INFO - 'branch': 'Fx-Team', 02:48:05 INFO - 'buildbot_json_path': 'buildprops.json', 02:48:05 INFO - 'config_files': ('talos/mac_config.py',), 02:48:05 INFO - 'default_actions': ('clobber', 02:48:05 INFO - 'read-buildbot-config', 02:48:05 INFO - 'download-and-extract', 02:48:05 INFO - 'populate-webroot', 02:48:05 INFO - 'create-virtualenv', 02:48:05 INFO - 'install', 02:48:05 INFO - 'run-tests'), 02:48:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:48:05 INFO - 'download_minidump_stackwalk': True, 02:48:05 INFO - 'download_symbols': 'ondemand', 02:48:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:48:05 INFO - 'tooltool.py': '/tools/tooltool.py', 02:48:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:48:05 INFO - '/tools/misc-python/virtualenv.py')}, 02:48:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:48:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:48:05 INFO - 'installer_path': 'installer.exe', 02:48:05 INFO - 'log_level': 'info', 02:48:05 INFO - 'log_name': 'talos', 02:48:05 INFO - 'log_to_console': True, 02:48:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:48:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:48:05 INFO - 'opt_config_files': (), 02:48:05 INFO - 'pip_index': False, 02:48:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:48:05 INFO - 'cmd': ('bash', 02:48:05 INFO - '-c', 02:48:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:48:05 INFO - 'enabled': True, 02:48:05 INFO - 'halt_on_failure': False, 02:48:05 INFO - 'name': 'check_screen_resolution'},), 02:48:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:48:05 INFO - 'cmd': ('bash', 02:48:05 INFO - '-c', 02:48:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:48:05 INFO - 'enabled': True, 02:48:05 INFO - 'halt_on_failure': False, 02:48:05 INFO - 'name': 'check_screen_resolution'},), 02:48:05 INFO - 'run_cmd_checks_enabled': True, 02:48:05 INFO - 'sps_profile': False, 02:48:05 INFO - 'sps_profile_interval': 0, 02:48:05 INFO - 'suite': 'dromaeojs', 02:48:05 INFO - 'system_bits': '32', 02:48:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:48:05 INFO - 'title': 't-yosemite-r7-0114', 02:48:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:48:05 INFO - 'use_talos_json': True, 02:48:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:48:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:48:05 INFO - 'work_dir': 'build'} 02:48:05 INFO - ##### 02:48:05 INFO - ##### Running clobber step. 02:48:05 INFO - ##### 02:48:05 INFO - Running pre-action listener: _resource_record_pre_action 02:48:05 INFO - Running main action method: clobber 02:48:05 INFO - rmtree: /builds/slave/test/build 02:48:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:48:07 INFO - Running post-action listener: _resource_record_post_action 02:48:07 INFO - ##### 02:48:07 INFO - ##### Running read-buildbot-config step. 02:48:07 INFO - ##### 02:48:07 INFO - Running pre-action listener: _resource_record_pre_action 02:48:07 INFO - Running main action method: read_buildbot_config 02:48:07 INFO - Using buildbot properties: 02:48:07 INFO - { 02:48:07 INFO - "project": "", 02:48:07 INFO - "product": "firefox", 02:48:07 INFO - "script_repo_revision": "production", 02:48:07 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 02:48:07 INFO - "repository": "", 02:48:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 02:48:07 INFO - "buildid": "20160506002422", 02:48:07 INFO - "pgo_build": "False", 02:48:07 INFO - "basedir": "/builds/slave/test", 02:48:07 INFO - "buildnumber": 810, 02:48:07 INFO - "slavename": "t-yosemite-r7-0114", 02:48:07 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 02:48:07 INFO - "platform": "yosemite_r7", 02:48:07 INFO - "scheduler": "tests-fx-team-macosx64-talos", 02:48:07 INFO - "branch": "fx-team", 02:48:07 INFO - "repo_path": "integration/fx-team", 02:48:07 INFO - "revision": "e65c3c2186710e9ee1dfb3f254bd45019ea34c80", 02:48:07 INFO - "stage_platform": "macosx64", 02:48:07 INFO - "builduid": "34aef8f5bc594344aea19174b0e81e63", 02:48:07 INFO - "slavebuilddir": "test" 02:48:07 INFO - } 02:48:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/XErRLRsCRSS7zuYl6ulpcA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 02:48:07 INFO - Running post-action listener: _resource_record_post_action 02:48:07 INFO - ##### 02:48:07 INFO - ##### Running download-and-extract step. 02:48:07 INFO - ##### 02:48:07 INFO - Running pre-action listener: _resource_record_pre_action 02:48:07 INFO - Running main action method: download_and_extract 02:48:07 INFO - mkdir: /builds/slave/test/build/tests 02:48:07 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')]} 02:48:07 INFO - https://queue.taskcluster.net/v1/task/XErRLRsCRSS7zuYl6ulpcA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 02:48:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XErRLRsCRSS7zuYl6ulpcA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 02:48:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XErRLRsCRSS7zuYl6ulpcA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 02:48:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XErRLRsCRSS7zuYl6ulpcA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 02:48:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XErRLRsCRSS7zuYl6ulpcA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 02:48:08 INFO - Downloaded 1199 bytes. 02:48:08 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 02:48:08 INFO - Using the following test package requirements: 02:48:08 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 02:48:08 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 02:48:08 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 02:48:08 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 02:48:08 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 02:48:08 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 02:48:08 INFO - u'jsshell-mac.zip'], 02:48:08 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 02:48:08 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 02:48:08 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 02:48:08 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 02:48:08 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 02:48:08 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 02:48:08 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 02:48:08 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 02:48:08 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 02:48:08 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 02:48:08 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 02:48:08 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:48:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:08 INFO - https://queue.taskcluster.net/v1/task/XErRLRsCRSS7zuYl6ulpcA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:48:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XErRLRsCRSS7zuYl6ulpcA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 02:48:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XErRLRsCRSS7zuYl6ulpcA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 02:48:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XErRLRsCRSS7zuYl6ulpcA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 02:48:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XErRLRsCRSS7zuYl6ulpcA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:48:09 INFO - Downloaded 18145050 bytes. 02:48:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:48:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 02:48:13 INFO - Return code: 0 02:48:13 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 02:48:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:13 INFO - https://queue.taskcluster.net/v1/task/XErRLRsCRSS7zuYl6ulpcA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:48:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XErRLRsCRSS7zuYl6ulpcA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 02:48:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XErRLRsCRSS7zuYl6ulpcA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 02:48:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XErRLRsCRSS7zuYl6ulpcA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 02:48:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XErRLRsCRSS7zuYl6ulpcA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:48:15 INFO - Downloaded 18145050 bytes. 02:48:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:48:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 02:48:18 INFO - Return code: 0 02:48:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:18 INFO - https://queue.taskcluster.net/v1/task/XErRLRsCRSS7zuYl6ulpcA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:48:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XErRLRsCRSS7zuYl6ulpcA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 02:48:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XErRLRsCRSS7zuYl6ulpcA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 02:48:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XErRLRsCRSS7zuYl6ulpcA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 02:48:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XErRLRsCRSS7zuYl6ulpcA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 02:48:19 INFO - Downloaded 10840152 bytes. 02:48:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:48:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 02:48:20 INFO - Return code: 0 02:48:20 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')]} 02:48:20 INFO - https://queue.taskcluster.net/v1/task/XErRLRsCRSS7zuYl6ulpcA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 02:48:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XErRLRsCRSS7zuYl6ulpcA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 02:48:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XErRLRsCRSS7zuYl6ulpcA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 02:48:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XErRLRsCRSS7zuYl6ulpcA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 02:48:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XErRLRsCRSS7zuYl6ulpcA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 02:48:22 INFO - Downloaded 110403998 bytes. 02:48:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XErRLRsCRSS7zuYl6ulpcA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 02:48:22 INFO - mkdir: /builds/slave/test/properties 02:48:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:48:22 INFO - Writing to file /builds/slave/test/properties/build_url 02:48:22 INFO - Contents: 02:48:22 INFO - build_url:https://queue.taskcluster.net/v1/task/XErRLRsCRSS7zuYl6ulpcA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 02:48:23 INFO - Running post-action listener: _resource_record_post_action 02:48:23 INFO - Running post-action listener: set_extra_try_arguments 02:48:23 INFO - ##### 02:48:23 INFO - ##### Running populate-webroot step. 02:48:23 INFO - ##### 02:48:23 INFO - Running pre-action listener: _resource_record_pre_action 02:48:23 INFO - Running main action method: populate_webroot 02:48:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:48:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:48:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:48:23 INFO - '--tppagecycles', 02:48:23 INFO - '7'], 02:48:23 INFO - 'tests': ['tsvgm']}}, 02:48:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:48:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:48:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:48:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:48:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:48:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:48:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:23 INFO - 'talos_options': ['--disable-e10s'], 02:48:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:48:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:48:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:23 INFO - 'talos_options': ['--disable-e10s'], 02:48:23 INFO - 'tests': ['damp', 'tps']}, 02:48:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:23 INFO - 'tests': ['damp', 'tps']}, 02:48:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:48:23 INFO - 'tests': ['dromaeo_dom']}, 02:48:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:48:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:48:23 INFO - 'tests': ['a11yr', 02:48:23 INFO - 'ts_paint', 02:48:23 INFO - 'tpaint', 02:48:23 INFO - 'sessionrestore', 02:48:23 INFO - 'sessionrestore_no_auto_restore', 02:48:23 INFO - 'tabpaint']}, 02:48:23 INFO - 'other-e10s': {'tests': ['a11yr', 02:48:23 INFO - 'ts_paint', 02:48:23 INFO - 'tpaint', 02:48:23 INFO - 'sessionrestore', 02:48:23 INFO - 'sessionrestore_no_auto_restore', 02:48:23 INFO - 'tabpaint']}, 02:48:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:48:23 INFO - 'ts_paint', 02:48:23 INFO - 'tpaint', 02:48:23 INFO - 'sessionrestore', 02:48:23 INFO - 'sessionrestore_no_auto_restore', 02:48:23 INFO - 'tabpaint']}, 02:48:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:48:23 INFO - 'ts_paint', 02:48:23 INFO - 'tpaint', 02:48:23 INFO - 'sessionrestore', 02:48:23 INFO - 'sessionrestore_no_auto_restore', 02:48:23 INFO - 'tabpaint']}, 02:48:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:48:23 INFO - 'tests': ['a11yr', 02:48:23 INFO - 'ts_paint', 02:48:23 INFO - 'tpaint', 02:48:23 INFO - 'sessionrestore', 02:48:23 INFO - 'sessionrestore_no_auto_restore', 02:48:23 INFO - 'tabpaint']}, 02:48:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:48:23 INFO - 'tests': ['a11yr', 02:48:23 INFO - 'ts_paint', 02:48:23 INFO - 'tpaint', 02:48:23 INFO - 'sessionrestore', 02:48:23 INFO - 'sessionrestore_no_auto_restore', 02:48:23 INFO - 'tabpaint']}, 02:48:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:48:23 INFO - 'tests': ['tsvgx', 02:48:23 INFO - 'tsvgr_opacity', 02:48:23 INFO - 'tart', 02:48:23 INFO - 'tscrollx', 02:48:23 INFO - 'cart']}, 02:48:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:48:23 INFO - 'tsvgr_opacity', 02:48:23 INFO - 'tart', 02:48:23 INFO - 'tscrollx', 02:48:23 INFO - 'cart']}, 02:48:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:23 INFO - 'talos_options': ['--disable-e10s'], 02:48:23 INFO - 'tests': ['tp5o']}, 02:48:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:23 INFO - 'tests': ['tp5o']}, 02:48:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:23 INFO - 'talos_options': ['--disable-e10s', 02:48:23 INFO - '--xperf_path', 02:48:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:48:23 INFO - 'tests': ['tp5n']}, 02:48:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:23 INFO - 'talos_options': ['--xperf_path', 02:48:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:48:23 INFO - 'tests': ['tp5n']}}, 02:48:23 INFO - 'talos.zip': {'path': '', 02:48:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:48:23 INFO - Running post-action listener: _resource_record_post_action 02:48:23 INFO - ##### 02:48:23 INFO - ##### Running create-virtualenv step. 02:48:23 INFO - ##### 02:48:23 INFO - Running pre-action listener: _resource_record_pre_action 02:48:23 INFO - Running main action method: create_virtualenv 02:48:23 INFO - Creating virtualenv /builds/slave/test/build/venv 02:48: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 02:48:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:48:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:48:23 INFO - Using real prefix '/tools/python27' 02:48:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:48:24 INFO - Installing distribute.............................................................................................................................................................................................done. 02:48:27 INFO - Installing pip.................done. 02:48:27 INFO - Return code: 0 02:48:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:48: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')]} 02:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48: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')]} 02:48:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48: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 0x10a51da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a52d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6b149b9e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3bce00>, '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 0x10a1e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a3b7b20>, '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.pp2NEngb2h/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.UQv9SAorFM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 02:48: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 02:48: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 02:48:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pp2NEngb2h/Render', 02:48:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:27 INFO - 'HOME': '/Users/cltbld', 02:48:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:27 INFO - 'LOGNAME': 'cltbld', 02:48:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:27 INFO - 'MOZ_NO_REMOTE': '1', 02:48:27 INFO - 'NO_EM_RESTART': '1', 02:48:27 INFO - 'PAGER': '/bin/cat', 02:48:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:27 INFO - 'PWD': '/builds/slave/test', 02:48:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:27 INFO - 'SHELL': '/bin/bash', 02:48:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UQv9SAorFM/Listeners', 02:48:27 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 02:48:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:27 INFO - 'USER': 'cltbld', 02:48:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:27 INFO - 'XPC_FLAGS': '0x0', 02:48:27 INFO - 'XPC_SERVICE_NAME': '0', 02:48:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48: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 02:48:27 INFO - Cleaning up... 02:48:27 INFO - Return code: 0 02:48:27 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:48: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')]} 02:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48: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')]} 02:48:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48: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 0x10a51da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a52d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6b149b9e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3bce00>, '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 0x10a1e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a3b7b20>, '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.pp2NEngb2h/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.UQv9SAorFM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 02:48: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 02:48: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 02:48:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pp2NEngb2h/Render', 02:48:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:27 INFO - 'HOME': '/Users/cltbld', 02:48:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:27 INFO - 'LOGNAME': 'cltbld', 02:48:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:27 INFO - 'MOZ_NO_REMOTE': '1', 02:48:27 INFO - 'NO_EM_RESTART': '1', 02:48:27 INFO - 'PAGER': '/bin/cat', 02:48:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:27 INFO - 'PWD': '/builds/slave/test', 02:48:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:27 INFO - 'SHELL': '/bin/bash', 02:48:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UQv9SAorFM/Listeners', 02:48:27 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 02:48:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:27 INFO - 'USER': 'cltbld', 02:48:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:27 INFO - 'XPC_FLAGS': '0x0', 02:48:27 INFO - 'XPC_SERVICE_NAME': '0', 02:48:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:27 INFO - Downloading/unpacking psutil>=0.7.1 02:48:27 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 02:48:27 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 02:48:27 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 02:48:27 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 02:48:27 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 02:48:27 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 02:48:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:48:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:48:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:48:30 INFO - Installing collected packages: psutil 02:48:30 INFO - Running setup.py install for psutil 02:48:30 INFO - building 'psutil._psutil_osx' extension 02:48:30 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 02:48:30 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 02:48: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/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 02:48:31 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 02:48:31 INFO - building 'psutil._psutil_posix' extension 02:48:31 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 02:48:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:48:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:48:31 INFO - ^ 02:48:31 INFO - 1 warning generated. 02:48:31 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 02:48:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:48:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:48:31 INFO - Successfully installed psutil 02:48:31 INFO - Cleaning up... 02:48:31 INFO - Return code: 0 02:48:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:48:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:31 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 0x10a51da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a52d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6b149b9e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3bce00>, '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 0x10a1e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a3b7b20>, '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.pp2NEngb2h/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.UQv9SAorFM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 02:48:31 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 02:48:31 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 02:48:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pp2NEngb2h/Render', 02:48:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:31 INFO - 'HOME': '/Users/cltbld', 02:48:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:31 INFO - 'LOGNAME': 'cltbld', 02:48:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:31 INFO - 'MOZ_NO_REMOTE': '1', 02:48:31 INFO - 'NO_EM_RESTART': '1', 02:48:31 INFO - 'PAGER': '/bin/cat', 02:48:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:31 INFO - 'PWD': '/builds/slave/test', 02:48:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:31 INFO - 'SHELL': '/bin/bash', 02:48:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UQv9SAorFM/Listeners', 02:48:31 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 02:48:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:31 INFO - 'USER': 'cltbld', 02:48:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:31 INFO - 'XPC_FLAGS': '0x0', 02:48:31 INFO - 'XPC_SERVICE_NAME': '0', 02:48:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:48:31 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 02:48:31 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 02:48:31 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 02:48:31 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 02:48:31 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 02:48:31 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 02:48:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:48:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:48:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:48:34 INFO - Installing collected packages: mozsystemmonitor 02:48:34 INFO - Running setup.py install for mozsystemmonitor 02:48:34 INFO - Successfully installed mozsystemmonitor 02:48:34 INFO - Cleaning up... 02:48:34 INFO - Return code: 0 02:48:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:48:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:34 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 0x10a51da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a52d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6b149b9e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3bce00>, '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 0x10a1e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a3b7b20>, '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.pp2NEngb2h/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.UQv9SAorFM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 02:48:34 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 02:48:34 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 02:48:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pp2NEngb2h/Render', 02:48:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:34 INFO - 'HOME': '/Users/cltbld', 02:48:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:34 INFO - 'LOGNAME': 'cltbld', 02:48:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:34 INFO - 'MOZ_NO_REMOTE': '1', 02:48:34 INFO - 'NO_EM_RESTART': '1', 02:48:34 INFO - 'PAGER': '/bin/cat', 02:48:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:34 INFO - 'PWD': '/builds/slave/test', 02:48:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:34 INFO - 'SHELL': '/bin/bash', 02:48:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UQv9SAorFM/Listeners', 02:48:34 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 02:48:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:34 INFO - 'USER': 'cltbld', 02:48:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:34 INFO - 'XPC_FLAGS': '0x0', 02:48:34 INFO - 'XPC_SERVICE_NAME': '0', 02:48:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:34 INFO - Downloading/unpacking blobuploader==1.2.4 02:48:34 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 02:48:34 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 02:48:34 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 02:48:34 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 02:48:34 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 02:48:34 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 02:48:37 INFO - Downloading blobuploader-1.2.4.tar.gz 02:48:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:48:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:48:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:48:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:48:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:38 INFO - Downloading docopt-0.6.1.tar.gz 02:48:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:48:38 INFO - Installing collected packages: blobuploader, requests, docopt 02:48:38 INFO - Running setup.py install for blobuploader 02:48:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:48:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:48:38 INFO - Running setup.py install for requests 02:48:39 INFO - Running setup.py install for docopt 02:48:39 INFO - Successfully installed blobuploader requests docopt 02:48:39 INFO - Cleaning up... 02:48:39 INFO - Return code: 0 02:48:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:48:39 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')]} 02:48:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:39 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')]} 02:48:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:39 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 0x10a51da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a52d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6b149b9e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3bce00>, '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 0x10a1e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a3b7b20>, '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.pp2NEngb2h/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.UQv9SAorFM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 02:48:39 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 02:48:39 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 02:48:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pp2NEngb2h/Render', 02:48:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:39 INFO - 'HOME': '/Users/cltbld', 02:48:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:39 INFO - 'LOGNAME': 'cltbld', 02:48:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:39 INFO - 'MOZ_NO_REMOTE': '1', 02:48:39 INFO - 'NO_EM_RESTART': '1', 02:48:39 INFO - 'PAGER': '/bin/cat', 02:48:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:39 INFO - 'PWD': '/builds/slave/test', 02:48:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:39 INFO - 'SHELL': '/bin/bash', 02:48:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UQv9SAorFM/Listeners', 02:48:39 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 02:48:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:39 INFO - 'USER': 'cltbld', 02:48:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:39 INFO - 'XPC_FLAGS': '0x0', 02:48:39 INFO - 'XPC_SERVICE_NAME': '0', 02:48:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:48:39 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-9p4pDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:48:39 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-OWfUAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:48:39 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-CuXE2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:48:39 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-3SiaaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:48:39 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-YcygaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:48:40 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-nnyipD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:48:40 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-0nC_lK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:48:40 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-lFppbt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:48:40 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-6rwisM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:48:40 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-6VfxK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:48:40 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-Ziqmo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:48:40 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-ZWo6l6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:48:40 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-5DL478-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:48:40 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-q_ky3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:41 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-lSS4mC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:48:41 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-SxsRtq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:48:41 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-2ZUoWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:48:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:48:41 INFO - Running setup.py install for manifestparser 02:48:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:48:41 INFO - Running setup.py install for mozcrash 02:48:41 INFO - Running setup.py install for mozdebug 02:48:41 INFO - Running setup.py install for mozdevice 02:48:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:48:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:48:41 INFO - Running setup.py install for mozfile 02:48:42 INFO - Running setup.py install for mozhttpd 02:48:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:48:42 INFO - Running setup.py install for mozinfo 02:48:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:48:42 INFO - Running setup.py install for mozInstall 02:48:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:48:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:48:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:48:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:48:42 INFO - Running setup.py install for mozleak 02:48:42 INFO - Running setup.py install for mozlog 02:48:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:48:42 INFO - Running setup.py install for moznetwork 02:48:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:48:42 INFO - Running setup.py install for mozprocess 02:48:43 INFO - Running setup.py install for mozprofile 02:48:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:48:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:48:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:48:43 INFO - Running setup.py install for mozrunner 02:48:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:48:43 INFO - Running setup.py install for mozscreenshot 02:48:43 INFO - Running setup.py install for moztest 02:48:43 INFO - Running setup.py install for mozversion 02:48:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:48:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:48:43 INFO - Cleaning up... 02:48:43 INFO - Return code: 0 02:48:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:48:43 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')]} 02:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:43 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')]} 02:48:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:43 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 0x10a51da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a52d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6b149b9e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3bce00>, '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 0x10a1e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a3b7b20>, '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.pp2NEngb2h/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.UQv9SAorFM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 02:48:43 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 02:48:43 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 02:48:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pp2NEngb2h/Render', 02:48:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:43 INFO - 'HOME': '/Users/cltbld', 02:48:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:43 INFO - 'LOGNAME': 'cltbld', 02:48:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:43 INFO - 'MOZ_NO_REMOTE': '1', 02:48:43 INFO - 'NO_EM_RESTART': '1', 02:48:43 INFO - 'PAGER': '/bin/cat', 02:48:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:43 INFO - 'PWD': '/builds/slave/test', 02:48:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:43 INFO - 'SHELL': '/bin/bash', 02:48:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UQv9SAorFM/Listeners', 02:48:43 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 02:48:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:43 INFO - 'USER': 'cltbld', 02:48:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:43 INFO - 'XPC_FLAGS': '0x0', 02:48:43 INFO - 'XPC_SERVICE_NAME': '0', 02:48:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:48:44 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-InTD6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:48:44 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)) 02:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:48:44 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-Igo2ZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:48:44 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)) 02:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:48:44 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-e6ZeU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:48:44 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)) 02:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:48:44 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-3QzC3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:48:44 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)) 02:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:48:44 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-9CqTG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:48:44 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)) 02:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:48:44 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-ziRz77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:48:44 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)) 02:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:48:44 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-fwIpI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:48:44 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)) 02:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:48:44 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-eS2hTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:48:45 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)) 02:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:48:45 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-e2ejlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:48:45 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)) 02:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:48:45 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-jeJJlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:48:45 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)) 02:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:48:45 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-6Qj_CH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:48:45 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)) 02:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:48:45 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-c9TBqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:48:45 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)) 02:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:48:45 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-3Ugn5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:48:45 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)) 02:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:48:45 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-fP26wQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:48:45 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)) 02:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:45 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-MYH9BV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:45 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)) 02:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:48:45 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-h6PhUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:48:45 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)) 02:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:48:45 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-8D5tzh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:48:46 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)) 02:48:46 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)) 02:48:46 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)) 02:48:46 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)) 02:48:46 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)) 02:48:46 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)) 02:48:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:48:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:48 INFO - Downloading blessings-1.6.tar.gz 02:48:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:48:48 INFO - Installing collected packages: blessings 02:48:48 INFO - Running setup.py install for blessings 02:48:48 INFO - Successfully installed blessings 02:48:48 INFO - Cleaning up... 02:48:48 INFO - Return code: 0 02:48:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:48:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:48:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:48:49 INFO - Reading from file tmpfile_stdout 02:48:49 INFO - Current package versions: 02:48:49 INFO - blessings == 1.6 02:48:49 INFO - blobuploader == 1.2.4 02:48:49 INFO - docopt == 0.6.1 02:48:49 INFO - manifestparser == 1.1 02:48:49 INFO - mozInstall == 1.12 02:48:49 INFO - mozcrash == 0.17 02:48:49 INFO - mozdebug == 0.1 02:48:49 INFO - mozdevice == 0.48 02:48:49 INFO - mozfile == 1.2 02:48:49 INFO - mozhttpd == 0.7 02:48:49 INFO - mozinfo == 0.9 02:48:49 INFO - mozleak == 0.1 02:48:49 INFO - mozlog == 3.1 02:48:49 INFO - moznetwork == 0.27 02:48:49 INFO - mozprocess == 0.22 02:48:49 INFO - mozprofile == 0.28 02:48:49 INFO - mozrunner == 6.11 02:48:49 INFO - mozscreenshot == 0.1 02:48:49 INFO - mozsystemmonitor == 0.0 02:48:49 INFO - moztest == 0.7 02:48:49 INFO - mozversion == 1.4 02:48:49 INFO - psutil == 3.1.1 02:48:49 INFO - requests == 1.2.3 02:48:49 INFO - wsgiref == 0.1.2 02:48:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:49 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 0x10a51da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a52d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6b149b9e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3bce00>, '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 0x10a1e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a3b7b20>, '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.pp2NEngb2h/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.UQv9SAorFM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 02:48:49 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 02:48:49 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 02:48:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pp2NEngb2h/Render', 02:48:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:49 INFO - 'HOME': '/Users/cltbld', 02:48:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:49 INFO - 'LOGNAME': 'cltbld', 02:48:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:49 INFO - 'MOZ_NO_REMOTE': '1', 02:48:49 INFO - 'NO_EM_RESTART': '1', 02:48:49 INFO - 'PAGER': '/bin/cat', 02:48:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:49 INFO - 'PWD': '/builds/slave/test', 02:48:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:49 INFO - 'SHELL': '/bin/bash', 02:48:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UQv9SAorFM/Listeners', 02:48:49 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 02:48:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:49 INFO - 'USER': 'cltbld', 02:48:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:49 INFO - 'XPC_FLAGS': '0x0', 02:48:49 INFO - 'XPC_SERVICE_NAME': '0', 02:48:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:49 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)) 02:48:49 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)) 02:48:49 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)) 02:48:49 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)) 02:48:49 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)) 02:48:49 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)) 02:48:49 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)) 02:48:49 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)) 02:48:49 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)) 02:48:49 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)) 02:48:49 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)) 02:48:49 INFO - Cleaning up... 02:48:49 INFO - Return code: 0 02:48:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:49 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 0x10a51da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a52d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6b149b9e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3bce00>, '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 0x10a1e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a3b7b20>, '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.pp2NEngb2h/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.UQv9SAorFM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 02:48:49 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 02:48:49 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 02:48:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pp2NEngb2h/Render', 02:48:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:49 INFO - 'HOME': '/Users/cltbld', 02:48:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:49 INFO - 'LOGNAME': 'cltbld', 02:48:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:49 INFO - 'MOZ_NO_REMOTE': '1', 02:48:49 INFO - 'NO_EM_RESTART': '1', 02:48:49 INFO - 'PAGER': '/bin/cat', 02:48:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:49 INFO - 'PWD': '/builds/slave/test', 02:48:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:49 INFO - 'SHELL': '/bin/bash', 02:48:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UQv9SAorFM/Listeners', 02:48:49 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 02:48:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:49 INFO - 'USER': 'cltbld', 02:48:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:49 INFO - 'XPC_FLAGS': '0x0', 02:48:49 INFO - 'XPC_SERVICE_NAME': '0', 02:48:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:49 INFO - Downloading/unpacking jsonschema 02:48:49 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 02:48:49 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 02:48:49 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 02:48:49 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 02:48:49 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 02:48:49 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 02:48:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:48:52 INFO - Downloading/unpacking functools32 (from jsonschema) 02:48:52 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 02:48:52 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 02:48:52 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 02:48:52 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 02:48:52 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 02:48:52 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 02:48:52 INFO - Downloading functools32-3.2.3-2.tar.gz 02:48:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:48:52 INFO - warning: no files found matching '*.txt' 02:48:52 INFO - no previously-included directories found matching 'build' 02:48:52 INFO - no previously-included directories found matching 'dist' 02:48:52 INFO - no previously-included directories found matching '.git*' 02:48:52 INFO - Installing collected packages: jsonschema, functools32 02:48:52 INFO - Running setup.py install for functools32 02:48:52 INFO - warning: no files found matching '*.txt' 02:48:52 INFO - no previously-included directories found matching 'build' 02:48:52 INFO - no previously-included directories found matching 'dist' 02:48:52 INFO - no previously-included directories found matching '.git*' 02:48:52 INFO - Successfully installed jsonschema functools32 02:48:52 INFO - Cleaning up... 02:48:52 INFO - Return code: 0 02:48:52 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:48:52 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')]} 02:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:52 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')]} 02:48:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:52 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 0x10a51da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a52d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6b149b9e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3bce00>, '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 0x10a1e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a3b7b20>, '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.pp2NEngb2h/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.UQv9SAorFM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 02:48:52 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 02:48:52 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 02:48:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pp2NEngb2h/Render', 02:48:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:52 INFO - 'HOME': '/Users/cltbld', 02:48:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:52 INFO - 'LOGNAME': 'cltbld', 02:48:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:52 INFO - 'MOZ_NO_REMOTE': '1', 02:48:52 INFO - 'NO_EM_RESTART': '1', 02:48:52 INFO - 'PAGER': '/bin/cat', 02:48:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:52 INFO - 'PWD': '/builds/slave/test', 02:48:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:52 INFO - 'SHELL': '/bin/bash', 02:48:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UQv9SAorFM/Listeners', 02:48:52 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 02:48:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:52 INFO - 'USER': 'cltbld', 02:48:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:52 INFO - 'XPC_FLAGS': '0x0', 02:48:52 INFO - 'XPC_SERVICE_NAME': '0', 02:48:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:53 INFO - Downloading/unpacking flake8 02:48: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 02:48: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 02:48: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 02:48: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 02:48: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 02:48: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 02:48:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:48:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:48:55 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 02:48:55 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 02:48:55 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 02:48:55 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 02:48:55 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 02:48:55 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 02:48:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:48:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:48:55 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 02:48:55 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 02:48:55 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 02:48:55 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 02:48:55 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 02:48:55 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 02:48:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:48: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 02:48: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 02:48: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 02:48: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 02:48: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 02:48: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 02:48:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:48:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:48:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:48:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:48:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:48:56 INFO - no previously-included directories found matching 'docs/_build' 02:48:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:48:56 INFO - Running setup.py install for pep8 02:48:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:48:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:48:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:48:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:48:57 INFO - no previously-included directories found matching 'docs/_build' 02:48:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:48:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:48:57 INFO - Cleaning up... 02:48:57 INFO - Return code: 0 02:48:57 INFO - Running post-action listener: _resource_record_post_action 02:48:57 INFO - Running post-action listener: _start_resource_monitoring 02:48:57 INFO - Starting resource monitoring. 02:48:57 INFO - ##### 02:48:57 INFO - ##### Running install step. 02:48:57 INFO - ##### 02:48:57 INFO - Running pre-action listener: _resource_record_pre_action 02:48:57 INFO - Running main action method: install 02:48:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:48:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:48:57 INFO - Reading from file tmpfile_stdout 02:48:57 INFO - Detecting whether we're running mozinstall >=1.0... 02:48:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:48:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:48:57 INFO - Reading from file tmpfile_stdout 02:48:57 INFO - Output received: 02:48:57 INFO - Usage: mozinstall [options] installer 02:48:57 INFO - Options: 02:48:57 INFO - -h, --help show this help message and exit 02:48:57 INFO - -d DEST, --destination=DEST 02:48:57 INFO - Directory to install application into. [default: 02:48:57 INFO - "/builds/slave/test"] 02:48:57 INFO - --app=APP Application being installed. [default: firefox] 02:48:57 INFO - mkdir: /builds/slave/test/build/application 02:48:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:48:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 02:49:31 INFO - Reading from file tmpfile_stdout 02:49:31 INFO - Output received: 02:49:31 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:49:31 INFO - Running post-action listener: _resource_record_post_action 02:49:31 INFO - ##### 02:49:31 INFO - ##### Running run-tests step. 02:49:31 INFO - ##### 02:49:31 INFO - Running pre-action listener: _resource_record_pre_action 02:49:31 INFO - Running main action method: run_tests 02:49:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:49:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:49:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:49:31 INFO - 2016-05-06 02:49:31.823 screenresolution[2240:13872] starting screenresolution argv=screenresolution get 02:49:31 INFO - 2016-05-06 02:49:31.825 screenresolution[2240:13872] Display 0: 1600x1200x32@60 02:49:31 INFO - 2016-05-06 02:49:31.831 screenresolution[2241:13874] starting screenresolution argv=screenresolution list 02:49:31 INFO - Available Modes on Display 0 02:49:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:49:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:49:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:49:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:49:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:49:32 INFO - Intel Iris: 02:49:32 INFO - Chipset Model: Intel Iris 02:49:32 INFO - Type: GPU 02:49:32 INFO - Bus: Built-In 02:49:32 INFO - VRAM (Dynamic, Max): 1536 MB 02:49:32 INFO - Vendor: Intel (0x8086) 02:49:32 INFO - Device ID: 0x0a2e 02:49:32 INFO - Revision ID: 0x0009 02:49:32 INFO - Displays: 02:49:32 INFO - Display: 02:49:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:49:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:49:32 INFO - Display Serial Number: 1600x1200 60 02:49:32 INFO - Main Display: Yes 02:49:32 INFO - Mirror: Off 02:49:32 INFO - Online: Yes 02:49:32 INFO - Rotation: Supported 02:49:32 INFO - Return code: 0 02:49:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:49:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:49:32 INFO - Python 2.7.3 02:49:32 INFO - Return code: 0 02:49:32 INFO - grabbing minidump binary from tooltool 02:49: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')]} 02:49: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 0x10a3bce00>, '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 0x10a1e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a3b7b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:49: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 02:49: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 02:49:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:49:32 INFO - Return code: 0 02:49:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:49:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:49:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:49:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:49:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:49:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:49:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:49:33 INFO - Return code: 0 02:49: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', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XErRLRsCRSS7zuYl6ulpcA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0114', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:49: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 --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XErRLRsCRSS7zuYl6ulpcA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0114 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:49:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pp2NEngb2h/Render', 02:49:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:49:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:49:33 INFO - 'HOME': '/Users/cltbld', 02:49:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:49:33 INFO - 'LOGNAME': 'cltbld', 02:49:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:49:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:49:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:33 INFO - 'MOZ_NO_REMOTE': '1', 02:49:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:49:33 INFO - 'NO_EM_RESTART': '1', 02:49:33 INFO - 'PAGER': '/bin/cat', 02:49:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:49:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:49:33 INFO - 'PWD': '/builds/slave/test', 02:49:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:49:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:49:33 INFO - 'SHELL': '/bin/bash', 02:49:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UQv9SAorFM/Listeners', 02:49:33 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 02:49:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:49:33 INFO - 'USER': 'cltbld', 02:49:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:49:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:49:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:33 INFO - 'XPC_FLAGS': '0x0', 02:49:33 INFO - 'XPC_SERVICE_NAME': '0', 02:49:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:49: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', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XErRLRsCRSS7zuYl6ulpcA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0114', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:49:33 INFO - mozversion application_buildid: 20160506002422 02:49:33 INFO - mozversion application_changeset: e65c3c2186710e9ee1dfb3f254bd45019ea34c80 02:49:33 INFO - mozversion application_display_name: Nightly 02:49:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:49:33 INFO - mozversion application_name: Firefox 02:49:33 INFO - mozversion application_remotingname: firefox 02:49:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:49:33 INFO - mozversion application_vendor: Mozilla 02:49:33 INFO - mozversion application_version: 49.0a1 02:49:33 INFO - mozversion platform_buildid: 20160506002422 02:49:33 INFO - mozversion platform_changeset: e65c3c2186710e9ee1dfb3f254bd45019ea34c80 02:49:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:49:33 INFO - mozversion platform_version: 49.0a1 02:49:33 INFO - using testdate: 1462528173 02:49:33 INFO - actual date: 1462528173 02:49:33 INFO - starting webserver on 'localhost:51046' 02:49:33 INFO - SUITE-START | Running 2 tests 02:49:33 INFO - TEST-START | dromaeo_css 02:49:33 INFO - operating with platform_type : mac_ 02:49:33 INFO - Initialising browser for dromaeo_css test... 02:49:33 INFO - TEST-INFO | started process 2259 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/tmpH_qdR_/profile http://localhost:51046/getInfo.html) 02:49:35 INFO - PROCESS | 2259 | __metrics Screen width/height:1600/1200 02:49:35 INFO - PROCESS | 2259 | colorDepth:24 02:49:35 INFO - PROCESS | 2259 | Browser inner width/height: 1024/689 02:49:35 INFO - PROCESS | 2259 | __metrics 02:49:35 INFO - PROCESS | 2259 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:49:35 ERROR - PROCESS | 2259 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:49:36 INFO - TEST-INFO | 2259: exit 0 02:49:36 INFO - Browser initialized. 02:49:36 INFO - Running cycle 1/1 for dromaeo_css test... 02:49:36 INFO - TEST-INFO | started process 2261 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/tmpH_qdR_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:49:48 INFO - PROCESS | 2261 | RSS: Main: 239042560 02:49:48 INFO - PROCESS | 2261 | 02:50:40 INFO - PROCESS | 2261 | 1462528240085 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] 02:52:50 INFO - PROCESS | 2261 | Cycle 1(1): loaded http://localhost:51046/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51046/tests/dromaeo/cssquery-ext.html) 02:52:52 INFO - PROCESS | 2261 | RSS: Main: 387358720 02:52:52 INFO - PROCESS | 2261 | 02:55:55 INFO - PROCESS | 2261 | Cycle 1(1): loaded http://localhost:51046/tests/dromaeo/cssquery-ext.html (next: http://localhost:51046/tests/dromaeo/cssquery-jquery.html) 02:55:56 INFO - PROCESS | 2261 | RSS: Main: 372035584 02:55:56 INFO - PROCESS | 2261 | 02:58:58 INFO - PROCESS | 2261 | Cycle 1(1): loaded http://localhost:51046/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51046/tests/dromaeo/cssquery-mootools.html) 02:58:59 INFO - PROCESS | 2261 | RSS: Main: 370102272 02:58:59 INFO - PROCESS | 2261 | 03:02:01 INFO - PROCESS | 2261 | Cycle 1(1): loaded http://localhost:51046/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51046/tests/dromaeo/cssquery-prototype.html) 03:02:02 INFO - PROCESS | 2261 | RSS: Main: 368947200 03:02:02 INFO - PROCESS | 2261 | 03:05:05 INFO - PROCESS | 2261 | Cycle 1(1): loaded http://localhost:51046/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51046/tests/dromaeo/cssquery-yui.html) 03:05:06 INFO - PROCESS | 2261 | RSS: Main: 345645056 03:05:06 INFO - PROCESS | 2261 | 03:08:09 INFO - PROCESS | 2261 | Cycle 1(1): loaded http://localhost:51046/tests/dromaeo/cssquery-yui.html (next: http://localhost:51046/tests/dromaeo/cssquery-dojo.html) 03:08:09 INFO - PROCESS | 2261 | RSS: Main: 383401984 03:08:09 INFO - PROCESS | 2261 | 03:08:09 INFO - PROCESS | 2261 | __start_tp_report 03:08:09 INFO - PROCESS | 2261 | _x_x_mozilla_page_load 03:08:09 INFO - PROCESS | 2261 | _x_x_mozilla_page_load_details 03:08:09 INFO - PROCESS | 2261 | |i|pagename|runs| 03:08:09 INFO - PROCESS | 2261 | |0;dojo.html;2987.3278512334728;3484.45990871415;3510.5962814276368;3518.8064656443894;3548.095235714892;4750.524947505248;5776.566757493194;5807.390224026474;5910.9064823007775;5946.2269904912355;5823.2138661280715;5897.941020589793;5915.704214789254;5922.733476993535;5950.88098238036;5271.1566149416;5312.229726689628;5356.303680521546;5357.357117145948;5404.83785486436;4537.228671125917;5156.736599533101;5395.649282796606;5399.649022813504;5403.7027963462;5262.210668399752;5299.682019078868;5318.202269659562;5333.653312534692;5394.973025134869;5362.088444964346;5396.865078373072;5401.78392864285;5404.351477822686;5428.4842939920645;5132.897342053176;5172.069027575035;5270.077736396115;5310.6813591184655;5312.521873031407;5636.267285252932;5666.5183459406;5673.943260567383;5723.941070901897;5761.481466667978;6293.056041593752;6304.148939893102;6314.652694101823;6323.93676063238;6329.303776584572;6144.832481828483;6204.162438070893;6271.843203919893;6289.339619339995;6295.7166927487915;6009.939900601025;6022.4638796103445;6026.819195424145;6049.455549000611;6066.726997285133;6345.333739957238;6371.553991220663;6373.968130159319;6376.489880809524;6385.2656944451055;6127.080937859357;6155.538334624921;6155.938440615626;6231.657258850807;6272;6181.443670069625;6202.34875338092;6248.4064013918605;6305.842353941096;6311.779087731908;6296.370362963758;6304.243490781136;6313.021481670348;6313.08460273267;6319.715612797435;6206.162168107338;6210.627362358183;6288.151099601587;6290.496760259169;6303.590266632654;4935.161022626162;4988.301637770715;4991.850244492671;5026.2460630904925;5068.493150684976;4513.661475389359;4548.135854187693;4566.429196350457;4573.016801387717;4575.26795712691;5835.941640583625;5856.765729370863;5872.031114865999;5874.089516125007;5882.1470886722045;6189.690515474208;6235.3452887446165;6241.75032998684;6258.15514905491;6265.373462653698;5967.403259673998;5969.641821490724;5970.850728731816;5972.761089556456;6008.459238668541;4767.022760334124;5504.504594586427;5518.310211223597;5536.640118392292;5537.7784888604;6259.7496100156395;6336.493080553545;6393.552451328363;6411.551191416556;6503.154589903283;6273.560850740404;6288.5283603728985;6288.937110628835;6294.433500984934;6302.243730752339;6228.252609686867;6475.449586785176;6486.805395838132;6491.513136514686;6494.220693516808;4961.925571116509;5369.785208591768;5890.14592884038;6225.595336303126;6274.560780745304;6265.561410701207;6279.120923070683;6293.276273228455;6299.149614801943;6317.084022816574;6112.969435152796;6129.693515324305;6178.969105154445;6225.968870155621;6282.497400207881;6181.227346581677;6274.090256912813;6288.685565721604;6294.71673774672;6300.464460520724;6152.169457123231;6170.074488826712;6175.104609831639;6184.907226391518;6192.783252586138;6027.36712645166;6170.660613666291;6203.2245969253845;6248.312685604489;6302.810915672537;6157.568970172045;6179.134921111138;6183.628982260899;6189.381061893775;6193.380661933951 03:08:09 INFO - PROCESS | 2261 | |1;ext.html;528.7620570743165;529.36740594989;532.1645017322804;553.535030574318;573.1832139201638;29771.553426698618;31137.377252454964;41503.79248103759;42797.93005174872;42952;43164.56835431645;43634;43652;43655;43724.56275437253;9614.230861531096;9793.314467987244;9803.950980245125;9813.313068085237;9821.852672209923;8654.697085602005;8858.424202426822;8864.955675221614;8870.600822962982;8915.375923685344;11568.190226684135;11832.290062596228;11843.7631247375;11962.581309654164;11967;11748;11851.88148118525;11855.407229638527;11861.762764744657;11866.881331186663;8695.217430431292;11438.02776763976;11631.76736465266;11763.764724705543;11772.234804737665;39283.21433571341;39530.40704389437;39672.80163599193;39715.40426893599;39802;3289.0626171541235;3303.3888730584918;3314.734821214297;3435.879744208941;3567.108222944264;25241.61171135587;27402.314942126406;27994.440111197866;28747;29040.12879613615;2703.675558932921;2704.445588654321;2738.52075886719;2904.4141343527144;2943.1611990582583;432375.8381208105;437384.81307593256;437484;437669;439927;55045.724771376685;55205;55275.723621381636;55342.44657553454;55346.16980745292;62034;62076.06885896715;62129.68935155295;62160;62182.68908655428;15099.320530576151;16752.49742507727;16957.745633815503;16992.57518562046;17007.31970721182;11855.525778968744;12180;12221.877781222074;12228.388580570936;13005.934970325277;15211.92394038045;15236.847631523542;15622.453214137451;15636.765448518281;15673.843261567466;5978.013627751459;6610.3720146586;6721.924492081243;6821.863562728718;6840.623765692934;921.7465197070725;931.1433481197315;940.7507010642186;952.5999080386255;1124.9100071994385;29119;29472.705272946994;29593.704062959525;30160.698393015788;30352.241193970327;1068.9144868410508;1080.2654195147375;1117.1621284036971;1121.8036843552345;1252.292454763056;15254.923725381524;15262.847371526143;15450.967921453292;15564.533064008097;15650.295736691876;622703.8864805738;634226;634368;635257;635607;58299;59666;59760.70119649461;59831;59862;1323.3780123342015;1369.2605992764195;1457.8760805331665;1478.150063713369;1506.3372116268806;30141.898570087946;30362.93729719449;30488.390232195674;30720.84639576788;30729.231769205948;49602.503974959785;50130.49869501258;50149.74925125351;50154.49845501498;50161.49838501714;472913;488610;488927;490153;490291;32497.187570309987;32660.020199394057;33422.99731008073;33455.83272083624;34598.65401345954;36322.91031269066;37798.81100594479;44768.328475072245;46004.7699761499;46102.53897460982;29834;35683;37412.06469838276;37983;38591.42112868253;29790;31832.68167318297;37413.43879841859;37795.81102094582;37940.62059379481;37025.44461833128;37276.6272337284;37690.623093768714;37735.62264377321;38235.61764382321;32635.673643263264;32698.83650581732;33195.83402082974;33279.667203327655;33332.833335833166;22386.66420003669;23880.094140963705;24213.03147874136;24455.38861528405;24748.133815316378 03:08:09 INFO - PROCESS | 2261 | |2;jquery.html;344.1499496244277;375.83651111766375;391.68860755699234;404.4762033167052;413.5533623686419;19517.707234391477;21764.238251661194;22350.10599576015;22669;22679.319620411392;20104.59790804183;21253;21273.787262127375;21491.67762483564;21981.23065692697;5196.908649183667;6077.179580756586;6137.877242455148;6146.938530614703;6148.508119350441;3868.825902834365;4068.572799856017;5710.371859095496;6059.121427393025;6061.817945500629;5195.246689230059;6093.238345206849;6097.939020609803;6099.237595300588;6101.115338275948;5834.56240781941;6068;6073.605215660968;6092.055731361646;6097.939020609803;3737.215184811193;5488;5818.796342128047;5822;5832.854178645525;13337.933310333483;13803;13915.58253252404;13925.23411212383;13967.161970281815;2049.252023011605;2091.7385326834146;2106.431263558846;2132.2110818996916;2206.768289329629;9236.953815230949;9729.951350243275;9762.658306959293;10141.13800326973;10277.383356998604;1662.1190768892507;1672.4230140601474;1709.9829001709948;1736.6540930778622;1819.654265689528;123660;132907;134646;139374.3031284837;140999;9542.666006689733;11635.650930472098;11680.94159529197;11705.88294117065;11828.112891532997;12628.494860205672;15397.99913005651;15399.23003849803;15413.922930385277;15451.150186739613;8536.914630853737;8797.428167169242;8799.648014079365;8927.24118449926;8956.731298061068;8768.25469835071;8779.780505487413;8799;8914.465132092095;8937.06160853101;3988.641022308006;4579;4647.326137710013;4659.697119687209;4717.95282047182;1747.867601526136;1758.516407987788;1770.1748575652387;1795.2639417838623;1901.4770937992164;923.2475532441039;925.5742358515024;959.2326139088701;981.7594689301167;1006.6527048168371;17080.658386832194;19490.805091949183;19931.903745293857;20565.50667846875;20642;900.104396125859;908.6728777640044;951.3007939164709;960.1742501448748;971.1745016735719;7249.927500725031;10669.946650266698;10838.295510791932;10888.61889833852;11007.834882476769;464463;610930;622292;628898;630423;133440.99838502432;143760.56239437472;145698;148121.2593937045;148955;862.7799911022774;895.7223260789046;968.3512046928574;1016.4714348538719;1017.59296281488;18385.172667230276;18622.72065918985;18632.97518636488;18704.158312876225;18921.337753178574;53066.2040069407;53617;54358;56058;57543.424565753805;67139.3286067133;79080.81378779208;79663.20336796557;80143;83913.58043209744;7762.068551773823;8006.959965200137;8064.637091331021;8218.301444377295;8452.197041281068;12478.563250286197;12636.55772047974;12658.403294788328;12670.049746269251;12789.872101278868;5340.51935325807;6496.350364963466;10747.570097196025;10900.07349375312;10972.341659500455;10543.42011189392;10812.243142979916;10855.402952837354;11048.447577621248;11116.666500005012;11018.944905275423;11239.269447485887;11347.37589432589;11374.374409407232;11563.710907227387;7991;8224.465409748347;8258.25675689191;8293.377996650155;8491.745247642333;8898.86651700238;9859.35914165577;10855;11407.486663100015;11499.770004600028 03:08:09 INFO - PROCESS | 2261 | |3;mootools.html;1342.630776536453;1609.227570766032;1633.9754903676444;1790.9820901790986;1851.9259229630816;7803.336716379107;8606.440581362214;8805.735827925173;8845.646174153035;8962.507062111581;8114.837703245947;8764.386492945496;8779.2537634301;8781.95609021954;8797.560121993907;2165.5993641176433;2245.079517397867;2248.9887550562307;2444.9144279950206;2475.7029156501244;2248.87631180285;2425.527022230666;2523.583608704571;2525.9747402526014;2538.0482319130324;2449.3876530867283;2467.728549859514;2489.2905521926255;2491.9875400623064;2497.8751062446895;2091.5816836632735;2141.625215587266;2412.0231306320966;2447.84089034214;2454.582720937436;2386.0455817672896;2445.2664200739705;2451.8161137914726;2463.48266863957;2466.5930121529927;8492.235698787077;8547.273481754059;8555.230029297392;8565.057843637194;8573.785655358604;5260.368755749297;5430.266913966603;5439.619226654136;5480.972595136999;5491.423400542965;3400.863965441379;3523.2953409317984;3651.703645205967;3666.578343490506;3681.0981309579056;1016.9745756356076;1039.880413752413;1041.2971244409994;1042.5256508288787;1047.1675018360422;11686.889745474165;11702.590409335717;11714.414279286002;11744;11744.295342279405;4234.9364759528635;4747.881302967454;4773.11697335994;4926.8768280793265;4936.851894443173;8386.454880432751;9900.801983960424;9907.900920990698;9916.80166396668;9952.452615106095;5436.782528698887;5470.890582188334;5478.890422191614;5483.835484935458;5484;4835.153848076572;4926.408830940239;4933.506649335038;4946.258061290835;5020.899582008339;3859.9228015439535;3866.7679939203736;3912.7456715313415;3935.2916475034194;3935.980320098381;1323.0474058677737;1329.6077657091182;1336.3051213368994;1348.4067010515341;1355.69496863205;809.1988930958427;836.8870202522703;879.520661239626;933.9439633622004;940.6172925799065;5777.88444231113;5819.272590926134;6003.6397816131175;6070.848228794315;6128.142060111588;973.6446197137993;976.0532283684814;985.2364417576435;990.5691024404407;1038.402918321968;3973.384125460558;4056.5213939827154;4069.5726948669962;4112.527059388209;4128.339465685476;10144.289899707097;10444.477776111164;10506.632267870587;10610.787784244272;10639.042486176126;10528.578856845794;10549.84175237372;10627.787444251226;10635.946820266005;10637.68086957377;7961.283484486308;8018.55897925608;8217.219364160395;8270.545120018456;8278.668853245923;5859.677717725566;5911.615744976562;5958.433948774859;5981;5993.3706960768495;9890.060444258072;9978.650747223812;9980.201583873419;10079.496025198565;10112.949435253071;8960.1935825776;9940.552675129782;10045.296829221885;10190.98090190975;10234.539445724811;5980.730867110903;6991.196012458429;6996.895046574204;7083.574985500681;7094;8109.75670729879;8133.918660813316;8152.103268640326;8212.17878212174;8212.753617391489;7335.816604584928;7369.410447164107;7448;7497.512661676974;7521.5111017783665;7028;7204.53170543913;7271;7273.781786546412;7427.7771666850085;6725.39471447572;6740.528163028541;6805.693743781443;6806.489513286424;6809.761658342132;4908.533689299511;4973.751312434436;5057.924131137962;5081.77132029067;5097.6941383517105;5002.299678045004;5030.698158110525;5109.1059064662795;5131.9486805132965;5215.191645294985 03:08:09 INFO - PROCESS | 2261 | |4;prototype.html;289.5526411693933;310.71724730495254;317.6601036890528;317.712470214456;321.93400352927654;5402.540784033357;5406.053940560396;5430.886668233013;5436.864078398037;5449.782008719647;4544.590986811187;4831.420229572447;5318.654287471311;5331.893362132755;5344.625876188668;3430;3871.399933010388;3972.682185425159;4123.670106391482;4126.89528340547;3563.968537933379;4013.8394464221396;4091.3453847384426;4105.692073094529;4119.629233368996;3468.497067925162;4028.6777057835448;4057.8376864925367;4072.857449989251;4107.691923105764;3246.853891574873;3850.26844899471;3879.4180872869156;3984.621460961204;4117.949922769704;2974.657914339857;3368.696817286456;3375.122468158272;3581.659742324475;3586.33652774235;4737.38414006177;5093.5415812576675;5099.541041306263;5129.153689641204;5158.845234642967;3992.960070399288;4320.675949303814;4419.204543182226;4654.277247810035;4717.268823332389;4907.705537667752;4924.679895806761;5429.077056900336;5599.708275679484;5656.519195868356;3166.9524957125664;3303.1081607965716;3882.611738826123;3885.747426417274;3902.512185976753;5270.338479068085;5430.782768689248;5893.351731309553;5914.852128696774;5922.437368449991;3669.743117981716;3892.2993861105274;3905.160390515996;3922.3920292354733;3936.1143742658246;3721.7394782364972;3739.7943113128495;3951.585083566242;3972.145988612462;3976.284268831638;4132.850917522871;4153.605407486284;4359.80380882861;4445.488768791565;4633.397658304399;5398.811041613525;5463.869091054492;5695.544356451557;5705.857353566194;5755.482006619341;1169.5964892112208;1262.6906407930117;1293.4373547506864;1305.7388522295578;1309.8886594639562;778.7274453941188;820.9409861279003;823.4770920465547;877.6050777150308;885.2475395913422;4750.95249047512;5071.290019397287;5133.921876405997;5177.870553236124;5185.196294574272;5406.756695948613;5457.426970168075;5757.65454072757;5848.2689663792025;5968.492678122321;4437.9348956250915;4450.065486247924;5037.773300201499;5298.940211957624;5302.3753242145385;2484.503099380131;2520.6849143857016;2622.645942797736;2955.852207389622;2985.1343110497714;4947.554720075139;5269.710165940834;5907.873165660359;5908.231929849092;5964.284285885635;5031.389955214369;5211.348581427322;5243.12731145604;5756.510696590753;5855.268091488564;4903.975480122648;5913.940860591425;5934.050551911673;5934.554908381889;5981;4851.393575803025;4948.901021979612;5685.886282274414;5691.7438715257085;5734.5125664319;4869.4400143982475;4896.92654610174;5263.763130659053;5308.309919710413;5582.599482222521;5426.945730542644;5681.119426488901;5808.419158084327;5872.265966754156;5896.611872191769;3025.0471101602925;3300.785448945811;3487.023633382657;3681.8711345102793;3737.6822970046765;5182.170852663556;5205.375354957429;5545.057340252248;5603.691796951207;5637.408072152365;4859.441164266154;5256.237845512455;5346.78612855497;5390.892182156256;5436.374816896107;4294.472401949082;4884.7069175849565;5127.743612819419;5349.277847490539;5376.596755243294;5075.923861142012;5271.947280527145;5306.257124002565;5331.546818520469;5347.786088556414;5284.873672537632;5297.8145764898045;5361.731913404236;5378.031954248273;5413;4443;5071.797128114834;5411.512963833116;5486.286782718221;5486.8203336282895 03:08:09 INFO - PROCESS | 2261 | |5;yui.html;622.81938237911;715.198977145597;745.9738909138181;756.3646536908997;797.1948332184492;14641.560753177408;15338.309776060076;15352.078875267493;15355.46255881043;15376;12250.571230006952;13894.652633684163;13935.860641393583;13962.511312104078;13973.371198296076;925.8240934222493;930.3208657679897;934.7756538430796;934.8177105464437;936.3819878879941;903.6972614174259;917.9311551633621;924.2098006204699;925.1211349218236;926.4858003807884;971.5093877591842;974.0211087856694;974.1768205866032;974.2108891797632;976.8046390721848;963.7397902566303;965.874436323277;968.394753279204;968.5157421289356;971.3152227679469;719.0652152202116;719.2986837833123;719.3597698048741;719.9244079371643;721.253502624786;13434;15074.24628768568;15097.54707358781;15107.471238506709;15119;11726.296422214695;12046.277223366626;12118.212316199419;12138.211016283913;12374.505019799197;9066.365354425192;10810.405427701473;10937.343759374464;11185.440727963569;11316.094712422986;3950.822213000422;4041.1109555897656;4043.8382464701376;4095.5494895561465;4162.791860406998;57522.849543009324;60110;66584.6683066336;75972.62013689896;82530.17469825345;9365.765855853659;9434.575444105032;9526.809463810685;9833.803323933482;9936.304458687822;21091.9454027298;21105.89447052755;21110.155593776384;21113.41649376272;21118.47203819917;7444.292792184734;7566.621668916532;7573.318401343906;7654.655540500691;7664.540127592362;4040.1717647882115;4118.5057793065025;4126.319157339006;4128.504579450485;4138.5861413858975;3505.77212481193;3588.7618771523785;3594.730395220369;3597.37046016946;3602.8919132426067;636.1030946365602;656.0716586030713;657.1161787395945;663.141232104426;667.4060086522999;521.474686541871;561.2983770287141;562.4684672983991;604.2778879239266;606.9119977603311;7936.444448888522;7975.880361794578;8316.958415207886;8378.748637540884;8404.873926891101;463.2865387303582;498.63421902160417;538.3163382504198;540.3461811208482;577.9219805326227;3211.405889910374;3844.557875844314;3846.8461261549783;4099.651529619956;4108;86885.56557217173;90244.5487772557;90719.09280907239;91193.54403227942;92517.53741231251;66714.66642666755;80170;80380.59809700915;81381.77927331095;82529;64288.678556606916;68421;69567.65216173886;70880.29119708737;71652;8124.390670699603;8219.013718353835;8351.582420879053;8386.161383861809;8427.410081294496;41581.79209103935;41990.790046050795;42688.78655606702;42785.50250741209;44009.55990440054;54507;56146;56187.87624247574;56332;56451.15323270072;9147.862782058408;10875.456227188768;11267.605633802777;11348.659540213806;11403.144764142888;11893.464794084113;11929.463174157358;12151.210171338835;12152;12338.938305308417;11327.093832493545;11375.886241137483;11406.657800266004;11450.198486105892;11759.706007349885;10339.276250662382;10525.684229473129;10847.78304433891;11457.312561246352;11504.25222360544;10982.286151400134;11348.421424624934;11452.31286122802;11497.827532587185;11611.5355385787;9225.861612075958;9277.582508787256;9401.435913845191;9468.763280918032;9811.55847986828;9440.433573985583;9611.509651611264;9678.27412944046;9744.269179811685;9824.65613703517 03:08:09 INFO - PROCESS | 2261 | __end_tp_report 03:08:09 INFO - PROCESS | 2261 | __start_cc_report 03:08:09 INFO - PROCESS | 2261 | _x_x_mozilla_cycle_collect,1384 03:08:09 INFO - PROCESS | 2261 | __end_cc_report 03:08:09 INFO - PROCESS | 2261 | __startTimestamp1462529289502__endTimestamp 03:08:09 INFO - PROCESS | 2261 | 03:08:09 INFO - PROCESS | 2261 | ------- Summary: start ------- 03:08:09 INFO - PROCESS | 2261 | Number of tests: 6 03:08:09 INFO - PROCESS | 2261 | 03:08:09 INFO - PROCESS | 2261 | [#0] dojo.html Cycles:165 Average:5825.46 Median:6144.83 stddev:655.62 (10.7%) stddev-sans-first:618.67 03:08:09 INFO - PROCESS | 2261 | Values: 2987.3 3484.5 3510.6 3518.8 3548.1 4750.5 5776.6 5807.4 5910.9 5946.2 5823.2 5897.9 5915.7 5922.7 5950.9 5271.2 5312.2 5356.3 5357.4 5404.8 4537.2 5156.7 5395.6 5399.6 5403.7 5262.2 5299.7 5318.2 5333.7 5395.0 5362.1 5396.9 5401.8 5404.4 5428.5 5132.9 5172.1 5270.1 5310.7 5312.5 5636.3 5666.5 5673.9 5723.9 5761.5 6293.1 6304.1 6314.7 6323.9 6329.3 6144.8 6204.2 6271.8 6289.3 6295.7 6009.9 6022.5 6026.8 6049.5 6066.7 6345.3 6371.6 6374.0 6376.5 6385.3 6127.1 6155.5 6155.9 6231.7 6272.0 6181.4 6202.3 6248.4 6305.8 6311.8 6296.4 6304.2 6313.0 6313.1 6319.7 6206.2 6210.6 6288.2 6290.5 6303.6 4935.2 4988.3 4991.9 5026.2 5068.5 4513.7 4548.1 4566.4 4573.0 4575.3 5835.9 5856.8 5872.0 5874.1 5882.1 6189.7 6235.3 6241.8 6258.2 6265.4 5967.4 5969.6 5970.9 5972.8 6008.5 4767.0 5504.5 5518.3 5536.6 5537.8 6259.7 6336.5 6393.6 6411.6 6503.2 6273.6 6288.5 6288.9 6294.4 6302.2 6228.3 6475.4 6486.8 6491.5 6494.2 4961.9 5369.8 5890.1 6225.6 6274.6 6265.6 6279.1 6293.3 6299.1 6317.1 6113.0 6129.7 6179.0 6226.0 6282.5 6181.2 6274.1 6288.7 6294.7 6300.5 6152.2 6170.1 6175.1 6184.9 6192.8 6027.4 6170.7 6203.2 6248.3 6302.8 6157.6 6179.1 6183.6 6189.4 6193.4 03:08:09 INFO - PROCESS | 2261 | 03:08:09 INFO - PROCESS | 2261 | [#1] ext.html Cycles:180 Average:65613.06 Median:36002.96 stddev:140121.27 (389.2%) stddev-sans-first:140429.14 03:08:09 INFO - PROCESS | 2261 | Values: 528.8 529.4 532.2 553.5 573.2 29771.6 31137.4 41503.8 42797.9 42952.0 43164.6 43634.0 43652.0 43655.0 43724.6 9614.2 9793.3 9804.0 9813.3 9821.9 8654.7 8858.4 8865.0 8870.6 8915.4 11568.2 11832.3 11843.8 11962.6 11967.0 11748.0 11851.9 11855.4 11861.8 11866.9 8695.2 11438.0 11631.8 11763.8 11772.2 39283.2 39530.4 39672.8 39715.4 39802.0 3289.1 3303.4 3314.7 3435.9 3567.1 25241.6 27402.3 27994.4 28747.0 29040.1 2703.7 2704.4 2738.5 2904.4 2943.2 432375.8 437384.8 437484.0 437669.0 439927.0 55045.7 55205.0 55275.7 55342.4 55346.2 62034.0 62076.1 62129.7 62160.0 62182.7 15099.3 16752.5 16957.7 16992.6 17007.3 11855.5 12180.0 12221.9 12228.4 13005.9 15211.9 15236.8 15622.5 15636.8 15673.8 5978.0 6610.4 6721.9 6821.9 6840.6 921.7 931.1 940.8 952.6 1124.9 29119.0 29472.7 29593.7 30160.7 30352.2 1068.9 1080.3 1117.2 1121.8 1252.3 15254.9 15262.8 15451.0 15564.5 15650.3 622703.9 634226.0 634368.0 635257.0 635607.0 58299.0 59666.0 59760.7 59831.0 59862.0 1323.4 1369.3 1457.9 1478.2 1506.3 30141.9 30362.9 30488.4 30720.8 30729.2 49602.5 50130.5 50149.7 50154.5 50161.5 472913.0 488610.0 488927.0 490153.0 490291.0 32497.2 32660.0 33423.0 33455.8 34598.7 36322.9 37798.8 44768.3 46004.8 46102.5 29834.0 35683.0 37412.1 37983.0 38591.4 29790.0 31832.7 37413.4 37795.8 37940.6 37025.4 37276.6 37690.6 37735.6 38235.6 32635.7 32698.8 33195.8 33279.7 33332.8 22386.7 23880.1 24213.0 24455.4 24748.1 03:08:09 INFO - PROCESS | 2261 | 03:08:09 INFO - PROCESS | 2261 | [#2] jquery.html Cycles:180 Average:35381.21 Median:2056.53 stddev:100311.47 (4877.7%) stddev-sans-first:100558.37 03:08:09 INFO - PROCESS | 2261 | Values: 344.1 375.8 391.7 404.5 413.6 19517.7 21764.2 22350.1 22669.0 22679.3 20104.6 21253.0 21273.8 21491.7 21981.2 5196.9 6077.2 6137.9 6146.9 6148.5 3868.8 4068.6 5710.4 6059.1 6061.8 5195.2 6093.2 6097.9 6099.2 6101.1 5834.6 6068.0 6073.6 6092.1 6097.9 3737.2 5488.0 5818.8 5822.0 5832.9 13337.9 13803.0 13915.6 13925.2 13967.2 2049.3 2091.7 2106.4 2132.2 2206.8 9237.0 9730.0 9762.7 10141.1 10277.4 1662.1 1672.4 1710.0 1736.7 1819.7 123660.0 132907.0 134646.0 139374.3 140999.0 9542.7 11635.7 11680.9 11705.9 11828.1 12628.5 15398.0 15399.2 15413.9 15451.2 8536.9 8797.4 8799.6 8927.2 8956.7 8768.3 8779.8 8799.0 8914.5 8937.1 3988.6 4579.0 4647.3 4659.7 4718.0 1747.9 1758.5 1770.2 1795.3 1901.5 923.2 925.6 959.2 981.8 1006.7 17080.7 19490.8 19931.9 20565.5 20642.0 900.1 908.7 951.3 960.2 971.2 7249.9 10669.9 10838.3 10888.6 11007.8 464463.0 610930.0 622292.0 628898.0 630423.0 133441.0 143760.6 145698.0 148121.3 148955.0 862.8 895.7 968.4 1016.5 1017.6 18385.2 18622.7 18633.0 18704.2 18921.3 53066.2 53617.0 54358.0 56058.0 57543.4 67139.3 79080.8 79663.2 80143.0 83913.6 7762.1 8007.0 8064.6 8218.3 8452.2 12478.6 12636.6 12658.4 12670.0 12789.9 5340.5 6496.4 10747.6 10900.1 10972.3 10543.4 10812.2 10855.4 11048.4 11116.7 11018.9 11239.3 11347.4 11374.4 11563.7 7991.0 8224.5 8258.3 8293.4 8491.7 8898.9 9859.4 10855.0 11407.5 11499.8 03:08:09 INFO - PROCESS | 2261 | 03:08:09 INFO - PROCESS | 2261 | [#3] mootools.html Cycles:180 Average:5685.93 Median:5069.85 stddev:3129.94 (61.7%) stddev-sans-first:3121.70 03:08:09 INFO - PROCESS | 2261 | Values: 1342.6 1609.2 1634.0 1791.0 1851.9 7803.3 8606.4 8805.7 8845.6 8962.5 8114.8 8764.4 8779.3 8782.0 8797.6 2165.6 2245.1 2249.0 2444.9 2475.7 2248.9 2425.5 2523.6 2526.0 2538.0 2449.4 2467.7 2489.3 2492.0 2497.9 2091.6 2141.6 2412.0 2447.8 2454.6 2386.0 2445.3 2451.8 2463.5 2466.6 8492.2 8547.3 8555.2 8565.1 8573.8 5260.4 5430.3 5439.6 5481.0 5491.4 3400.9 3523.3 3651.7 3666.6 3681.1 1017.0 1039.9 1041.3 1042.5 1047.2 11686.9 11702.6 11714.4 11744.0 11744.3 4234.9 4747.9 4773.1 4926.9 4936.9 8386.5 9900.8 9907.9 9916.8 9952.5 5436.8 5470.9 5478.9 5483.8 5484.0 4835.2 4926.4 4933.5 4946.3 5020.9 3859.9 3866.8 3912.7 3935.3 3936.0 1323.0 1329.6 1336.3 1348.4 1355.7 809.2 836.9 879.5 933.9 940.6 5777.9 5819.3 6003.6 6070.8 6128.1 973.6 976.1 985.2 990.6 1038.4 3973.4 4056.5 4069.6 4112.5 4128.3 10144.3 10444.5 10506.6 10610.8 10639.0 10528.6 10549.8 10627.8 10635.9 10637.7 7961.3 8018.6 8217.2 8270.5 8278.7 5859.7 5911.6 5958.4 5981.0 5993.4 9890.1 9978.7 9980.2 10079.5 10112.9 8960.2 9940.6 10045.3 10191.0 10234.5 5980.7 6991.2 6996.9 7083.6 7094.0 8109.8 8133.9 8152.1 8212.2 8212.8 7335.8 7369.4 7448.0 7497.5 7521.5 7028.0 7204.5 7271.0 7273.8 7427.8 6725.4 6740.5 6805.7 6806.5 6809.8 4908.5 4973.8 5057.9 5081.8 5097.7 5002.3 5030.7 5109.1 5131.9 5215.2 03:08:09 INFO - PROCESS | 2261 | 03:08:09 INFO - PROCESS | 2261 | [#4] prototype.html Cycles:180 Average:4446.56 Median:5071.54 stddev:1384.86 (27.3%) stddev-sans-first:1353.14 03:08:09 INFO - PROCESS | 2261 | Values: 289.6 310.7 317.7 317.7 321.9 5402.5 5406.1 5430.9 5436.9 5449.8 4544.6 4831.4 5318.7 5331.9 5344.6 3430.0 3871.4 3972.7 4123.7 4126.9 3564.0 4013.8 4091.3 4105.7 4119.6 3468.5 4028.7 4057.8 4072.9 4107.7 3246.9 3850.3 3879.4 3984.6 4117.9 2974.7 3368.7 3375.1 3581.7 3586.3 4737.4 5093.5 5099.5 5129.2 5158.8 3993.0 4320.7 4419.2 4654.3 4717.3 4907.7 4924.7 5429.1 5599.7 5656.5 3167.0 3303.1 3882.6 3885.7 3902.5 5270.3 5430.8 5893.4 5914.9 5922.4 3669.7 3892.3 3905.2 3922.4 3936.1 3721.7 3739.8 3951.6 3972.1 3976.3 4132.9 4153.6 4359.8 4445.5 4633.4 5398.8 5463.9 5695.5 5705.9 5755.5 1169.6 1262.7 1293.4 1305.7 1309.9 778.7 820.9 823.5 877.6 885.2 4751.0 5071.3 5133.9 5177.9 5185.2 5406.8 5457.4 5757.7 5848.3 5968.5 4437.9 4450.1 5037.8 5298.9 5302.4 2484.5 2520.7 2622.6 2955.9 2985.1 4947.6 5269.7 5907.9 5908.2 5964.3 5031.4 5211.3 5243.1 5756.5 5855.3 4904.0 5913.9 5934.1 5934.6 5981.0 4851.4 4948.9 5685.9 5691.7 5734.5 4869.4 4896.9 5263.8 5308.3 5582.6 5426.9 5681.1 5808.4 5872.3 5896.6 3025.0 3300.8 3487.0 3681.9 3737.7 5182.2 5205.4 5545.1 5603.7 5637.4 4859.4 5256.2 5346.8 5390.9 5436.4 4294.5 4884.7 5127.7 5349.3 5376.6 5075.9 5271.9 5306.3 5331.5 5347.8 5284.9 5297.8 5361.7 5378.0 5413.0 4443.0 5071.8 5411.5 5486.3 5486.8 03:08:09 INFO - PROCESS | 2261 | 03:08:09 INFO - PROCESS | 2261 | [#5] yui.html Cycles:180 Average:17335.14 Median:29050.39 stddev:23936.68 (82.4%) stddev-sans-first:23970.94 03:08:09 INFO - PROCESS | 2261 | Values: 622.8 715.2 746.0 756.4 797.2 14641.6 15338.3 15352.1 15355.5 15376.0 12250.6 13894.7 13935.9 13962.5 13973.4 925.8 930.3 934.8 934.8 936.4 903.7 917.9 924.2 925.1 926.5 971.5 974.0 974.2 974.2 976.8 963.7 965.9 968.4 968.5 971.3 719.1 719.3 719.4 719.9 721.3 13434.0 15074.2 15097.5 15107.5 15119.0 11726.3 12046.3 12118.2 12138.2 12374.5 9066.4 10810.4 10937.3 11185.4 11316.1 3950.8 4041.1 4043.8 4095.5 4162.8 57522.8 60110.0 66584.7 75972.6 82530.2 9365.8 9434.6 9526.8 9833.8 9936.3 21091.9 21105.9 21110.2 21113.4 21118.5 7444.3 7566.6 7573.3 7654.7 7664.5 4040.2 4118.5 4126.3 4128.5 4138.6 3505.8 3588.8 3594.7 3597.4 3602.9 636.1 656.1 657.1 663.1 667.4 521.5 561.3 562.5 604.3 606.9 7936.4 7975.9 8317.0 8378.7 8404.9 463.3 498.6 538.3 540.3 577.9 3211.4 3844.6 3846.8 4099.7 4108.0 86885.6 90244.5 90719.1 91193.5 92517.5 66714.7 80170.0 80380.6 81381.8 82529.0 64288.7 68421.0 69567.7 70880.3 71652.0 8124.4 8219.0 8351.6 8386.2 8427.4 41581.8 41990.8 42688.8 42785.5 44009.6 54507.0 56146.0 56187.9 56332.0 56451.2 9147.9 10875.5 11267.6 11348.7 11403.1 11893.5 11929.5 12151.2 12152.0 12338.9 11327.1 11375.9 11406.7 11450.2 11759.7 10339.3 10525.7 10847.8 11457.3 11504.3 10982.3 11348.4 11452.3 11497.8 11611.5 9225.9 9277.6 9401.4 9468.8 9811.6 9440.4 9611.5 9678.3 9744.3 9824.7 03:08:09 INFO - PROCESS | 2261 | -------- Summary: end -------- 03:08:09 INFO - PROCESS | 2261 | 03:08:10 INFO - TEST-INFO | 2261: exit 0 03:08:10 INFO - TEST-OK | dromaeo_css | took 1116649ms 03:08:10 INFO - TEST-START | kraken 03:08:10 INFO - operating with platform_type : mac_ 03:08:10 INFO - Initialising browser for kraken test... 03:08:10 INFO - TEST-INFO | started process 2264 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/tmpGEOGzH/profile http://localhost:51046/getInfo.html) 03:08:12 INFO - PROCESS | 2264 | __metrics Screen width/height:1600/1200 03:08:12 INFO - PROCESS | 2264 | colorDepth:24 03:08:12 INFO - PROCESS | 2264 | Browser inner width/height: 1024/689 03:08:12 INFO - PROCESS | 2264 | __metrics 03:08:12 INFO - PROCESS | 2264 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:08:12 ERROR - PROCESS | 2264 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:08:13 INFO - TEST-INFO | 2264: exit 0 03:08:13 INFO - Browser initialized. 03:08:13 INFO - Running cycle 1/1 for kraken test... 03:08:13 INFO - TEST-INFO | started process 2266 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/tmpGEOGzH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:08:25 INFO - PROCESS | 2266 | RSS: Main: 239263744 03:08:25 INFO - PROCESS | 2266 | 03:08:27 INFO - PROCESS | 2266 | Cycle 1(1): loaded http://localhost:51046/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51046/tests/kraken/driver.html?testName=audio-beat-detection) 03:08:28 INFO - PROCESS | 2266 | RSS: Main: 286826496 03:08:28 INFO - PROCESS | 2266 | 03:08:31 INFO - PROCESS | 2266 | Cycle 1(1): loaded http://localhost:51046/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51046/tests/kraken/driver.html?testName=audio-dft) 03:08:31 INFO - PROCESS | 2266 | RSS: Main: 295694336 03:08:31 INFO - PROCESS | 2266 | 03:08:35 INFO - PROCESS | 2266 | Cycle 1(1): loaded http://localhost:51046/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51046/tests/kraken/driver.html?testName=audio-fft) 03:08:36 INFO - PROCESS | 2266 | RSS: Main: 384249856 03:08:36 INFO - PROCESS | 2266 | 03:08:38 INFO - PROCESS | 2266 | Cycle 1(1): loaded http://localhost:51046/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51046/tests/kraken/driver.html?testName=audio-oscillator) 03:08:38 INFO - PROCESS | 2266 | RSS: Main: 282378240 03:08:38 INFO - PROCESS | 2266 | 03:08:40 INFO - PROCESS | 2266 | Cycle 1(1): loaded http://localhost:51046/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51046/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:08:41 INFO - PROCESS | 2266 | RSS: Main: 285749248 03:08:41 INFO - PROCESS | 2266 | 03:08:44 INFO - PROCESS | 2266 | Cycle 1(1): loaded http://localhost:51046/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51046/tests/kraken/driver.html?testName=imaging-darkroom) 03:08:44 INFO - PROCESS | 2266 | RSS: Main: 322158592 03:08:44 INFO - PROCESS | 2266 | 03:08:47 INFO - PROCESS | 2266 | Cycle 1(1): loaded http://localhost:51046/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51046/tests/kraken/driver.html?testName=imaging-desaturate) 03:08:48 INFO - PROCESS | 2266 | RSS: Main: 324603904 03:08:48 INFO - PROCESS | 2266 | 03:08:51 INFO - PROCESS | 2266 | Cycle 1(1): loaded http://localhost:51046/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51046/tests/kraken/driver.html?testName=json-parse-financial) 03:08:52 INFO - PROCESS | 2266 | RSS: Main: 323362816 03:08:52 INFO - PROCESS | 2266 | 03:08:53 INFO - PROCESS | 2266 | Cycle 1(1): loaded http://localhost:51046/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51046/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:08:54 INFO - PROCESS | 2266 | RSS: Main: 314777600 03:08:54 INFO - PROCESS | 2266 | 03:08:56 INFO - PROCESS | 2266 | Cycle 1(1): loaded http://localhost:51046/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51046/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:08:56 INFO - PROCESS | 2266 | RSS: Main: 322355200 03:08:56 INFO - PROCESS | 2266 | 03:08:59 INFO - PROCESS | 2266 | Cycle 1(1): loaded http://localhost:51046/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51046/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:08:59 INFO - PROCESS | 2266 | RSS: Main: 324083712 03:08:59 INFO - PROCESS | 2266 | 03:09:02 INFO - PROCESS | 2266 | Cycle 1(1): loaded http://localhost:51046/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51046/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:09:03 INFO - PROCESS | 2266 | RSS: Main: 328548352 03:09:03 INFO - PROCESS | 2266 | 03:09:06 INFO - PROCESS | 2266 | Cycle 1(1): loaded http://localhost:51046/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51046/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:09:06 INFO - PROCESS | 2266 | RSS: Main: 325931008 03:09:06 INFO - PROCESS | 2266 | 03:09:08 INFO - PROCESS | 2266 | Cycle 1(1): loaded http://localhost:51046/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51046/tests/kraken/driver.html?testName=ai-astar) 03:09:08 INFO - PROCESS | 2266 | RSS: Main: 372379648 03:09:08 INFO - PROCESS | 2266 | 03:09:08 INFO - PROCESS | 2266 | __start_tp_report 03:09:08 INFO - PROCESS | 2266 | _x_x_mozilla_page_load 03:09:08 INFO - PROCESS | 2266 | _x_x_mozilla_page_load_details 03:09:08 INFO - PROCESS | 2266 | |i|pagename|runs| 03:09:08 INFO - PROCESS | 2266 | |0;ai-astar;113;106;111;112;112;114;114;113;114;111 03:09:08 INFO - PROCESS | 2266 | |1;audio-beat-detection;155;118;149;183;118;132;156;139;198;116 03:09:08 INFO - PROCESS | 2266 | |2;audio-dft;194;253;206;188;185;186;186;187;182;182 03:09:08 INFO - PROCESS | 2266 | |3;audio-fft;81;74;58;108;57;64;57;58;114;55 03:09:08 INFO - PROCESS | 2266 | |4;audio-oscillator;93;97;101;80;81;77;102;80;83;102 03:09:08 INFO - PROCESS | 2266 | |5;imaging-gaussian-blur;90;87;89;89;89;87;91;86;90;71 03:09:08 INFO - PROCESS | 2266 | |6;imaging-darkroom;93;94;94;97;94;94;94;94;100;142 03:09:08 INFO - PROCESS | 2266 | |7;imaging-desaturate;85;86;97;137;70;129;139;129;86;85 03:09:08 INFO - PROCESS | 2266 | |8;json-parse-financial;59;58;60;58;57;58;61;80;59;57 03:09:08 INFO - PROCESS | 2266 | |9;json-stringify-tinderbox;66;72;78;77;72;71;68;71;67;76 03:09:08 INFO - PROCESS | 2266 | |10;stanford-crypto-aes;86;86;88;85;85;85;87;85;85;84 03:09:08 INFO - PROCESS | 2266 | |11;stanford-crypto-ccm;140;136;141;137;136;149;147;147;177;145 03:09:08 INFO - PROCESS | 2266 | |12;stanford-crypto-pbkdf2;168;168;165;217;167;169;169;166;161;166 03:09:08 INFO - PROCESS | 2266 | |13;stanford-crypto-sha256-iterative;69;67;67;69;66;67;65;65;65;65 03:09:08 INFO - PROCESS | 2266 | __end_tp_report 03:09:08 INFO - PROCESS | 2266 | __start_cc_report 03:09:08 INFO - PROCESS | 2266 | _x_x_mozilla_cycle_collect,2088 03:09:08 INFO - PROCESS | 2266 | __end_cc_report 03:09:08 INFO - PROCESS | 2266 | __startTimestamp1462529348750__endTimestamp 03:09:08 INFO - PROCESS | 2266 | 03:09:08 INFO - PROCESS | 2266 | ------- Summary: start ------- 03:09:08 INFO - PROCESS | 2266 | Number of tests: 14 03:09:08 INFO - PROCESS | 2266 | 03:09:08 INFO - PROCESS | 2266 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:2.40 (2.1%) stddev-sans-first:2.52 03:09:08 INFO - PROCESS | 2266 | Values: 113.0 106.0 111.0 112.0 112.0 114.0 114.0 113.0 114.0 111.0 03:09:08 INFO - PROCESS | 2266 | 03:09:08 INFO - PROCESS | 2266 | [#1] audio-beat-detection Cycles:10 Average:146.40 Median:152.00 stddev:27.84 (18.3%) stddev-sans-first:29.35 03:09:08 INFO - PROCESS | 2266 | Values: 155.0 118.0 149.0 183.0 118.0 132.0 156.0 139.0 198.0 116.0 03:09:08 INFO - PROCESS | 2266 | 03:09:08 INFO - PROCESS | 2266 | [#2] audio-dft Cycles:10 Average:194.90 Median:187.50 stddev:21.60 (11.5%) stddev-sans-first:22.91 03:09:08 INFO - PROCESS | 2266 | Values: 194.0 253.0 206.0 188.0 185.0 186.0 186.0 187.0 182.0 182.0 03:09:08 INFO - PROCESS | 2266 | 03:09:08 INFO - PROCESS | 2266 | [#3] audio-fft Cycles:10 Average:72.60 Median:58.00 stddev:21.95 (37.8%) stddev-sans-first:23.07 03:09:08 INFO - PROCESS | 2266 | Values: 81.0 74.0 58.0 108.0 57.0 64.0 57.0 58.0 114.0 55.0 03:09:08 INFO - PROCESS | 2266 | 03:09:08 INFO - PROCESS | 2266 | [#4] audio-oscillator Cycles:10 Average:89.60 Median:80.50 stddev:10.35 (12.9%) stddev-sans-first:10.91 03:09:08 INFO - PROCESS | 2266 | Values: 93.0 97.0 101.0 80.0 81.0 77.0 102.0 80.0 83.0 102.0 03:09:08 INFO - PROCESS | 2266 | 03:09:08 INFO - PROCESS | 2266 | [#5] imaging-gaussian-blur Cycles:10 Average:86.90 Median:89.00 stddev:5.80 (6.5%) stddev-sans-first:6.04 03:09:08 INFO - PROCESS | 2266 | Values: 90.0 87.0 89.0 89.0 89.0 87.0 91.0 86.0 90.0 71.0 03:09:08 INFO - PROCESS | 2266 | 03:09:08 INFO - PROCESS | 2266 | [#6] imaging-darkroom Cycles:10 Average:99.60 Median:94.00 stddev:15.04 (16.0%) stddev-sans-first:15.76 03:09:08 INFO - PROCESS | 2266 | Values: 93.0 94.0 94.0 97.0 94.0 94.0 94.0 94.0 100.0 142.0 03:09:08 INFO - PROCESS | 2266 | 03:09:08 INFO - PROCESS | 2266 | [#7] imaging-desaturate Cycles:10 Average:104.30 Median:85.00 stddev:26.12 (30.7%) stddev-sans-first:26.75 03:09:08 INFO - PROCESS | 2266 | Values: 85.0 86.0 97.0 137.0 70.0 129.0 139.0 129.0 86.0 85.0 03:09:08 INFO - PROCESS | 2266 | 03:09:08 INFO - PROCESS | 2266 | [#8] json-parse-financial Cycles:10 Average:60.70 Median:59.00 stddev:6.90 (11.7%) stddev-sans-first:7.29 03:09:08 INFO - PROCESS | 2266 | Values: 59.0 58.0 60.0 58.0 57.0 58.0 61.0 80.0 59.0 57.0 03:09:08 INFO - PROCESS | 2266 | 03:09:08 INFO - PROCESS | 2266 | [#9] json-stringify-tinderbox Cycles:10 Average:71.80 Median:72.00 stddev:4.16 (5.8%) stddev-sans-first:3.84 03:09:08 INFO - PROCESS | 2266 | Values: 66.0 72.0 78.0 77.0 72.0 71.0 68.0 71.0 67.0 76.0 03:09:08 INFO - PROCESS | 2266 | 03:09:08 INFO - PROCESS | 2266 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:85.50 stddev:1.17 (1.4%) stddev-sans-first:1.24 03:09:08 INFO - PROCESS | 2266 | Values: 86.0 86.0 88.0 85.0 85.0 85.0 87.0 85.0 85.0 84.0 03:09:08 INFO - PROCESS | 2266 | 03:09:08 INFO - PROCESS | 2266 | [#11] stanford-crypto-ccm Cycles:10 Average:145.50 Median:146.00 stddev:12.08 (8.3%) stddev-sans-first:12.64 03:09:08 INFO - PROCESS | 2266 | Values: 140.0 136.0 141.0 137.0 136.0 149.0 147.0 147.0 177.0 145.0 03:09:08 INFO - PROCESS | 2266 | 03:09:08 INFO - PROCESS | 2266 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.60 Median:168.00 stddev:16.13 (9.6%) stddev-sans-first:17.05 03:09:08 INFO - PROCESS | 2266 | Values: 168.0 168.0 165.0 217.0 167.0 169.0 169.0 166.0 161.0 166.0 03:09:08 INFO - PROCESS | 2266 | 03:09:08 INFO - PROCESS | 2266 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:1.58 (2.4%) stddev-sans-first:1.39 03:09:08 INFO - PROCESS | 2266 | Values: 69.0 67.0 67.0 69.0 66.0 67.0 65.0 65.0 65.0 65.0 03:09:08 INFO - PROCESS | 2266 | -------- Summary: end -------- 03:09:08 INFO - PROCESS | 2266 | 03:09:09 INFO - TEST-INFO | 2266: exit 0 03:09:09 INFO - TEST-OK | kraken | took 59617ms 03:09:09 INFO - SUITE-END | took 1176s 03:09:09 INFO - Completed test suite (00:19:36) 03:09:09 INFO - javascript benchmark 03:09:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2987.3278512334728, 3484.45990871415, 3510.5962814276368, 3518.8064656443894, 3548.095235714892, 4750.524947505248, 5776.566757493194, 5807.390224026474, 5910.9064823007775, 5946.2269904912355, 5823.2138661280715, 5897.941020589793, 5915.704214789254, 5922.733476993535, 5950.88098238036, 5271.1566149416, 5312.229726689628, 5356.303680521546, 5357.357117145948, 5404.83785486436, 4537.228671125917, 5156.736599533101, 5395.649282796606, 5399.649022813504, 5403.7027963462, 5262.210668399752, 5299.682019078868, 5318.202269659562, 5333.653312534692, 5394.973025134869, 5362.088444964346, 5396.865078373072, 5401.78392864285, 5404.351477822686, 5428.4842939920645, 5132.897342053176, 5172.069027575035, 5270.077736396115, 5310.6813591184655, 5312.521873031407, 5636.267285252932, 5666.5183459406, 5673.943260567383, 5723.941070901897, 5761.481466667978, 6293.056041593752, 6304.148939893102, 6314.652694101823, 6323.93676063238, 6329.303776584572, 6144.832481828483, 6204.162438070893, 6271.843203919893, 6289.339619339995, 6295.7166927487915, 6009.939900601025, 6022.4638796103445, 6026.819195424145, 6049.455549000611, 6066.726997285133, 6345.333739957238, 6371.553991220663, 6373.968130159319, 6376.489880809524, 6385.2656944451055, 6127.080937859357, 6155.538334624921, 6155.938440615626, 6231.657258850807, 6272.0, 6181.443670069625, 6202.34875338092, 6248.4064013918605, 6305.842353941096, 6311.779087731908, 6296.370362963758, 6304.243490781136, 6313.021481670348, 6313.08460273267, 6319.715612797435, 6206.162168107338, 6210.627362358183, 6288.151099601587, 6290.496760259169, 6303.590266632654, 4935.161022626162, 4988.301637770715, 4991.850244492671, 5026.2460630904925, 5068.493150684976, 4513.661475389359, 4548.135854187693, 4566.429196350457, 4573.016801387717, 4575.26795712691, 5835.941640583625, 5856.765729370863, 5872.031114865999, 5874.089516125007, 5882.1470886722045, 6189.690515474208, 6235.3452887446165, 6241.75032998684, 6258.15514905491, 6265.373462653698, 5967.403259673998, 5969.641821490724, 5970.850728731816, 5972.761089556456, 6008.459238668541, 4767.022760334124, 5504.504594586427, 5518.310211223597, 5536.640118392292, 5537.7784888604, 6259.7496100156395, 6336.493080553545, 6393.552451328363, 6411.551191416556, 6503.154589903283, 6273.560850740404, 6288.5283603728985, 6288.937110628835, 6294.433500984934, 6302.243730752339, 6228.252609686867, 6475.449586785176, 6486.805395838132, 6491.513136514686, 6494.220693516808, 4961.925571116509, 5369.785208591768, 5890.14592884038, 6225.595336303126, 6274.560780745304, 6265.561410701207, 6279.120923070683, 6293.276273228455, 6299.149614801943, 6317.084022816574, 6112.969435152796, 6129.693515324305, 6178.969105154445, 6225.968870155621, 6282.497400207881, 6181.227346581677, 6274.090256912813, 6288.685565721604, 6294.71673774672, 6300.464460520724, 6152.169457123231, 6170.074488826712, 6175.104609831639, 6184.907226391518, 6192.783252586138, 6027.36712645166, 6170.660613666291, 6203.2245969253845, 6248.312685604489, 6302.810915672537, 6157.568970172045, 6179.134921111138, 6183.628982260899, 6189.381061893775, 6193.380661933951], "value": 5784.032527521879, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [528.7620570743165, 529.36740594989, 532.1645017322804, 553.535030574318, 573.1832139201638, 29771.553426698618, 31137.377252454964, 41503.79248103759, 42797.93005174872, 42952.0, 43164.56835431645, 43634.0, 43652.0, 43655.0, 43724.56275437253, 9614.230861531096, 9793.314467987244, 9803.950980245125, 9813.313068085237, 9821.852672209923, 8654.697085602005, 8858.424202426822, 8864.955675221614, 8870.600822962982, 8915.375923685344, 11568.190226684135, 11832.290062596228, 11843.7631247375, 11962.581309654164, 11967.0, 11748.0, 11851.88148118525, 11855.407229638527, 11861.762764744657, 11866.881331186663, 8695.217430431292, 11438.02776763976, 11631.76736465266, 11763.764724705543, 11772.234804737665, 39283.21433571341, 39530.40704389437, 39672.80163599193, 39715.40426893599, 39802.0, 3289.0626171541235, 3303.3888730584918, 3314.734821214297, 3435.879744208941, 3567.108222944264, 25241.61171135587, 27402.314942126406, 27994.440111197866, 28747.0, 29040.12879613615, 2703.675558932921, 2704.445588654321, 2738.52075886719, 2904.4141343527144, 2943.1611990582583, 432375.8381208105, 437384.81307593256, 437484.0, 437669.0, 439927.0, 55045.724771376685, 55205.0, 55275.723621381636, 55342.44657553454, 55346.16980745292, 62034.0, 62076.06885896715, 62129.68935155295, 62160.0, 62182.68908655428, 15099.320530576151, 16752.49742507727, 16957.745633815503, 16992.57518562046, 17007.31970721182, 11855.525778968744, 12180.0, 12221.877781222074, 12228.388580570936, 13005.934970325277, 15211.92394038045, 15236.847631523542, 15622.453214137451, 15636.765448518281, 15673.843261567466, 5978.013627751459, 6610.3720146586, 6721.924492081243, 6821.863562728718, 6840.623765692934, 921.7465197070725, 931.1433481197315, 940.7507010642186, 952.5999080386255, 1124.9100071994385, 29119.0, 29472.705272946994, 29593.704062959525, 30160.698393015788, 30352.241193970327, 1068.9144868410508, 1080.2654195147375, 1117.1621284036971, 1121.8036843552345, 1252.292454763056, 15254.923725381524, 15262.847371526143, 15450.967921453292, 15564.533064008097, 15650.295736691876, 622703.8864805738, 634226.0, 634368.0, 635257.0, 635607.0, 58299.0, 59666.0, 59760.70119649461, 59831.0, 59862.0, 1323.3780123342015, 1369.2605992764195, 1457.8760805331665, 1478.150063713369, 1506.3372116268806, 30141.898570087946, 30362.93729719449, 30488.390232195674, 30720.84639576788, 30729.231769205948, 49602.503974959785, 50130.49869501258, 50149.74925125351, 50154.49845501498, 50161.49838501714, 472913.0, 488610.0, 488927.0, 490153.0, 490291.0, 32497.187570309987, 32660.020199394057, 33422.99731008073, 33455.83272083624, 34598.65401345954, 36322.91031269066, 37798.81100594479, 44768.328475072245, 46004.7699761499, 46102.53897460982, 29834.0, 35683.0, 37412.06469838276, 37983.0, 38591.42112868253, 29790.0, 31832.68167318297, 37413.43879841859, 37795.81102094582, 37940.62059379481, 37025.44461833128, 37276.6272337284, 37690.623093768714, 37735.62264377321, 38235.61764382321, 32635.673643263264, 32698.83650581732, 33195.83402082974, 33279.667203327655, 33332.833335833166, 22386.66420003669, 23880.094140963705, 24213.03147874136, 24455.38861528405, 24748.133815316378], "value": 19712.33086808947, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.1499496244277, 375.83651111766375, 391.68860755699234, 404.4762033167052, 413.5533623686419, 19517.707234391477, 21764.238251661194, 22350.10599576015, 22669.0, 22679.319620411392, 20104.59790804183, 21253.0, 21273.787262127375, 21491.67762483564, 21981.23065692697, 5196.908649183667, 6077.179580756586, 6137.877242455148, 6146.938530614703, 6148.508119350441, 3868.825902834365, 4068.572799856017, 5710.371859095496, 6059.121427393025, 6061.817945500629, 5195.246689230059, 6093.238345206849, 6097.939020609803, 6099.237595300588, 6101.115338275948, 5834.56240781941, 6068.0, 6073.605215660968, 6092.055731361646, 6097.939020609803, 3737.215184811193, 5488.0, 5818.796342128047, 5822.0, 5832.854178645525, 13337.933310333483, 13803.0, 13915.58253252404, 13925.23411212383, 13967.161970281815, 2049.252023011605, 2091.7385326834146, 2106.431263558846, 2132.2110818996916, 2206.768289329629, 9236.953815230949, 9729.951350243275, 9762.658306959293, 10141.13800326973, 10277.383356998604, 1662.1190768892507, 1672.4230140601474, 1709.9829001709948, 1736.6540930778622, 1819.654265689528, 123660.0, 132907.0, 134646.0, 139374.3031284837, 140999.0, 9542.666006689733, 11635.650930472098, 11680.94159529197, 11705.88294117065, 11828.112891532997, 12628.494860205672, 15397.99913005651, 15399.23003849803, 15413.922930385277, 15451.150186739613, 8536.914630853737, 8797.428167169242, 8799.648014079365, 8927.24118449926, 8956.731298061068, 8768.25469835071, 8779.780505487413, 8799.0, 8914.465132092095, 8937.06160853101, 3988.641022308006, 4579.0, 4647.326137710013, 4659.697119687209, 4717.95282047182, 1747.867601526136, 1758.516407987788, 1770.1748575652387, 1795.2639417838623, 1901.4770937992164, 923.2475532441039, 925.5742358515024, 959.2326139088701, 981.7594689301167, 1006.6527048168371, 17080.658386832194, 19490.805091949183, 19931.903745293857, 20565.50667846875, 20642.0, 900.104396125859, 908.6728777640044, 951.3007939164709, 960.1742501448748, 971.1745016735719, 7249.927500725031, 10669.946650266698, 10838.295510791932, 10888.61889833852, 11007.834882476769, 464463.0, 610930.0, 622292.0, 628898.0, 630423.0, 133440.99838502432, 143760.56239437472, 145698.0, 148121.2593937045, 148955.0, 862.7799911022774, 895.7223260789046, 968.3512046928574, 1016.4714348538719, 1017.59296281488, 18385.172667230276, 18622.72065918985, 18632.97518636488, 18704.158312876225, 18921.337753178574, 53066.2040069407, 53617.0, 54358.0, 56058.0, 57543.424565753805, 67139.3286067133, 79080.81378779208, 79663.20336796557, 80143.0, 83913.58043209744, 7762.068551773823, 8006.959965200137, 8064.637091331021, 8218.301444377295, 8452.197041281068, 12478.563250286197, 12636.55772047974, 12658.403294788328, 12670.049746269251, 12789.872101278868, 5340.51935325807, 6496.350364963466, 10747.570097196025, 10900.07349375312, 10972.341659500455, 10543.42011189392, 10812.243142979916, 10855.402952837354, 11048.447577621248, 11116.666500005012, 11018.944905275423, 11239.269447485887, 11347.37589432589, 11374.374409407232, 11563.710907227387, 7991.0, 8224.465409748347, 8258.25675689191, 8293.377996650155, 8491.745247642333, 8898.86651700238, 9859.35914165577, 10855.0, 11407.486663100015, 11499.770004600028], "value": 9330.230968077336, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1342.630776536453, 1609.227570766032, 1633.9754903676444, 1790.9820901790986, 1851.9259229630816, 7803.336716379107, 8606.440581362214, 8805.735827925173, 8845.646174153035, 8962.507062111581, 8114.837703245947, 8764.386492945496, 8779.2537634301, 8781.95609021954, 8797.560121993907, 2165.5993641176433, 2245.079517397867, 2248.9887550562307, 2444.9144279950206, 2475.7029156501244, 2248.87631180285, 2425.527022230666, 2523.583608704571, 2525.9747402526014, 2538.0482319130324, 2449.3876530867283, 2467.728549859514, 2489.2905521926255, 2491.9875400623064, 2497.8751062446895, 2091.5816836632735, 2141.625215587266, 2412.0231306320966, 2447.84089034214, 2454.582720937436, 2386.0455817672896, 2445.2664200739705, 2451.8161137914726, 2463.48266863957, 2466.5930121529927, 8492.235698787077, 8547.273481754059, 8555.230029297392, 8565.057843637194, 8573.785655358604, 5260.368755749297, 5430.266913966603, 5439.619226654136, 5480.972595136999, 5491.423400542965, 3400.863965441379, 3523.2953409317984, 3651.703645205967, 3666.578343490506, 3681.0981309579056, 1016.9745756356076, 1039.880413752413, 1041.2971244409994, 1042.5256508288787, 1047.1675018360422, 11686.889745474165, 11702.590409335717, 11714.414279286002, 11744.0, 11744.295342279405, 4234.9364759528635, 4747.881302967454, 4773.11697335994, 4926.8768280793265, 4936.851894443173, 8386.454880432751, 9900.801983960424, 9907.900920990698, 9916.80166396668, 9952.452615106095, 5436.782528698887, 5470.890582188334, 5478.890422191614, 5483.835484935458, 5484.0, 4835.153848076572, 4926.408830940239, 4933.506649335038, 4946.258061290835, 5020.899582008339, 3859.9228015439535, 3866.7679939203736, 3912.7456715313415, 3935.2916475034194, 3935.980320098381, 1323.0474058677737, 1329.6077657091182, 1336.3051213368994, 1348.4067010515341, 1355.69496863205, 809.1988930958427, 836.8870202522703, 879.520661239626, 933.9439633622004, 940.6172925799065, 5777.88444231113, 5819.272590926134, 6003.6397816131175, 6070.848228794315, 6128.142060111588, 973.6446197137993, 976.0532283684814, 985.2364417576435, 990.5691024404407, 1038.402918321968, 3973.384125460558, 4056.5213939827154, 4069.5726948669962, 4112.527059388209, 4128.339465685476, 10144.289899707097, 10444.477776111164, 10506.632267870587, 10610.787784244272, 10639.042486176126, 10528.578856845794, 10549.84175237372, 10627.787444251226, 10635.946820266005, 10637.68086957377, 7961.283484486308, 8018.55897925608, 8217.219364160395, 8270.545120018456, 8278.668853245923, 5859.677717725566, 5911.615744976562, 5958.433948774859, 5981.0, 5993.3706960768495, 9890.060444258072, 9978.650747223812, 9980.201583873419, 10079.496025198565, 10112.949435253071, 8960.1935825776, 9940.552675129782, 10045.296829221885, 10190.98090190975, 10234.539445724811, 5980.730867110903, 6991.196012458429, 6996.895046574204, 7083.574985500681, 7094.0, 8109.75670729879, 8133.918660813316, 8152.103268640326, 8212.17878212174, 8212.753617391489, 7335.816604584928, 7369.410447164107, 7448.0, 7497.512661676974, 7521.5111017783665, 7028.0, 7204.53170543913, 7271.0, 7273.781786546412, 7427.7771666850085, 6725.39471447572, 6740.528163028541, 6805.693743781443, 6806.489513286424, 6809.761658342132, 4908.533689299511, 4973.751312434436, 5057.924131137962, 5081.77132029067, 5097.6941383517105, 5002.299678045004, 5030.698158110525, 5109.1059064662795, 5131.9486805132965, 5215.191645294985], "value": 4602.670949424588, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.5526411693933, 310.71724730495254, 317.6601036890528, 317.712470214456, 321.93400352927654, 5402.540784033357, 5406.053940560396, 5430.886668233013, 5436.864078398037, 5449.782008719647, 4544.590986811187, 4831.420229572447, 5318.654287471311, 5331.893362132755, 5344.625876188668, 3430.0, 3871.399933010388, 3972.682185425159, 4123.670106391482, 4126.89528340547, 3563.968537933379, 4013.8394464221396, 4091.3453847384426, 4105.692073094529, 4119.629233368996, 3468.497067925162, 4028.6777057835448, 4057.8376864925367, 4072.857449989251, 4107.691923105764, 3246.853891574873, 3850.26844899471, 3879.4180872869156, 3984.621460961204, 4117.949922769704, 2974.657914339857, 3368.696817286456, 3375.122468158272, 3581.659742324475, 3586.33652774235, 4737.38414006177, 5093.5415812576675, 5099.541041306263, 5129.153689641204, 5158.845234642967, 3992.960070399288, 4320.675949303814, 4419.204543182226, 4654.277247810035, 4717.268823332389, 4907.705537667752, 4924.679895806761, 5429.077056900336, 5599.708275679484, 5656.519195868356, 3166.9524957125664, 3303.1081607965716, 3882.611738826123, 3885.747426417274, 3902.512185976753, 5270.338479068085, 5430.782768689248, 5893.351731309553, 5914.852128696774, 5922.437368449991, 3669.743117981716, 3892.2993861105274, 3905.160390515996, 3922.3920292354733, 3936.1143742658246, 3721.7394782364972, 3739.7943113128495, 3951.585083566242, 3972.145988612462, 3976.284268831638, 4132.850917522871, 4153.605407486284, 4359.80380882861, 4445.488768791565, 4633.397658304399, 5398.811041613525, 5463.869091054492, 5695.544356451557, 5705.857353566194, 5755.482006619341, 1169.5964892112208, 1262.6906407930117, 1293.4373547506864, 1305.7388522295578, 1309.8886594639562, 778.7274453941188, 820.9409861279003, 823.4770920465547, 877.6050777150308, 885.2475395913422, 4750.95249047512, 5071.290019397287, 5133.921876405997, 5177.870553236124, 5185.196294574272, 5406.756695948613, 5457.426970168075, 5757.65454072757, 5848.2689663792025, 5968.492678122321, 4437.9348956250915, 4450.065486247924, 5037.773300201499, 5298.940211957624, 5302.3753242145385, 2484.503099380131, 2520.6849143857016, 2622.645942797736, 2955.852207389622, 2985.1343110497714, 4947.554720075139, 5269.710165940834, 5907.873165660359, 5908.231929849092, 5964.284285885635, 5031.389955214369, 5211.348581427322, 5243.12731145604, 5756.510696590753, 5855.268091488564, 4903.975480122648, 5913.940860591425, 5934.050551911673, 5934.554908381889, 5981.0, 4851.393575803025, 4948.901021979612, 5685.886282274414, 5691.7438715257085, 5734.5125664319, 4869.4400143982475, 4896.92654610174, 5263.763130659053, 5308.309919710413, 5582.599482222521, 5426.945730542644, 5681.119426488901, 5808.419158084327, 5872.265966754156, 5896.611872191769, 3025.0471101602925, 3300.785448945811, 3487.023633382657, 3681.8711345102793, 3737.6822970046765, 5182.170852663556, 5205.375354957429, 5545.057340252248, 5603.691796951207, 5637.408072152365, 4859.441164266154, 5256.237845512455, 5346.78612855497, 5390.892182156256, 5436.374816896107, 4294.472401949082, 4884.7069175849565, 5127.743612819419, 5349.277847490539, 5376.596755243294, 5075.923861142012, 5271.947280527145, 5306.257124002565, 5331.546818520469, 5347.786088556414, 5284.873672537632, 5297.8145764898045, 5361.731913404236, 5378.031954248273, 5413.0, 4443.0, 5071.797128114834, 5411.512963833116, 5486.286782718221, 5486.8203336282895], "value": 4004.819782659228, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [622.81938237911, 715.198977145597, 745.9738909138181, 756.3646536908997, 797.1948332184492, 14641.560753177408, 15338.309776060076, 15352.078875267493, 15355.46255881043, 15376.0, 12250.571230006952, 13894.652633684163, 13935.860641393583, 13962.511312104078, 13973.371198296076, 925.8240934222493, 930.3208657679897, 934.7756538430796, 934.8177105464437, 936.3819878879941, 903.6972614174259, 917.9311551633621, 924.2098006204699, 925.1211349218236, 926.4858003807884, 971.5093877591842, 974.0211087856694, 974.1768205866032, 974.2108891797632, 976.8046390721848, 963.7397902566303, 965.874436323277, 968.394753279204, 968.5157421289356, 971.3152227679469, 719.0652152202116, 719.2986837833123, 719.3597698048741, 719.9244079371643, 721.253502624786, 13434.0, 15074.24628768568, 15097.54707358781, 15107.471238506709, 15119.0, 11726.296422214695, 12046.277223366626, 12118.212316199419, 12138.211016283913, 12374.505019799197, 9066.365354425192, 10810.405427701473, 10937.343759374464, 11185.440727963569, 11316.094712422986, 3950.822213000422, 4041.1109555897656, 4043.8382464701376, 4095.5494895561465, 4162.791860406998, 57522.849543009324, 60110.0, 66584.6683066336, 75972.62013689896, 82530.17469825345, 9365.765855853659, 9434.575444105032, 9526.809463810685, 9833.803323933482, 9936.304458687822, 21091.9454027298, 21105.89447052755, 21110.155593776384, 21113.41649376272, 21118.47203819917, 7444.292792184734, 7566.621668916532, 7573.318401343906, 7654.655540500691, 7664.540127592362, 4040.1717647882115, 4118.5057793065025, 4126.319157339006, 4128.504579450485, 4138.5861413858975, 3505.77212481193, 3588.7618771523785, 3594.730395220369, 3597.37046016946, 3602.8919132426067, 636.1030946365602, 656.0716586030713, 657.1161787395945, 663.141232104426, 667.4060086522999, 521.474686541871, 561.2983770287141, 562.4684672983991, 604.2778879239266, 606.9119977603311, 7936.444448888522, 7975.880361794578, 8316.958415207886, 8378.748637540884, 8404.873926891101, 463.2865387303582, 498.63421902160417, 538.3163382504198, 540.3461811208482, 577.9219805326227, 3211.405889910374, 3844.557875844314, 3846.8461261549783, 4099.651529619956, 4108.0, 86885.56557217173, 90244.5487772557, 90719.09280907239, 91193.54403227942, 92517.53741231251, 66714.66642666755, 80170.0, 80380.59809700915, 81381.77927331095, 82529.0, 64288.678556606916, 68421.0, 69567.65216173886, 70880.29119708737, 71652.0, 8124.390670699603, 8219.013718353835, 8351.582420879053, 8386.161383861809, 8427.410081294496, 41581.79209103935, 41990.790046050795, 42688.78655606702, 42785.50250741209, 44009.55990440054, 54507.0, 56146.0, 56187.87624247574, 56332.0, 56451.15323270072, 9147.862782058408, 10875.456227188768, 11267.605633802777, 11348.659540213806, 11403.144764142888, 11893.464794084113, 11929.463174157358, 12151.210171338835, 12152.0, 12338.938305308417, 11327.093832493545, 11375.886241137483, 11406.657800266004, 11450.198486105892, 11759.706007349885, 10339.276250662382, 10525.684229473129, 10847.78304433891, 11457.312561246352, 11504.25222360544, 10982.286151400134, 11348.421424624934, 11452.31286122802, 11497.827532587185, 11611.5355385787, 9225.861612075958, 9277.582508787256, 9401.435913845191, 9468.763280918032, 9811.55847986828, 9440.433573985583, 9611.509651611264, 9678.27412944046, 9744.269179811685, 9824.65613703517], "value": 6825.316025026067, "unit": "score"}], "name": "dromaeo_css", "value": 7152.1577799694705, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 106.0, 111.0, 112.0, 112.0, 114.0, 114.0, 113.0, 114.0, 111.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 118.0, 149.0, 183.0, 118.0, 132.0, 156.0, 139.0, 198.0, 116.0], "value": 146.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 253.0, 206.0, 188.0, 185.0, 186.0, 186.0, 187.0, 182.0, 182.0], "value": 194.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 74.0, 58.0, 108.0, 57.0, 64.0, 57.0, 58.0, 114.0, 55.0], "value": 72.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 97.0, 101.0, 80.0, 81.0, 77.0, 102.0, 80.0, 83.0, 102.0], "value": 89.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 89.0, 89.0, 89.0, 87.0, 91.0, 86.0, 90.0, 71.0], "value": 86.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 97.0, 94.0, 94.0, 94.0, 94.0, 100.0, 142.0], "value": 99.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 97.0, 137.0, 70.0, 129.0, 139.0, 129.0, 86.0, 85.0], "value": 104.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 60.0, 58.0, 57.0, 58.0, 61.0, 80.0, 59.0, 57.0], "value": 60.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 72.0, 78.0, 77.0, 72.0, 71.0, 68.0, 71.0, 67.0, 76.0], "value": 71.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 88.0, 85.0, 85.0, 85.0, 87.0, 85.0, 85.0, 84.0], "value": 85.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 136.0, 141.0, 137.0, 136.0, 149.0, 147.0, 147.0, 177.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 168.0, 165.0, 217.0, 167.0, 169.0, 169.0, 166.0, 161.0, 166.0], "value": 171.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 67.0, 69.0, 66.0, 67.0, 65.0, 65.0, 65.0, 65.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1507.9999999999998, "alertThreshold": 2.0}]} 03:09:10 INFO - Return code: 0 03:09:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:09:10 ERROR - # TBPL SUCCESS # 03:09:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:09:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:09:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:09:10 INFO - 2016-05-06 03:09:10.067 screenresolution[2270:15900] starting screenresolution argv=screenresolution get 03:09:10 INFO - 2016-05-06 03:09:10.070 screenresolution[2270:15900] Display 0: 1600x1200x32@60 03:09:10 INFO - 2016-05-06 03:09:10.075 screenresolution[2271:15903] starting screenresolution argv=screenresolution list 03:09:10 INFO - Available Modes on Display 0 03:09:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:09:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:09:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:09:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:09:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:09:10 INFO - Intel Iris: 03:09:10 INFO - Chipset Model: Intel Iris 03:09:10 INFO - Type: GPU 03:09:10 INFO - Bus: Built-In 03:09:10 INFO - VRAM (Dynamic, Max): 1536 MB 03:09:10 INFO - Vendor: Intel (0x8086) 03:09:10 INFO - Device ID: 0x0a2e 03:09:10 INFO - Revision ID: 0x0009 03:09:10 INFO - Displays: 03:09:10 INFO - Display: 03:09:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:09:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:09:10 INFO - Display Serial Number: 1600x1200 60 03:09:10 INFO - Main Display: Yes 03:09:10 INFO - Mirror: Off 03:09:10 INFO - Online: Yes 03:09:10 INFO - Rotation: Supported 03:09:10 INFO - Return code: 0 03:09:10 INFO - Running post-action listener: _resource_record_post_action 03:09:10 INFO - Running post-run listener: _resource_record_post_run 03:09:11 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 331776; Write bytes: 695379456; Read time: 8; Write time: 2109 03:09:11 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 386103808; Write bytes: 381493760; Read time: 29455; Write time: 774 03:09:11 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 331776; Write bytes: 294413312; Read time: 8; Write time: 1290 03:09:11 INFO - Running post-run listener: _upload_blobber_files 03:09:11 INFO - Blob upload gear active. 03:09:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:09:11 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 03:09:11 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'] 03:09:11 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 03:09:11 INFO - (blobuploader) - INFO - Open directory for files ... 03:09:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:09:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:09:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:09:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:09:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:09:12 INFO - (blobuploader) - INFO - Done attempting. 03:09:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:09:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:09:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:09:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:09:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:09:13 INFO - (blobuploader) - INFO - Done attempting. 03:09:13 INFO - (blobuploader) - INFO - Iteration through files over. 03:09:13 INFO - Return code: 0 03:09:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:09:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:09:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eb297f9420042db405ef59d8a0b3af93fa07e284fc6299b9bc42a726cd48b2f573d5f3555efe1526ec1c6a1433457bf3d0a0b70989b21c2a93190e679cea9cca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c0e0ce590a765aab24c2ef263718600a83c1a5808839dbc9877c2ca4506d2bd1b251e166574e6ff6f430062e9effa4d5de322cc8980001d989ed6f241e3145e"} 03:09:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:09:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:09:13 INFO - Contents: 03:09:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eb297f9420042db405ef59d8a0b3af93fa07e284fc6299b9bc42a726cd48b2f573d5f3555efe1526ec1c6a1433457bf3d0a0b70989b21c2a93190e679cea9cca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c0e0ce590a765aab24c2ef263718600a83c1a5808839dbc9877c2ca4506d2bd1b251e166574e6ff6f430062e9effa4d5de322cc8980001d989ed6f241e3145e"} 03:09:13 INFO - Running post-run listener: copy_logs_to_upload_dir 03:09:13 INFO - Copying logs to upload dir... 03:09:13 INFO - mkdir: /builds/slave/test/build/upload/logs 03:09:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.601354 ========= master_lag: 3.55 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-05-06 03:09:17.251178) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 03:09:17.259765) ========= 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.pp2NEngb2h/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.UQv9SAorFM/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eb297f9420042db405ef59d8a0b3af93fa07e284fc6299b9bc42a726cd48b2f573d5f3555efe1526ec1c6a1433457bf3d0a0b70989b21c2a93190e679cea9cca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c0e0ce590a765aab24c2ef263718600a83c1a5808839dbc9877c2ca4506d2bd1b251e166574e6ff6f430062e9effa4d5de322cc8980001d989ed6f241e3145e"} build_url:https://queue.taskcluster.net/v1/task/XErRLRsCRSS7zuYl6ulpcA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011561 build_url: 'https://queue.taskcluster.net/v1/task/XErRLRsCRSS7zuYl6ulpcA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eb297f9420042db405ef59d8a0b3af93fa07e284fc6299b9bc42a726cd48b2f573d5f3555efe1526ec1c6a1433457bf3d0a0b70989b21c2a93190e679cea9cca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c0e0ce590a765aab24c2ef263718600a83c1a5808839dbc9877c2ca4506d2bd1b251e166574e6ff6f430062e9effa4d5de322cc8980001d989ed6f241e3145e"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 03:09:17.302574) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:09:17.306536) ========= 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.pp2NEngb2h/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.UQv9SAorFM/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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.005256 ========= master_lag: 0.09 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:09:17.399940) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 03:09:17.400243) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 03:09:17.402566) ========= ========= Total master_lag: 3.74 =========