builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0045 starttime: 1461779136.01 results: success (0) buildid: 20160427085158 builduid: d3f9236ced27470d936c0aa992b48f20 revision: 8c546512c77169d62f232edd00fa896eff5038e0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 10:45:36.012453) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 10:45:36.012878) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 10:45:36.013175) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 10:45:36.037222) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 10:45:36.037515) ========= 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.IwxP2X65XC/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.xDoMx62y6g/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-27 10:45:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 156M=0s 2016-04-27 10:45:36 (156 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.424554 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 10:45:36.481182) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 10:45:36.481499) ========= 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.IwxP2X65XC/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.xDoMx62y6g/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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.026440 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 10:45:36.531730) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-27 10:45:36.532069) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 8c546512c77169d62f232edd00fa896eff5038e0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 8c546512c77169d62f232edd00fa896eff5038e0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IwxP2X65XC/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.xDoMx62y6g/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-27 10:45:36,605 truncating revision to first 12 chars 2016-04-27 10:45:36,605 Setting DEBUG logging. 2016-04-27 10:45:36,605 attempt 1/10 2016-04-27 10:45:36,605 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/8c546512c771?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-27 10:45:37,263 unpacking tar archive at: mozilla-beta-8c546512c771/testing/mozharness/ program finished with exit code 0 elapsedTime=0.906469 ========= master_lag: 0.75 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-27 10:45:38.184604) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 10:45:38.184959) ========= script_repo_revision: 8c546512c77169d62f232edd00fa896eff5038e0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 10:45:38.189401) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 10:45:38.189707) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 10:45:38.217580) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 12 secs) (at 2016-04-27 10:45:38.217928) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IwxP2X65XC/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.xDoMx62y6g/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 10:45:38 INFO - MultiFileLogger online at 20160427 10:45:38 in /builds/slave/test 10:45:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 10:45:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:45:38 INFO - {'append_to_log': False, 10:45:38 INFO - 'base_work_dir': '/builds/slave/test', 10:45:38 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:45:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:45:38 INFO - 'branch': 'Mozilla-Beta', 10:45:38 INFO - 'buildbot_json_path': 'buildprops.json', 10:45:38 INFO - 'config_files': ('talos/mac_config.py',), 10:45:38 INFO - 'default_actions': ('clobber', 10:45:38 INFO - 'read-buildbot-config', 10:45:38 INFO - 'download-and-extract', 10:45:38 INFO - 'populate-webroot', 10:45:38 INFO - 'create-virtualenv', 10:45:38 INFO - 'install', 10:45:38 INFO - 'run-tests'), 10:45:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:45:38 INFO - 'download_minidump_stackwalk': True, 10:45:38 INFO - 'download_symbols': 'ondemand', 10:45:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:45:38 INFO - 'tooltool.py': '/tools/tooltool.py', 10:45:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:45:38 INFO - '/tools/misc-python/virtualenv.py')}, 10:45:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:45:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:45:38 INFO - 'installer_path': 'installer.exe', 10:45:38 INFO - 'log_level': 'info', 10:45:38 INFO - 'log_name': 'talos', 10:45:38 INFO - 'log_to_console': True, 10:45:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:45:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:45:38 INFO - 'opt_config_files': (), 10:45:38 INFO - 'pip_index': False, 10:45:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:45:38 INFO - 'cmd': ('bash', 10:45:38 INFO - '-c', 10:45:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:45:38 INFO - 'enabled': True, 10:45:38 INFO - 'halt_on_failure': False, 10:45:38 INFO - 'name': 'check_screen_resolution'},), 10:45:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:45:38 INFO - 'cmd': ('bash', 10:45:38 INFO - '-c', 10:45:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:45:38 INFO - 'enabled': True, 10:45:38 INFO - 'halt_on_failure': False, 10:45:38 INFO - 'name': 'check_screen_resolution'},), 10:45:38 INFO - 'run_cmd_checks_enabled': True, 10:45:38 INFO - 'sps_profile': False, 10:45:38 INFO - 'sps_profile_interval': 0, 10:45:38 INFO - 'suite': 'dromaeojs', 10:45:38 INFO - 'system_bits': '32', 10:45:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:45:38 INFO - 'title': 't-yosemite-r7-0045', 10:45:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:45:38 INFO - 'use_talos_json': True, 10:45:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:45:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:45:38 INFO - 'work_dir': 'build'} 10:45:38 INFO - ##### 10:45:38 INFO - ##### Running clobber step. 10:45:38 INFO - ##### 10:45:38 INFO - Running pre-action listener: _resource_record_pre_action 10:45:38 INFO - Running main action method: clobber 10:45:38 INFO - rmtree: /builds/slave/test/build 10:45:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:45:40 INFO - Running post-action listener: _resource_record_post_action 10:45:40 INFO - ##### 10:45:40 INFO - ##### Running read-buildbot-config step. 10:45:40 INFO - ##### 10:45:40 INFO - Running pre-action listener: _resource_record_pre_action 10:45:40 INFO - Running main action method: read_buildbot_config 10:45:40 INFO - Using buildbot properties: 10:45:40 INFO - { 10:45:40 INFO - "project": "", 10:45:40 INFO - "product": "firefox", 10:45:40 INFO - "script_repo_revision": "production", 10:45:40 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 10:45:40 INFO - "repository": "", 10:45:40 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 10:45:40 INFO - "buildid": "20160427085158", 10:45:40 INFO - "pgo_build": "False", 10:45:40 INFO - "basedir": "/builds/slave/test", 10:45:40 INFO - "buildnumber": 161, 10:45:40 INFO - "slavename": "t-yosemite-r7-0045", 10:45:40 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 10:45:40 INFO - "platform": "yosemite_r7", 10:45:40 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 10:45:40 INFO - "branch": "mozilla-beta", 10:45:40 INFO - "repo_path": "releases/mozilla-beta", 10:45:40 INFO - "revision": "8c546512c77169d62f232edd00fa896eff5038e0", 10:45:40 INFO - "stage_platform": "macosx64", 10:45:40 INFO - "builduid": "d3f9236ced27470d936c0aa992b48f20", 10:45:40 INFO - "slavebuilddir": "test" 10:45:40 INFO - } 10:45:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/dmZXRcCGTMO-b2qIY_0bKw/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 10:45:40 INFO - Running post-action listener: _resource_record_post_action 10:45:40 INFO - ##### 10:45:40 INFO - ##### Running download-and-extract step. 10:45:40 INFO - ##### 10:45:40 INFO - Running pre-action listener: _resource_record_pre_action 10:45:40 INFO - Running main action method: download_and_extract 10:45:40 INFO - mkdir: /builds/slave/test/build/tests 10:45:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:45:40 INFO - https://queue.taskcluster.net/v1/task/dmZXRcCGTMO-b2qIY_0bKw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 10:45:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dmZXRcCGTMO-b2qIY_0bKw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 10:45:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dmZXRcCGTMO-b2qIY_0bKw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 10:45:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dmZXRcCGTMO-b2qIY_0bKw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 10:45:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dmZXRcCGTMO-b2qIY_0bKw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json'}, attempt #1 10:45:41 INFO - Downloaded 1241 bytes. 10:45:41 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 10:45:41 INFO - Using the following test package requirements: 10:45:41 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 10:45:41 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:45:41 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 10:45:41 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:45:41 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 10:45:41 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 10:45:41 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:45:41 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 10:45:41 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 10:45:41 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:45:41 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 10:45:41 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:45:41 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 10:45:41 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:45:41 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 10:45:41 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 10:45:41 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:45:41 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 10:45:41 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 10:45:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:45:41 INFO - https://queue.taskcluster.net/v1/task/dmZXRcCGTMO-b2qIY_0bKw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:45:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dmZXRcCGTMO-b2qIY_0bKw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 10:45:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dmZXRcCGTMO-b2qIY_0bKw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 10:45:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dmZXRcCGTMO-b2qIY_0bKw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 10:45:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dmZXRcCGTMO-b2qIY_0bKw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 10:45:42 INFO - Downloaded 17745656 bytes. 10:45:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:45:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:45:45 INFO - Return code: 0 10:45:45 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip', u'firefox-47.0.en-US.mac.talos.tests.zip'] for test suite category: talos 10:45:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:45:45 INFO - https://queue.taskcluster.net/v1/task/dmZXRcCGTMO-b2qIY_0bKw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:45:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dmZXRcCGTMO-b2qIY_0bKw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 10:45:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dmZXRcCGTMO-b2qIY_0bKw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 10:45:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dmZXRcCGTMO-b2qIY_0bKw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 10:45:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dmZXRcCGTMO-b2qIY_0bKw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 10:45:48 INFO - Downloaded 17745656 bytes. 10:45:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:45:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:45:52 INFO - Return code: 0 10:45: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')]} 10:45:52 INFO - https://queue.taskcluster.net/v1/task/dmZXRcCGTMO-b2qIY_0bKw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:45:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dmZXRcCGTMO-b2qIY_0bKw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 10:45:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dmZXRcCGTMO-b2qIY_0bKw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 10:45:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dmZXRcCGTMO-b2qIY_0bKw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip 10:45:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dmZXRcCGTMO-b2qIY_0bKw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip'}, attempt #1 10:45:53 INFO - Downloaded 10845194 bytes. 10:45:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:45:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 10:45:53 INFO - Return code: 0 10:45:53 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')]} 10:45:53 INFO - https://queue.taskcluster.net/v1/task/dmZXRcCGTMO-b2qIY_0bKw/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 10:45:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dmZXRcCGTMO-b2qIY_0bKw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 10:45:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dmZXRcCGTMO-b2qIY_0bKw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 10:45:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dmZXRcCGTMO-b2qIY_0bKw/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 10:45:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dmZXRcCGTMO-b2qIY_0bKw/artifacts/public/build/firefox-47.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg'}, attempt #1 10:45:55 INFO - Downloaded 88298959 bytes. 10:45:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dmZXRcCGTMO-b2qIY_0bKw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 10:45:55 INFO - mkdir: /builds/slave/test/properties 10:45:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:45:55 INFO - Writing to file /builds/slave/test/properties/build_url 10:45:55 INFO - Contents: 10:45:55 INFO - build_url:https://queue.taskcluster.net/v1/task/dmZXRcCGTMO-b2qIY_0bKw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 10:45:57 INFO - Running post-action listener: _resource_record_post_action 10:45:57 INFO - Running post-action listener: set_extra_try_arguments 10:45:57 INFO - ##### 10:45:57 INFO - ##### Running populate-webroot step. 10:45:57 INFO - ##### 10:45:57 INFO - Running pre-action listener: _resource_record_pre_action 10:45:57 INFO - Running main action method: populate_webroot 10:45:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:45:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:45:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:45:57 INFO - '--tppagecycles', 10:45:57 INFO - '7'], 10:45:57 INFO - 'tests': ['tsvgm']}}, 10:45:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:45:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:45:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:45:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 10:45:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:45:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:45:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:45:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:45:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:45:57 INFO - 'talos_options': ['--e10s'], 10:45:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:45:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:45:57 INFO - 'tests': ['damp', 'tps']}, 10:45:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:45:57 INFO - 'talos_options': ['--e10s'], 10:45:57 INFO - 'tests': ['damp', 'tps']}, 10:45:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:45:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:45:57 INFO - 'other': {'tests': ['a11yr', 10:45:57 INFO - 'ts_paint', 10:45:57 INFO - 'tpaint', 10:45:57 INFO - 'sessionrestore', 10:45:57 INFO - 'sessionrestore_no_auto_restore', 10:45:57 INFO - 'tabpaint']}, 10:45:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:45:57 INFO - 'tests': ['a11yr', 10:45:57 INFO - 'ts_paint', 10:45:57 INFO - 'tpaint', 10:45:57 INFO - 'sessionrestore', 10:45:57 INFO - 'sessionrestore_no_auto_restore', 10:45:57 INFO - 'tabpaint']}, 10:45:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:45:57 INFO - 'tests': ['a11yr', 10:45:57 INFO - 'ts_paint', 10:45:57 INFO - 'tpaint', 10:45:57 INFO - 'sessionrestore', 10:45:57 INFO - 'sessionrestore_no_auto_restore', 10:45:57 INFO - 'tabpaint']}, 10:45:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:45:57 INFO - 'tests': ['a11yr', 10:45:57 INFO - 'ts_paint', 10:45:57 INFO - 'tpaint', 10:45:57 INFO - 'sessionrestore', 10:45:57 INFO - 'sessionrestore_no_auto_restore', 10:45:57 INFO - 'tabpaint']}, 10:45:57 INFO - 'other_l64': {'tests': ['a11yr', 10:45:57 INFO - 'ts_paint', 10:45:57 INFO - 'tpaint', 10:45:57 INFO - 'sessionrestore', 10:45:57 INFO - 'sessionrestore_no_auto_restore', 10:45:57 INFO - 'tabpaint']}, 10:45:57 INFO - 'other_nol64': {'tests': ['a11yr', 10:45:57 INFO - 'ts_paint', 10:45:57 INFO - 'tpaint', 10:45:57 INFO - 'sessionrestore', 10:45:57 INFO - 'sessionrestore_no_auto_restore', 10:45:57 INFO - 'tabpaint']}, 10:45:57 INFO - 'svgr': {'tests': ['tsvgx', 10:45:57 INFO - 'tsvgr_opacity', 10:45:57 INFO - 'tart', 10:45:57 INFO - 'tscrollx', 10:45:57 INFO - 'cart']}, 10:45:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:45:57 INFO - 'tests': ['tsvgx', 10:45:57 INFO - 'tsvgr_opacity', 10:45:57 INFO - 'tart', 10:45:57 INFO - 'tscrollx', 10:45:57 INFO - 'cart']}, 10:45:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:45:57 INFO - 'tests': ['tp5o']}, 10:45:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:45:57 INFO - 'talos_options': ['--e10s'], 10:45:57 INFO - 'tests': ['tp5o']}, 10:45:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:45:57 INFO - 'talos_options': ['--xperf_path', 10:45:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:45:57 INFO - 'tests': ['tp5n']}, 10:45:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:45:57 INFO - 'talos_options': ['--e10s', 10:45:57 INFO - '--xperf_path', 10:45:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:45:57 INFO - 'tests': ['tp5n']}}, 10:45:57 INFO - 'talos.zip': {'path': '', 10:45:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:45:57 INFO - Running post-action listener: _resource_record_post_action 10:45:57 INFO - ##### 10:45:57 INFO - ##### Running create-virtualenv step. 10:45:57 INFO - ##### 10:45:57 INFO - Running pre-action listener: _resource_record_pre_action 10:45:57 INFO - Running main action method: create_virtualenv 10:45:57 INFO - Creating virtualenv /builds/slave/test/build/venv 10:45:57 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 10:45:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:45:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:45:57 INFO - Using real prefix '/tools/python27' 10:45:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:45:57 INFO - Installing distribute.............................................................................................................................................................................................done. 10:46:00 INFO - Installing pip.................done. 10:46:00 INFO - Return code: 0 10:46:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:46:00 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')]} 10:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:46:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46:00 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')]} 10:46:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:46:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46:00 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 0x10af02a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af094c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ca959e960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ada6d30>, '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 0x10ac0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad9db20>, '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.IwxP2X65XC/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.xDoMx62y6g/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 10:46:00 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 10:46:00 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 10:46:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IwxP2X65XC/Render', 10:46:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:46:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:46:00 INFO - 'HOME': '/Users/cltbld', 10:46:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:46:00 INFO - 'LOGNAME': 'cltbld', 10:46:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:46:00 INFO - 'MOZ_NO_REMOTE': '1', 10:46:00 INFO - 'NO_EM_RESTART': '1', 10:46:00 INFO - 'PAGER': '/bin/cat', 10:46:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:46:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:46:00 INFO - 'PWD': '/builds/slave/test', 10:46:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:46:00 INFO - 'SHELL': '/bin/bash', 10:46:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xDoMx62y6g/Listeners', 10:46:00 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 10:46:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:46:00 INFO - 'USER': 'cltbld', 10:46:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:46:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:46:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:46:00 INFO - 'XPC_FLAGS': '0x0', 10:46:00 INFO - 'XPC_SERVICE_NAME': '0', 10:46:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:46:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:46:01 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 10:46:01 INFO - Cleaning up... 10:46:01 INFO - Return code: 0 10:46:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:46:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:46:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:46:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:46:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:46:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10af02a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af094c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ca959e960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ada6d30>, '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 0x10ac0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad9db20>, '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.IwxP2X65XC/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.xDoMx62y6g/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 10:46:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 10:46:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:46:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IwxP2X65XC/Render', 10:46:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:46:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:46:01 INFO - 'HOME': '/Users/cltbld', 10:46:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:46:01 INFO - 'LOGNAME': 'cltbld', 10:46:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:46:01 INFO - 'MOZ_NO_REMOTE': '1', 10:46:01 INFO - 'NO_EM_RESTART': '1', 10:46:01 INFO - 'PAGER': '/bin/cat', 10:46:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:46:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:46:01 INFO - 'PWD': '/builds/slave/test', 10:46:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:46:01 INFO - 'SHELL': '/bin/bash', 10:46:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xDoMx62y6g/Listeners', 10:46:01 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 10:46:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:46:01 INFO - 'USER': 'cltbld', 10:46:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:46:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:46:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:46:01 INFO - 'XPC_FLAGS': '0x0', 10:46:01 INFO - 'XPC_SERVICE_NAME': '0', 10:46:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:46:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:46:01 INFO - Downloading/unpacking psutil>=0.7.1 10:46:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:46:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:46:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:46:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:46:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:46:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:46:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:46:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:46:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:46:04 INFO - Installing collected packages: psutil 10:46:04 INFO - Running setup.py install for psutil 10:46:04 INFO - building 'psutil._psutil_osx' extension 10:46:04 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 10:46:04 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 10:46:04 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 10:46:05 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 10:46:05 INFO - building 'psutil._psutil_posix' extension 10:46:05 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 10:46:05 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:46:05 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:46:05 INFO - ^ 10:46:05 INFO - 1 warning generated. 10:46:05 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 10:46:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:46:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:46:05 INFO - Successfully installed psutil 10:46:05 INFO - Cleaning up... 10:46:05 INFO - Return code: 0 10:46:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:46:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:46:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:46:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:46:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:46:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46:05 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 0x10af02a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af094c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ca959e960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ada6d30>, '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 0x10ac0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad9db20>, '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.IwxP2X65XC/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.xDoMx62y6g/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 10:46:05 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 10:46:05 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 10:46:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IwxP2X65XC/Render', 10:46:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:46:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:46:05 INFO - 'HOME': '/Users/cltbld', 10:46:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:46:05 INFO - 'LOGNAME': 'cltbld', 10:46:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:46:05 INFO - 'MOZ_NO_REMOTE': '1', 10:46:05 INFO - 'NO_EM_RESTART': '1', 10:46:05 INFO - 'PAGER': '/bin/cat', 10:46:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:46:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:46:05 INFO - 'PWD': '/builds/slave/test', 10:46:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:46:05 INFO - 'SHELL': '/bin/bash', 10:46:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xDoMx62y6g/Listeners', 10:46:05 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 10:46:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:46:05 INFO - 'USER': 'cltbld', 10:46:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:46:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:46:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:46:05 INFO - 'XPC_FLAGS': '0x0', 10:46:05 INFO - 'XPC_SERVICE_NAME': '0', 10:46:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:46:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:46:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:46:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:46:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:46:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:46:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:46:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:46:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:46:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:46:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:46:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:46:08 INFO - Installing collected packages: mozsystemmonitor 10:46:08 INFO - Running setup.py install for mozsystemmonitor 10:46:08 INFO - Successfully installed mozsystemmonitor 10:46:08 INFO - Cleaning up... 10:46:08 INFO - Return code: 0 10:46:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:46: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')]} 10:46:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:46:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46: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')]} 10:46:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:46:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46:08 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 0x10af02a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af094c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ca959e960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ada6d30>, '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 0x10ac0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad9db20>, '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.IwxP2X65XC/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.xDoMx62y6g/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 10:46:08 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 10:46:08 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 10:46:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IwxP2X65XC/Render', 10:46:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:46:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:46:08 INFO - 'HOME': '/Users/cltbld', 10:46:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:46:08 INFO - 'LOGNAME': 'cltbld', 10:46:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:46:08 INFO - 'MOZ_NO_REMOTE': '1', 10:46:08 INFO - 'NO_EM_RESTART': '1', 10:46:08 INFO - 'PAGER': '/bin/cat', 10:46:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:46:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:46:08 INFO - 'PWD': '/builds/slave/test', 10:46:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:46:08 INFO - 'SHELL': '/bin/bash', 10:46:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xDoMx62y6g/Listeners', 10:46:08 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 10:46:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:46:08 INFO - 'USER': 'cltbld', 10:46:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:46:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:46:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:46:08 INFO - 'XPC_FLAGS': '0x0', 10:46:08 INFO - 'XPC_SERVICE_NAME': '0', 10:46:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:46:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:46:08 INFO - Downloading/unpacking blobuploader==1.2.4 10:46:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:46:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:46:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:46:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:46:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:46:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:46:11 INFO - Downloading blobuploader-1.2.4.tar.gz 10:46:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:46:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:46:11 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 10:46:11 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 10:46:11 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 10:46:11 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 10:46:11 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 10:46:11 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 10:46:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:46:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:46:11 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 10:46:11 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 10:46:11 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 10:46:11 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 10:46:11 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 10:46:11 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 10:46:12 INFO - Downloading docopt-0.6.1.tar.gz 10:46:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:46:12 INFO - Installing collected packages: blobuploader, requests, docopt 10:46:12 INFO - Running setup.py install for blobuploader 10:46:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:46:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:46:12 INFO - Running setup.py install for requests 10:46:13 INFO - Running setup.py install for docopt 10:46:13 INFO - Successfully installed blobuploader requests docopt 10:46:13 INFO - Cleaning up... 10:46:13 INFO - Return code: 0 10:46:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:46: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')]} 10:46:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:46:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46: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')]} 10:46:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:46:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46:13 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 0x10af02a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af094c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ca959e960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ada6d30>, '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 0x10ac0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad9db20>, '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.IwxP2X65XC/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.xDoMx62y6g/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 10:46:13 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 10:46:13 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 10:46:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IwxP2X65XC/Render', 10:46:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:46:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:46:13 INFO - 'HOME': '/Users/cltbld', 10:46:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:46:13 INFO - 'LOGNAME': 'cltbld', 10:46:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:46:13 INFO - 'MOZ_NO_REMOTE': '1', 10:46:13 INFO - 'NO_EM_RESTART': '1', 10:46:13 INFO - 'PAGER': '/bin/cat', 10:46:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:46:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:46:13 INFO - 'PWD': '/builds/slave/test', 10:46:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:46:13 INFO - 'SHELL': '/bin/bash', 10:46:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xDoMx62y6g/Listeners', 10:46:13 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 10:46:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:46:13 INFO - 'USER': 'cltbld', 10:46:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:46:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:46:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:46:13 INFO - 'XPC_FLAGS': '0x0', 10:46:13 INFO - 'XPC_SERVICE_NAME': '0', 10:46:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:46:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:46:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:46:13 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-KxZm4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:46:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:46:13 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-5Fu3D2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:46:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:46:13 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-Z8Lyxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:46:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:46:13 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-kDMpLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:46:14 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-QTHgQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:46:14 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-82mTLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:46:14 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-RaS_4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:46:14 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-ytPPo_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:46:14 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-OJvcU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:46:14 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-p7rjfv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:46:14 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-xIujbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:46:14 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-bYc9T2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:46:14 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-SgNjRK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:46:14 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-Xj22Ya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:46:15 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-NnI39Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:46:15 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-Fpy49E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:46:15 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-Yo5J3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:46:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:46:15 INFO - Running setup.py install for manifestparser 10:46:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:46:15 INFO - Running setup.py install for mozcrash 10:46:15 INFO - Running setup.py install for mozdebug 10:46:15 INFO - Running setup.py install for mozdevice 10:46:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:46:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:46:16 INFO - Running setup.py install for mozfile 10:46:16 INFO - Running setup.py install for mozhttpd 10:46:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:46:16 INFO - Running setup.py install for mozinfo 10:46:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:46:16 INFO - Running setup.py install for mozInstall 10:46:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:46:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:46:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:46:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:46:16 INFO - Running setup.py install for mozleak 10:46:16 INFO - Running setup.py install for mozlog 10:46:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:46:16 INFO - Running setup.py install for moznetwork 10:46:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:46:17 INFO - Running setup.py install for mozprocess 10:46:17 INFO - Running setup.py install for mozprofile 10:46:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:46:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:46:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:46:17 INFO - Running setup.py install for mozrunner 10:46:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:46:17 INFO - Running setup.py install for mozscreenshot 10:46:17 INFO - Running setup.py install for moztest 10:46:17 INFO - Running setup.py install for mozversion 10:46:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:46:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:46:17 INFO - Cleaning up... 10:46:18 INFO - Return code: 0 10:46:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:46: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')]} 10:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:46:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46: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')]} 10:46:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:46:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46:18 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 0x10af02a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af094c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ca959e960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ada6d30>, '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 0x10ac0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad9db20>, '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.IwxP2X65XC/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.xDoMx62y6g/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 10:46:18 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 10:46:18 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 10:46:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IwxP2X65XC/Render', 10:46:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:46:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:46:18 INFO - 'HOME': '/Users/cltbld', 10:46:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:46:18 INFO - 'LOGNAME': 'cltbld', 10:46:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:46:18 INFO - 'MOZ_NO_REMOTE': '1', 10:46:18 INFO - 'NO_EM_RESTART': '1', 10:46:18 INFO - 'PAGER': '/bin/cat', 10:46:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:46:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:46:18 INFO - 'PWD': '/builds/slave/test', 10:46:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:46:18 INFO - 'SHELL': '/bin/bash', 10:46:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xDoMx62y6g/Listeners', 10:46:18 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 10:46:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:46:18 INFO - 'USER': 'cltbld', 10:46:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:46:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:46:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:46:18 INFO - 'XPC_FLAGS': '0x0', 10:46:18 INFO - 'XPC_SERVICE_NAME': '0', 10:46:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:46:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:46:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:46:18 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-qYk4hW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:46:18 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)) 10:46:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:46:18 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-_vLhKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:46:18 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)) 10:46:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:46:18 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-XTIxji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:46:18 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)) 10:46:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:46:18 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-TJyJq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:46:18 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)) 10:46:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:46:18 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-a3lbWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:46:18 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)) 10:46:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:46:18 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-hI5D69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:46:18 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)) 10:46:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:46:18 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-0nfLgh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:46:19 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)) 10:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:46:19 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-G_vlao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:46:19 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)) 10:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:46:19 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-iL13Xl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:46:19 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)) 10:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:46:19 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-z9PayZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:46:19 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)) 10:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:46:19 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-jDWJsy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:46:19 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)) 10:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:46:19 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-rRaAdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:46:19 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)) 10:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:46:19 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-gAnksi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:46:19 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)) 10:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:46:19 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-aD_fvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:46:19 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)) 10:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:46:19 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-XC_PVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:46:19 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)) 10:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:46:19 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-GjNt15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:46:19 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)) 10:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:46:19 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-dmv1Ec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:46:20 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)) 10:46:20 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)) 10:46:20 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)) 10:46:20 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)) 10:46:20 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)) 10:46:20 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)) 10:46:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:46:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:46:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:46:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:46:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:46:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:46:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:46:22 INFO - Downloading blessings-1.6.tar.gz 10:46:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:46:22 INFO - Installing collected packages: blessings 10:46:22 INFO - Running setup.py install for blessings 10:46:22 INFO - Successfully installed blessings 10:46:22 INFO - Cleaning up... 10:46:22 INFO - Return code: 0 10:46:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:46:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:46:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:46:23 INFO - Reading from file tmpfile_stdout 10:46:23 INFO - Current package versions: 10:46:23 INFO - blessings == 1.6 10:46:23 INFO - blobuploader == 1.2.4 10:46:23 INFO - docopt == 0.6.1 10:46:23 INFO - manifestparser == 1.1 10:46:23 INFO - mozInstall == 1.12 10:46:23 INFO - mozcrash == 0.17 10:46:23 INFO - mozdebug == 0.1 10:46:23 INFO - mozdevice == 0.48 10:46:23 INFO - mozfile == 1.2 10:46:23 INFO - mozhttpd == 0.7 10:46:23 INFO - mozinfo == 0.9 10:46:23 INFO - mozleak == 0.1 10:46:23 INFO - mozlog == 3.1 10:46:23 INFO - moznetwork == 0.27 10:46:23 INFO - mozprocess == 0.22 10:46:23 INFO - mozprofile == 0.28 10:46:23 INFO - mozrunner == 6.11 10:46:23 INFO - mozscreenshot == 0.1 10:46:23 INFO - mozsystemmonitor == 0.0 10:46:23 INFO - moztest == 0.7 10:46:23 INFO - mozversion == 1.4 10:46:23 INFO - psutil == 3.1.1 10:46:23 INFO - requests == 1.2.3 10:46:23 INFO - wsgiref == 0.1.2 10:46:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:46:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:46:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:46:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:46:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46:23 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 0x10af02a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af094c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ca959e960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ada6d30>, '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 0x10ac0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad9db20>, '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.IwxP2X65XC/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.xDoMx62y6g/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 10:46:23 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 10:46:23 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 10:46:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IwxP2X65XC/Render', 10:46:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:46:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:46:23 INFO - 'HOME': '/Users/cltbld', 10:46:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:46:23 INFO - 'LOGNAME': 'cltbld', 10:46:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:46:23 INFO - 'MOZ_NO_REMOTE': '1', 10:46:23 INFO - 'NO_EM_RESTART': '1', 10:46:23 INFO - 'PAGER': '/bin/cat', 10:46:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:46:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:46:23 INFO - 'PWD': '/builds/slave/test', 10:46:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:46:23 INFO - 'SHELL': '/bin/bash', 10:46:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xDoMx62y6g/Listeners', 10:46:23 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 10:46:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:46:23 INFO - 'USER': 'cltbld', 10:46:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:46:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:46:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:46:23 INFO - 'XPC_FLAGS': '0x0', 10:46:23 INFO - 'XPC_SERVICE_NAME': '0', 10:46:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:46:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:46:23 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)) 10:46:23 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)) 10:46:23 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)) 10:46:23 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)) 10:46:23 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)) 10:46:23 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)) 10:46:23 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)) 10:46:23 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)) 10:46:23 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)) 10:46:23 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)) 10:46:23 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)) 10:46:23 INFO - Cleaning up... 10:46:23 INFO - Return code: 0 10:46:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:46:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:46:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:46:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:46:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10af02a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af094c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ca959e960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ada6d30>, '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 0x10ac0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad9db20>, '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.IwxP2X65XC/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.xDoMx62y6g/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 10:46:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:46:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:46:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IwxP2X65XC/Render', 10:46:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:46:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:46:23 INFO - 'HOME': '/Users/cltbld', 10:46:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:46:23 INFO - 'LOGNAME': 'cltbld', 10:46:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:46:23 INFO - 'MOZ_NO_REMOTE': '1', 10:46:23 INFO - 'NO_EM_RESTART': '1', 10:46:23 INFO - 'PAGER': '/bin/cat', 10:46:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:46:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:46:23 INFO - 'PWD': '/builds/slave/test', 10:46:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:46:23 INFO - 'SHELL': '/bin/bash', 10:46:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xDoMx62y6g/Listeners', 10:46:23 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 10:46:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:46:23 INFO - 'USER': 'cltbld', 10:46:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:46:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:46:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:46:23 INFO - 'XPC_FLAGS': '0x0', 10:46:23 INFO - 'XPC_SERVICE_NAME': '0', 10:46:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:46:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:46:23 INFO - Downloading/unpacking jsonschema 10:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:46:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:46:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:46:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:46:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:46:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:46:25 INFO - Downloading/unpacking functools32 (from jsonschema) 10:46:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:46:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:46:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:46:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:46:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:46:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:46:26 INFO - Downloading functools32-3.2.3-2.tar.gz 10:46:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:46:26 INFO - warning: no files found matching '*.txt' 10:46:26 INFO - no previously-included directories found matching 'build' 10:46:26 INFO - no previously-included directories found matching 'dist' 10:46:26 INFO - no previously-included directories found matching '.git*' 10:46:26 INFO - Installing collected packages: jsonschema, functools32 10:46:26 INFO - Running setup.py install for functools32 10:46:26 INFO - warning: no files found matching '*.txt' 10:46:26 INFO - no previously-included directories found matching 'build' 10:46:26 INFO - no previously-included directories found matching 'dist' 10:46:26 INFO - no previously-included directories found matching '.git*' 10:46:26 INFO - Successfully installed jsonschema functools32 10:46:26 INFO - Cleaning up... 10:46:26 INFO - Return code: 0 10:46:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:46:26 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')]} 10:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:46:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46:26 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')]} 10:46:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:46:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46:26 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 0x10af02a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af094c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ca959e960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ada6d30>, '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 0x10ac0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad9db20>, '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.IwxP2X65XC/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.xDoMx62y6g/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 10:46:26 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 10:46:26 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 10:46:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IwxP2X65XC/Render', 10:46:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:46:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:46:26 INFO - 'HOME': '/Users/cltbld', 10:46:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:46:26 INFO - 'LOGNAME': 'cltbld', 10:46:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:46:26 INFO - 'MOZ_NO_REMOTE': '1', 10:46:26 INFO - 'NO_EM_RESTART': '1', 10:46:26 INFO - 'PAGER': '/bin/cat', 10:46:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:46:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:46:26 INFO - 'PWD': '/builds/slave/test', 10:46:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:46:26 INFO - 'SHELL': '/bin/bash', 10:46:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xDoMx62y6g/Listeners', 10:46:26 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 10:46:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:46:26 INFO - 'USER': 'cltbld', 10:46:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:46:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:46:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:46:26 INFO - 'XPC_FLAGS': '0x0', 10:46:26 INFO - 'XPC_SERVICE_NAME': '0', 10:46:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:46:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:46:26 INFO - Downloading/unpacking flake8 10:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:46:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:46:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:46:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:46:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:46:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:46:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:46:29 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 10:46:29 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 10:46:29 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 10:46:29 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 10:46:29 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 10:46:29 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 10:46:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:46:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:46:29 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 10:46:29 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 10:46:29 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 10:46:29 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 10:46:29 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 10:46:29 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 10:46:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:46:30 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 10:46:30 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 10:46:30 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 10:46:30 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 10:46:30 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 10:46:30 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 10:46:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:46:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:46:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:46:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:46:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:46:30 INFO - no previously-included directories found matching 'docs/_build' 10:46:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:46:30 INFO - Running setup.py install for pep8 10:46:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:46:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:46:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:46:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:46:30 INFO - no previously-included directories found matching 'docs/_build' 10:46:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:46:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:46:30 INFO - Cleaning up... 10:46:31 INFO - Return code: 0 10:46:31 INFO - Running post-action listener: _resource_record_post_action 10:46:31 INFO - Running post-action listener: _start_resource_monitoring 10:46:31 INFO - Starting resource monitoring. 10:46:31 INFO - ##### 10:46:31 INFO - ##### Running install step. 10:46:31 INFO - ##### 10:46:31 INFO - Running pre-action listener: _resource_record_pre_action 10:46:31 INFO - Running main action method: install 10:46:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:46:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:46:31 INFO - Reading from file tmpfile_stdout 10:46:31 INFO - Detecting whether we're running mozinstall >=1.0... 10:46:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:46:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:46:31 INFO - Reading from file tmpfile_stdout 10:46:31 INFO - Output received: 10:46:31 INFO - Usage: mozinstall [options] installer 10:46:31 INFO - Options: 10:46:31 INFO - -h, --help show this help message and exit 10:46:31 INFO - -d DEST, --destination=DEST 10:46:31 INFO - Directory to install application into. [default: 10:46:31 INFO - "/builds/slave/test"] 10:46:31 INFO - --app=APP Application being installed. [default: firefox] 10:46:31 INFO - mkdir: /builds/slave/test/build/application 10:46:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:46:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.mac.dmg --destination /builds/slave/test/build/application 10:46:53 INFO - Reading from file tmpfile_stdout 10:46:53 INFO - Output received: 10:46:53 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 10:46:53 INFO - Running post-action listener: _resource_record_post_action 10:46:53 INFO - ##### 10:46:53 INFO - ##### Running run-tests step. 10:46:53 INFO - ##### 10:46:53 INFO - Running pre-action listener: _resource_record_pre_action 10:46:53 INFO - Running main action method: run_tests 10:46:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:46:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:46:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:46:53 INFO - 2016-04-27 10:46:53.987 screenresolution[1639:7679] starting screenresolution argv=screenresolution get 10:46:53 INFO - 2016-04-27 10:46:53.990 screenresolution[1639:7679] Display 0: 1600x1200x32@60 10:46:53 INFO - 2016-04-27 10:46:53.996 screenresolution[1640:7681] starting screenresolution argv=screenresolution list 10:46:53 INFO - Available Modes on Display 0 10:46:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:46:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:46:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:46:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:46:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:46:54 INFO - Intel Iris: 10:46:54 INFO - Chipset Model: Intel Iris 10:46:54 INFO - Type: GPU 10:46:54 INFO - Bus: Built-In 10:46:54 INFO - VRAM (Dynamic, Max): 1536 MB 10:46:54 INFO - Vendor: Intel (0x8086) 10:46:54 INFO - Device ID: 0x0a2e 10:46:54 INFO - Revision ID: 0x0009 10:46:54 INFO - Displays: 10:46:54 INFO - Display: 10:46:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:46:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:46:54 INFO - Display Serial Number: 1600x1200 60 10:46:54 INFO - Main Display: Yes 10:46:54 INFO - Mirror: Off 10:46:54 INFO - Online: Yes 10:46:54 INFO - Rotation: Supported 10:46:54 INFO - Return code: 0 10:46:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:46:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:46:54 INFO - Python 2.7.3 10:46:54 INFO - Return code: 0 10:46:54 INFO - grabbing minidump binary from tooltool 10:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:46:54 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 0x10ada6d30>, '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 0x10ac0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad9db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:46:54 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 10:46:54 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 10:46:54 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:46:54 INFO - Return code: 0 10:46:54 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:46:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:46:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:46:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:46:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:46:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:46:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:46:55 INFO - Return code: 0 10:46:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dmZXRcCGTMO-b2qIY_0bKw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0045', '--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 10:46:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dmZXRcCGTMO-b2qIY_0bKw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0045 --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 10:46:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IwxP2X65XC/Render', 10:46:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:46:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:46:55 INFO - 'HOME': '/Users/cltbld', 10:46:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:46:55 INFO - 'LOGNAME': 'cltbld', 10:46:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:46:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:46:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:46:55 INFO - 'MOZ_NO_REMOTE': '1', 10:46:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:46:55 INFO - 'NO_EM_RESTART': '1', 10:46:55 INFO - 'PAGER': '/bin/cat', 10:46:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:46:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:46:55 INFO - 'PWD': '/builds/slave/test', 10:46:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:46:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:46:55 INFO - 'SHELL': '/bin/bash', 10:46:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xDoMx62y6g/Listeners', 10:46:55 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 10:46:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:46:55 INFO - 'USER': 'cltbld', 10:46:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:46:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:46:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:46:55 INFO - 'XPC_FLAGS': '0x0', 10:46:55 INFO - 'XPC_SERVICE_NAME': '0', 10:46:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:46:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dmZXRcCGTMO-b2qIY_0bKw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0045', '--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 10:46:55 INFO - mozversion application_buildid: 20160427085158 10:46:55 INFO - mozversion application_changeset: 8c546512c77169d62f232edd00fa896eff5038e0 10:46:55 INFO - mozversion application_display_name: Firefox 10:46:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:46:55 INFO - mozversion application_name: Firefox 10:46:55 INFO - mozversion application_remotingname: firefox 10:46:55 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:46:55 INFO - mozversion application_vendor: Mozilla 10:46:55 INFO - mozversion application_version: 47.0 10:46:55 INFO - mozversion platform_buildid: 20160427085158 10:46:55 INFO - mozversion platform_changeset: 8c546512c77169d62f232edd00fa896eff5038e0 10:46:55 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:46:55 INFO - mozversion platform_version: 47.0 10:46:55 INFO - using testdate: 1461779215 10:46:55 INFO - actual date: 1461779215 10:46:55 INFO - starting webserver on 'localhost:49283' 10:46:55 INFO - SUITE-START | Running 2 tests 10:46:55 INFO - TEST-START | dromaeo_css 10:46:55 INFO - operating with platform_type : mac_ 10:46:55 INFO - Initialising browser for dromaeo_css test... 10:46:55 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/tmpRPvDPq/profile http://localhost:49283/getInfo.html) 10:46:58 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 10:46:58 INFO - PROCESS | 1658 | colorDepth:24 10:46:58 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 10:46:58 INFO - PROCESS | 1658 | __metrics 10:46:58 INFO - PROCESS | 1658 | 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" 10:46:58 INFO - PROCESS | 1658 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:46:58 INFO - TEST-INFO | 1658: exit 0 10:46:58 INFO - Browser initialized. 10:46:58 INFO - Running cycle 1/1 for dromaeo_css test... 10:46:58 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/tmpRPvDPq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:47:10 INFO - PROCESS | 1661 | RSS: Main: 156704768 10:47:10 INFO - PROCESS | 1661 | 10:48:02 INFO - PROCESS | 1661 | 1461779282233 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:50:11 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49283/tests/dromaeo/cssquery-ext.html) 10:50:12 INFO - PROCESS | 1661 | RSS: Main: 295669760 10:50:12 INFO - PROCESS | 1661 | 10:53:14 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-ext.html (next: http://localhost:49283/tests/dromaeo/cssquery-jquery.html) 10:53:15 INFO - PROCESS | 1661 | RSS: Main: 292151296 10:53:15 INFO - PROCESS | 1661 | 10:56:17 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49283/tests/dromaeo/cssquery-mootools.html) 10:56:17 INFO - PROCESS | 1661 | RSS: Main: 296419328 10:56:17 INFO - PROCESS | 1661 | 10:59:19 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49283/tests/dromaeo/cssquery-prototype.html) 10:59:20 INFO - PROCESS | 1661 | RSS: Main: 252608512 10:59:20 INFO - PROCESS | 1661 | 11:02:23 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49283/tests/dromaeo/cssquery-yui.html) 11:02:24 INFO - PROCESS | 1661 | RSS: Main: 255516672 11:02:24 INFO - PROCESS | 1661 | 11:05:26 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-yui.html (next: http://localhost:49283/tests/dromaeo/cssquery-dojo.html) 11:05:26 INFO - PROCESS | 1661 | RSS: Main: 304140288 11:05:26 INFO - PROCESS | 1661 | 11:05:26 INFO - PROCESS | 1661 | __start_tp_report 11:05:26 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 11:05:26 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 11:05:26 INFO - PROCESS | 1661 | |i|pagename|runs| 11:05:26 INFO - PROCESS | 1661 | |0;dojo.html;3508.736844736645;3566.090646885042;3567.32220878033;3589.5692516897966;3637.3816451203293;5743.942560574393;5785.27684039495;5785.710714464276;5796.681182534959;5820.505257053151;5762.481376676098;5826.038703613898;5831.562632802546;5840.883182336351;5847.006008978473;5219.947800521984;5237.083510385677;5267.947320526784;5294.629375943686;5315.202719592054;5343.118385466413;5344.518993290603;5345.4387289334645;5349.277847490597;5361.490658387447;5326.946730532683;5358.410574836765;5378.220158077076;5381.650192737479;5383;5362.8123015694455;5375.865603359908;5416.51251387377;5417.729113544347;5480.26016487773;5146.330976973007;5305.920411193835;5316.175992721096;5347.224652425377;5349.358077030743;5665.036943719578;5715.942840571583;5722.2561067061015;5744.597878148531;5749.59752817303;6218.906716399258;6348.079528468393;6351.269603995507;6361.141245931786;6378.394052565045;5318.574514038867;5944.7027648617395;6003.129546215774;6294.402031806971;6366.840828979266;5964.105384192362;5978.940210597882;5983;5996.820095397145;6001.159837622737;6300.684965751786;6311.779087731908;6413.775517856852;6415.775447859302;6435.613863168225;6283.96858015707;6284.308726040132;6306.842328941813;6326.715297811517;6340.587861788969;6318.778842740482;6342.904856427157;6349.873002539924;6352.936470635234;6371.713272902731;5878.177055212188;6172.629642221481;6203.131561581382;6327.11420401135;6366.236051673829;6332.873342533216;6364.045393190966;6368.235811702625;6377.840553986188;6383.042543618401;4952.628552858478;4960.404751429852;4982.128127577659;4986.650934434555;4989.176785830297;4400.207962566705;4522.4346956630425;4530.637548996073;4538.9546104539195;4543.659225558096;5890.852728681817;5919.6152250103605;5928.584999050111;5930.7924222652;5945.583809133319;6247.625142491374;6320.968395157995;6342.841428964312;6352.205974253218;6357.11000459936;5969.940300597025;5991.490723288569;5994.970025149846;6002.939970600325;6011.579189456696;5459.071957767189;5468;5469.179623056573;5471.316085489314;5478.287822583039;6291.1192433059405;6416.935830641727;6450.935490645127;6467.223933128054;6468.773592924225;6317.273513546001;6320.020396838498;6340.365963403808;6357.554971151975;6364.363563643598;6507.251666058464;6508.902366464602;6512.218533775977;6512.739490420519;6518.902216466662;6138.694953005908;6232.937670623236;6239.75040998355;6349.14286571307;6349.68251587428;6316.873662526816;6329.651869147241;6332.208473940757;6341.809745707452;6370.55406121567;6265.028920517327;6272.933601287701;6282.937170628235;6286.15136956505;6293.056041593798;6100.420460056288;6140.41222487552;6190.1952746142715;6243.750249989949;6257.2491301044165;6042.939570604238;6063.787767428119;6084.878302433838;6086.1175129606845;6090.330063692902;6081.361457047124;6090.512758979359;6162.322144564184;6165.599236049642;6210.441060304594;6102.572819902564;6166.691665416622;6184.350643182401;6189.81430557084;6201.317855036033 11:05:26 INFO - PROCESS | 1661 | |1;ext.html;473.39878354489775;571.5684658083146;597.1252115650572;622.5984240165092;651.4397618048479;31967.84016079919;33392.49911251333;41013;41215.79392103035;41252.17495650085;43662;44292;44340.55659443405;44353.55646443534;44402.77798611002;8576.228139467446;9850.162736167416;10082.546285417136;10083.19334453242;10086;9713.125818676317;9851.655192068243;9852.50737463124;9857.852132218022;9875.160611348045;9828.655997040105;9975.800483990315;9992.200623950102;9998.800023999516;10009.549570269355;9913.801723965516;9952.203823694088;9954.402735835873;9979.550920208609;9989.350692204984;9816.950915245377;9855.852162217572;9956.950215248877;9958.352707074017;9961.252906032005;43217.35173972393;43675.34486982698;43762.12475750499;43848.56151438509;43871.683849484565;3317.2204531934976;3448.775829571095;3561.893143205708;3832.9041773955596;4063.9593604063875;27875.581866272023;29124.708752912622;29145.854270728723;29378.55932161019;29455;2814.8311101333984;2824.7034061423665;2866.226118947893;2897.9710202897913;2899.405621847516;467267.6636616829;468976;472868;473120;473592;48429.75785121052;49016;49126.75436622794;73672.63163684147;74260;49823.75088124536;49877;50020.249696254585;50081;50084;15253.466128685443;17530.824691752918;18110.5472363192;18297.176627051813;18321.63356732858;14652.487162949246;14750.262486875614;14750.704985900222;14757.852421475647;14758.778618320519;15776.842231577766;15777;15777.633354996613;15785.921070394805;15824.68350632981;6664.600123992576;6764.526483146133;6817.829554261084;6818.2159051708695;6819.897701534481;906.465185540521;1047.61238341814;1190.2441949362217;1193.91045671575;1208.709909621702;31251.37497250088;31358.37283254368;31506.048477762488;31549.52675709866;31714.207144821103;1176.8411264479187;1182.9704257393462;1249.28790589365;1253.9059570532247;1263.646179069862;14169.079009864532;15484.993475424062;15722.764158537631;16065.598360041093;16119.919400402923;492506;498255;498476.50761746685;498948.5052574714;500114;51951.48048519466;52466.21300680493;61794;63840.36159638437;63969.36030639727;1452.469848505288;1489.113977183574;1501.8347981722002;1554.3627112883664;1598.8401159884152;29931.401371972002;30138.9451369201;30920.226994325323;32287;33334.499982499794;46740;57619.84760304854;58352.70823646025;58443.415565843796;58444.415555843894;476360.47279054916;479689;481187;481206;482043;38562.421563677126;47027;47954.76022619865;48171.27743083927;49116.77208069827;45829.54170458253;45952.77023614861;46028.7698561505;47668;47694.28458573193;37895.81052094722;38316;39349.40975885421;39630.603693962694;40655.7967210162;33484.330313394086;37932;38701.80649096736;38944.61055389523;39612;39296.01759956024;40701;41087.38368924409;42176;42255.366169508095;31837.522437163;33802.830985844914;33817.81637642671;33843.830780845936;34116;26193.869030655485;26203.29678570887;26240.8687956559;26422.603660945486;26614.600780987912 11:05:26 INFO - PROCESS | 1661 | |2;jquery.html;377.9508663873696;380.2584959329308;385.7589006870706;389.91811719538896;390.625;19851.50371240718;21028.264010759627;21777;22487.437814054658;22528;21440.571188576258;21909.794961277123;22175.334739957827;22228.555428891414;22305.776942230572;5904.970475147618;5908.1728558001805;6147.969260153693;6178.443940045395;6196.78311259106;6008.639481631094;6104.236970378703;6130.141780150782;6130.203073600448;6137.232845894263;5907.616004959686;6010.36891126432;6076.361981991893;6079.969600151993;6094.207752992127;5847.678377689225;5971.313298970631;5989.940100599004;6029.668368239745;6032.849178770522;5095.159298715707;5227.45111763267;5251.894962100737;5258.211268309784;5267.473252674702;20234.494137646678;25968.480630387287;26056.8697156513;26200.737992620212;26358.604620930702;2323.3610757041947;2594.818362714611;2681.9195424137306;2871.899483518088;3021.214484234115;14653.926730366387;14957.700845983129;15000.099994000286;15139.167345795977;15438.305276262596;1751.9211635476433;1854.1378259109579;1856.5544269375387;1901.4390754727388;1901.982389787263;98629.50685246527;100139.99999999927;102108.48945755298;103138.48430757874;104909;10712.517936692868;10729.570817167381;10813.21581938987;11021.173411994132;11344.319340839576;12752.17110887808;12781.233126012283;12969.286689231994;13071.346432678329;13206.27365494907;8807.867881981776;8991.28069754418;8993.23557497607;8997.505137217517;9088.681896133736;9274.44353338802;9406.952965235267;9433.716988490356;9513.809723805485;9556.426614403159;5373.596980226499;6322.146510221153;6332.68336583169;6341.302456729756;6348.77779277723;1858.8605854560963;1859.4514618187668;1864.2729335559143;1864.7575815143944;1872.9511473574569;780.4575819805294;872.8472517309445;918.7565295196778;980.2207245239908;1062.2776511971933;19315.90342048281;20233.49416264576;20891.477713057295;20917.37247882566;20979;1080.4327727942737;1080.6811990462832;1100.6037826382496;1140.1843281515703;1145.6047663556226;11486.310821350746;11896.405179740977;11923.926846583849;11935.164538482222;11936.52253909834;635881;647875;658239;658763;659069.7046514737;84144;105003.42494862583;107245;108169;108918;1047.4972013433442;1072.9088027517591;1085.0614218700925;1085.8371244313416;1090.6019302954523;17991.730124048412;18056.187471564073;18064.096795159927;18089.63820723552;18812.435626931216;50891.49108508867;51309.743451282506;51354;53017.7349113252;56863.86272274449;71510.28489715036;77169.2283077162;80648.59675701584;81593;82891;8040.356771458152;8255.628496717782;8356.456830306011;8470.449420787629;8503.829923401621;9669.806603868024;13222.867771322548;13376.732465350833;13830.515931942333;13988.440462381392;11655.242409243372;11762.529498819951;12035.819462708241;12071.155019148575;12162.513499460276;11640.243384180001;11662.300261984308;11770.17608767378;11784.057275417774;11975.041996640422;9415.670451534163;11436.398904153259;12045.578404755792;12144.33206173669;12220.816687749513;6971.825704357431;8359.623816928131;8385;8426.95786521088;8474.74575762728;8606.526641034552;11028.944855275993;11842;11872.584459543874;12110.51557937708 11:05:26 INFO - PROCESS | 1661 | |3;mootools.html;1506.3673257231962;1661.6344404231068;1692.1454665393974;2031.2281333093422;2106.2206983416127;8421.621027053781;8938.553072346382;9180.678676246325;9186.265098792097;9188.81622367554;8966.327525435601;9273.933497647773;9289.024652411485;9292.628294868196;9302.023287554794;2576.987115064422;2603.7005744339453;2605.6873175219002;2605.973940260592;2606.335384476956;2534.42975330551;2586.6508021417058;2587.042794166161;2588.2623452316093;2589;2581.5224183526107;2594.7924166066764;2607.4785042991384;2613.163787587973;2616.0451435226196;2584.5257629637827;2594.2995391244353;2602.0112357304292;2607.9478410431684;2608.1653870761365;2578.12343803106;2605.59613259945;2614.7646711795837;2623.0425894548353;2625.3042943619957;9152.359334846564;9210.263178945735;9232.030636783109;9239.076092390775;9249.982501924784;5586.525145362649;5776.768929242825;5778.3643799182055;5784.768609255625;5788.565857560699;3625.021244264034;3673.3938900081453;3787.6591106800242;3790.639889210521;3793.620637936212;1032.5611615063567;1056.1339701444817;1060.48566445274;1087.8150714378496;1087.8422628718793;12401.689957751038;12434.62696119118;12473.126881118325;12475.875241247653;12478.937605312007;4933.975330123399;4989.451160372356;5042.4705405931845;5080.415752188472;5125.513076257749;10476.214283928735;10494.790104198026;10513.947430262953;10525.631602894015;10531.104856087166;5706.828795136153;5712.143178523254;5720.08478643415;5743.310802703702;5748.7125643717645;4288.50682171548;4713.670043097019;4816.964352664194;4819.397575303087;4861.9027619447415;3668.816559172031;4040.91918161641;4108.383742438598;4110.301248787713;4133.937990930139;1347.5148946379295;1356.0981947005132;1365.481117175467;1368.1585824717927;1371.4171477122184;1428.4214892968364;1432.1120905038943;1447.1317209674112;1472.749632562467;1475.859793319633;8464.788380290542;8502.872456913152;8526.488410695378;8535.615897284637;8554.230119289294;1259.9622011339675;1271;1280.5326055989497;1288.2141893444991;1299.6750812296925;6384.808455746335;6405.391487808651;6458.2895881453005;6474.838129046811;6501.057346684799;10952.726181845517;11254.831177532344;11290.040346570633;11317.83023254652;11437.542498300141;10964.17768667353;10972.177086718528;11091.72270693239;11164.553417863195;11204;8689.826203475895;8705.608247628872;8788.824223515494;8791.428557143892;8835.160659737314;8072.959635201786;8207.630656620586;8267.62795674184;8274.710385136492;8275.379346549153;9802.460864652512;9972.750681233027;10058.698239052841;10133.695989120339;10258.897411026093;9828.508574571386;10212.336198147394;10447.425391603534;10490.632827850988;10633.680989570325;7012.439004879496;7103.431725462054;7196.280371962762;7521.7743467696055;7786.26030527099;7188.748393806191;8555.786105347415;8569.828603427772;8570.914290857012;8618.956905215684;7462.813429664085;7594.772156835304;7623.428242881695;7697.499662522142;7709.306162445407;7417.851642967218;7473.962630186814;7492.175860655215;7569.772906812805;7585.469017168745;7987.720429784929;8037.23646253605;8056.83886322282;8097.109317975136;8146.877796832934;7199.1001124859395;7328.120625524971;7329.377002954809;7332.926670733438;7397.667104980396;7428.851422971402;7440.181580026085;7457.440691948234;7489.363404110493;7492 11:05:26 INFO - PROCESS | 1661 | |4;prototype.html;337.4903895118371;344.093314117301;346.54775517949065;347.322432650299;350.9912252193695;6484.610923344597;6519.1199188109595;6552.47580193584;6564.146660934072;6581.967090164542;6459.160309159803;6470.320616335288;6476.1257230273895;6478.578892371993;6488.513361497895;4698.624110071203;4773.11697335994;4792.353032340624;4873.390826146731;4924.359833221676;4860.854174374756;4883.487233840449;4902.58328042115;4912.950870491285;4914.729689867056;3887.319719049169;4837.153498137812;4842.709437433748;4860.270959356108;4867.951320486785;4591.334256532801;4686.226772582537;4798.880027999293;4818.807247710088;4834.323194752737;4157.230912281208;4162.292410290228;4166.312558427856;4188.078622703;4193.454850869368;5109.41241757199;5894;6145.910390467217;6146.969265153691;6175;5675.120356344773;5685.8009969651275;5691.7723291068305;5693.516051135658;5698.772049118031;5958.672273024982;6469.450096741735;6866.622335771531;6869.622170780605;6879.484038697067;4319.524852266248;4486.327050942352;4492.9775351123035;4493.101379724036;4507.873031742064;5748.7987920423;6610.570312929693;7086.503944723871;7217.314355136254;7227;4151.356539736345;4618.099470603267;4618.699784513996;4620.930686039712;4624.699394539344;4682.953170468251;4685.812567497262;4689.109069276895;4689.343491911135;4698.412698412699;4478.350639157304;5486.753096110685;5492.972535137299;5493.7802487900835;5501.724913754377;6639.840994563387;6828.897566536506;6833.350831670983;6869.313068693091;6890.20762612306;1605.4300723243314;1618.8138364088045;1638.8852780305504;1639.7294446416447;1640.2126979050122;862.3618522293458;976.7156189610781;1015.1472762879217;1034.384541197986;1059.4173204737363;5367.329083864517;6531.967340163269;6626.768063117768;6658.6337751424135;6663.167104111986;7203.279672032755;7218.963905180441;7240.927590724131;7245;7250.347468727839;6506.837329066717;6530.595921876819;6553.246376666649;6562.442192413699;6616.4045235929;3767.9246415071543;3808.333541630204;3827.4067519534515;3835.347990841564;3839.117003089305;6032.3967603239325;7297.124345078624;7542.868569714587;7552;7559.962200188964;7321.853562928712;7452.031235939293;7471.925280747231;7481.364084052808;7485.513441626277;7543.962280188564;7574.3183113520045;7578.204288549733;7583.05211848519;7586.696532138763;6467.997460393646;7224.74713385029;7232.63836808147;7239.819004524929;7249.383802376646;6137.631742095488;7030.613316267654;7054.753083642048;7080.114985626797;7093.574385536885;7517.1731109579;7524.021877155935;7524.209957954336;7524.2851929066655;7546.471746977659;4595.908081838412;4640.535946405333;4646.326282689059;4649.070185962889;4661.091087237956;7119.323664252095;7120.003199551963;7120.1099862517185;7132.607706576188;7137.536060156073;6757.493188011017;6926.480513961373;6987.441004719712;6989.161300643752;7017.7192912282935;6260.154879091447;6936.653167341512;6938.202106757787;6966.3730264276455;6985.511014228955;6789.15135608049;6806.55757375769;6828.931710682829;6842.965785171043;6843.178818541807;5624.971875140762;6659.633720145439;6924.480663950123;6955.721771129301;6962.025316455599;6594.670266486753;6718.2609912908565;6783.932160678528;6792.66036698173;6808.217055038734 11:05:26 INFO - PROCESS | 1661 | |5;yui.html;671.5494531811282;686.8488932434863;718.888572271298;725.2819708488598;807.160553024854;15377.384904603816;15777.21113944301;15796.44712435065;15822;15823.20883955802;14411.919106067035;14469.855301447009;14541.636459088502;14541.636459088528;14573.05275157114;798.8881556582054;808.2483290539795;810.8540462716738;812.8943237379133;956.7129861041677;963.9807203855919;992.136840948376;992.6525715999414;994.8557459168417;995.6166875752851;1046.853440518328;1051.295631926611;1056.1867362131154;1056.5456853552969;1058.640062378791;838.2581415447373;1028.7993841200969;1045.002023067972;1048.355261514167;1049.2969710294083;782.4014628808966;784.2980532423506;785.4541093939714;785.8939043229148;786.1431040166246;15463.5360939172;15549.922250388676;15557.611059723484;15572.766408503881;15609.297581608742;12419.627411177678;12845.100842940998;12898.161619494704;13053.934730326288;13280.667983300398;10162.339447935861;10293;10349.63776267827;10452.843207351896;11096.889031109666;3530.064532898784;3601.171730501973;3618.113562177257;3677.3013127505687;3695.907602309937;82382.58808705978;85094.57452712697;85165;85183;85254.72117918236;9344.486053267136;9539.236861051098;9559.856602150834;9736.172425343924;9842.901570984342;21783.455413614785;22023.449413764785;22086.226982055552;22137;23478.64782028271;7740.187280335596;7747.186545412763;7877.881831772528;8019.198080192051;8034.638441270157;4217.451731274976;4261.552536983572;4274.123804620045;4300.892477688083;4365.345198220229;3606.6573675500786;3628.727845411605;3629;3629.165291982859;3647.5805282392867;638.084348959245;655.2562841175301;659.8713250916026;661.2990230355838;675.6115233740619;603.3604379357895;606.5450911816138;608.7534548507862;610.1214251477858;615.6490800243818;8338.166183381612;8398.83202335962;8498.447600906045;8629;8952.731418057469;593.6942474625571;608.7808388979963;616.5406771954832;619.2445216835454;630.6657471540091;3910.550286717064;3935.704822138351;3952.2490726761825;4037.313656678372;4153.709240353207;88898.22203555892;90156.6476502853;90384.09615903888;90475;90606;80285.17576005988;80489;81288;82079.58960205161;82725.17274827295;57701.845963081345;67387;73821.63089184627;74102.88845667211;75354.86967695488;8582.959641255606;8850.645974160961;8867.822643546964;8927.776805579913;8937.553122343726;51212.74393628008;51659.22511162411;51787.74106129596;53069.469305308;54580.72709636585;63283.6835815818;71624.64187679028;74903.62548187442;75034.6248268777;75976.62011689907;11078.723031924266;11179.049780768726;11231.989120979151;11524.884751152382;11646.883531164918;12073.69815754578;12106.939465302617;12291.385430728607;12445.439955202219;12871.099023068295;11531.019863311378;11736.471858766205;11756.654144352915;11866.347350895438;12053.75892482163;9790.853137202805;11893.821592675944;11900.16698831108;11927;12254.264744115382;11100.500477478694;11630.302181869114;11840.28958262507;11877.643670689893;11922.284662920252;8535.658573656985;9626.9037309626;9828.606855725977;9848.162906153057;10111.696649100539;9579;9770.462624555717;9776.85334719994;9787.46168960714;9845.803083938137 11:05:26 INFO - PROCESS | 1661 | __end_tp_report 11:05:26 INFO - PROCESS | 1661 | __start_cc_report 11:05:26 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,1137 11:05:26 INFO - PROCESS | 1661 | __end_cc_report 11:05:26 INFO - PROCESS | 1661 | __startTimestamp1461780326782__endTimestamp 11:05:26 INFO - PROCESS | 1661 | 11:05:26 INFO - PROCESS | 1661 | ------- Summary: start ------- 11:05:26 INFO - PROCESS | 1661 | Number of tests: 6 11:05:26 INFO - PROCESS | 1661 | 11:05:26 INFO - PROCESS | 1661 | [#0] dojo.html Cycles:165 Average:5860.25 Median:6084.88 stddev:630.41 (10.4%) stddev-sans-first:604.75 11:05:26 INFO - PROCESS | 1661 | Values: 3508.7 3566.1 3567.3 3589.6 3637.4 5743.9 5785.3 5785.7 5796.7 5820.5 5762.5 5826.0 5831.6 5840.9 5847.0 5219.9 5237.1 5267.9 5294.6 5315.2 5343.1 5344.5 5345.4 5349.3 5361.5 5326.9 5358.4 5378.2 5381.7 5383.0 5362.8 5375.9 5416.5 5417.7 5480.3 5146.3 5305.9 5316.2 5347.2 5349.4 5665.0 5715.9 5722.3 5744.6 5749.6 6218.9 6348.1 6351.3 6361.1 6378.4 5318.6 5944.7 6003.1 6294.4 6366.8 5964.1 5978.9 5983.0 5996.8 6001.2 6300.7 6311.8 6413.8 6415.8 6435.6 6284.0 6284.3 6306.8 6326.7 6340.6 6318.8 6342.9 6349.9 6352.9 6371.7 5878.2 6172.6 6203.1 6327.1 6366.2 6332.9 6364.0 6368.2 6377.8 6383.0 4952.6 4960.4 4982.1 4986.7 4989.2 4400.2 4522.4 4530.6 4539.0 4543.7 5890.9 5919.6 5928.6 5930.8 5945.6 6247.6 6321.0 6342.8 6352.2 6357.1 5969.9 5991.5 5995.0 6002.9 6011.6 5459.1 5468.0 5469.2 5471.3 5478.3 6291.1 6416.9 6450.9 6467.2 6468.8 6317.3 6320.0 6340.4 6357.6 6364.4 6507.3 6508.9 6512.2 6512.7 6518.9 6138.7 6232.9 6239.8 6349.1 6349.7 6316.9 6329.7 6332.2 6341.8 6370.6 6265.0 6272.9 6282.9 6286.2 6293.1 6100.4 6140.4 6190.2 6243.8 6257.2 6042.9 6063.8 6084.9 6086.1 6090.3 6081.4 6090.5 6162.3 6165.6 6210.4 6102.6 6166.7 6184.4 6189.8 6201.3 11:05:26 INFO - PROCESS | 1661 | 11:05:26 INFO - PROCESS | 1661 | [#1] ext.html Cycles:180 Average:63645.87 Median:41233.98 stddev:128113.41 (310.7%) stddev-sans-first:128385.00 11:05:26 INFO - PROCESS | 1661 | Values: 473.4 571.6 597.1 622.6 651.4 31967.8 33392.5 41013.0 41215.8 41252.2 43662.0 44292.0 44340.6 44353.6 44402.8 8576.2 9850.2 10082.5 10083.2 10086.0 9713.1 9851.7 9852.5 9857.9 9875.2 9828.7 9975.8 9992.2 9998.8 10009.5 9913.8 9952.2 9954.4 9979.6 9989.4 9817.0 9855.9 9957.0 9958.4 9961.3 43217.4 43675.3 43762.1 43848.6 43871.7 3317.2 3448.8 3561.9 3832.9 4064.0 27875.6 29124.7 29145.9 29378.6 29455.0 2814.8 2824.7 2866.2 2898.0 2899.4 467267.7 468976.0 472868.0 473120.0 473592.0 48429.8 49016.0 49126.8 73672.6 74260.0 49823.8 49877.0 50020.2 50081.0 50084.0 15253.5 17530.8 18110.5 18297.2 18321.6 14652.5 14750.3 14750.7 14757.9 14758.8 15776.8 15777.0 15777.6 15785.9 15824.7 6664.6 6764.5 6817.8 6818.2 6819.9 906.5 1047.6 1190.2 1193.9 1208.7 31251.4 31358.4 31506.0 31549.5 31714.2 1176.8 1183.0 1249.3 1253.9 1263.6 14169.1 15485.0 15722.8 16065.6 16119.9 492506.0 498255.0 498476.5 498948.5 500114.0 51951.5 52466.2 61794.0 63840.4 63969.4 1452.5 1489.1 1501.8 1554.4 1598.8 29931.4 30138.9 30920.2 32287.0 33334.5 46740.0 57619.8 58352.7 58443.4 58444.4 476360.5 479689.0 481187.0 481206.0 482043.0 38562.4 47027.0 47954.8 48171.3 49116.8 45829.5 45952.8 46028.8 47668.0 47694.3 37895.8 38316.0 39349.4 39630.6 40655.8 33484.3 37932.0 38701.8 38944.6 39612.0 39296.0 40701.0 41087.4 42176.0 42255.4 31837.5 33802.8 33817.8 33843.8 34116.0 26193.9 26203.3 26240.9 26422.6 26614.6 11:05:26 INFO - PROCESS | 1661 | 11:05:26 INFO - PROCESS | 1661 | [#2] jquery.html Cycles:180 Average:35700.26 Median:22507.72 stddev:107469.77 (477.5%) stddev-sans-first:107738.52 11:05:26 INFO - PROCESS | 1661 | Values: 378.0 380.3 385.8 389.9 390.6 19851.5 21028.3 21777.0 22487.4 22528.0 21440.6 21909.8 22175.3 22228.6 22305.8 5905.0 5908.2 6148.0 6178.4 6196.8 6008.6 6104.2 6130.1 6130.2 6137.2 5907.6 6010.4 6076.4 6080.0 6094.2 5847.7 5971.3 5989.9 6029.7 6032.8 5095.2 5227.5 5251.9 5258.2 5267.5 20234.5 25968.5 26056.9 26200.7 26358.6 2323.4 2594.8 2681.9 2871.9 3021.2 14653.9 14957.7 15000.1 15139.2 15438.3 1751.9 1854.1 1856.6 1901.4 1902.0 98629.5 100140.0 102108.5 103138.5 104909.0 10712.5 10729.6 10813.2 11021.2 11344.3 12752.2 12781.2 12969.3 13071.3 13206.3 8807.9 8991.3 8993.2 8997.5 9088.7 9274.4 9407.0 9433.7 9513.8 9556.4 5373.6 6322.1 6332.7 6341.3 6348.8 1858.9 1859.5 1864.3 1864.8 1873.0 780.5 872.8 918.8 980.2 1062.3 19315.9 20233.5 20891.5 20917.4 20979.0 1080.4 1080.7 1100.6 1140.2 1145.6 11486.3 11896.4 11923.9 11935.2 11936.5 635881.0 647875.0 658239.0 658763.0 659069.7 84144.0 105003.4 107245.0 108169.0 108918.0 1047.5 1072.9 1085.1 1085.8 1090.6 17991.7 18056.2 18064.1 18089.6 18812.4 50891.5 51309.7 51354.0 53017.7 56863.9 71510.3 77169.2 80648.6 81593.0 82891.0 8040.4 8255.6 8356.5 8470.4 8503.8 9669.8 13222.9 13376.7 13830.5 13988.4 11655.2 11762.5 12035.8 12071.2 12162.5 11640.2 11662.3 11770.2 11784.1 11975.0 9415.7 11436.4 12045.6 12144.3 12220.8 6971.8 8359.6 8385.0 8427.0 8474.7 8606.5 11028.9 11842.0 11872.6 12110.5 11:05:26 INFO - PROCESS | 1661 | 11:05:26 INFO - PROCESS | 1661 | [#3] mootools.html Cycles:180 Average:6319.93 Median:4840.65 stddev:3311.28 (68.4%) stddev-sans-first:3300.80 11:05:26 INFO - PROCESS | 1661 | Values: 1506.4 1661.6 1692.1 2031.2 2106.2 8421.6 8938.6 9180.7 9186.3 9188.8 8966.3 9273.9 9289.0 9292.6 9302.0 2577.0 2603.7 2605.7 2606.0 2606.3 2534.4 2586.7 2587.0 2588.3 2589.0 2581.5 2594.8 2607.5 2613.2 2616.0 2584.5 2594.3 2602.0 2607.9 2608.2 2578.1 2605.6 2614.8 2623.0 2625.3 9152.4 9210.3 9232.0 9239.1 9250.0 5586.5 5776.8 5778.4 5784.8 5788.6 3625.0 3673.4 3787.7 3790.6 3793.6 1032.6 1056.1 1060.5 1087.8 1087.8 12401.7 12434.6 12473.1 12475.9 12478.9 4934.0 4989.5 5042.5 5080.4 5125.5 10476.2 10494.8 10513.9 10525.6 10531.1 5706.8 5712.1 5720.1 5743.3 5748.7 4288.5 4713.7 4817.0 4819.4 4861.9 3668.8 4040.9 4108.4 4110.3 4133.9 1347.5 1356.1 1365.5 1368.2 1371.4 1428.4 1432.1 1447.1 1472.7 1475.9 8464.8 8502.9 8526.5 8535.6 8554.2 1260.0 1271.0 1280.5 1288.2 1299.7 6384.8 6405.4 6458.3 6474.8 6501.1 10952.7 11254.8 11290.0 11317.8 11437.5 10964.2 10972.2 11091.7 11164.6 11204.0 8689.8 8705.6 8788.8 8791.4 8835.2 8073.0 8207.6 8267.6 8274.7 8275.4 9802.5 9972.8 10058.7 10133.7 10258.9 9828.5 10212.3 10447.4 10490.6 10633.7 7012.4 7103.4 7196.3 7521.8 7786.3 7188.7 8555.8 8569.8 8570.9 8619.0 7462.8 7594.8 7623.4 7697.5 7709.3 7417.9 7474.0 7492.2 7569.8 7585.5 7987.7 8037.2 8056.8 8097.1 8146.9 7199.1 7328.1 7329.4 7332.9 7397.7 7428.9 7440.2 7457.4 7489.4 7492.0 11:05:26 INFO - PROCESS | 1661 | 11:05:26 INFO - PROCESS | 1661 | [#4] prototype.html Cycles:180 Average:5649.74 Median:6481.59 stddev:1796.99 (27.7%) stddev-sans-first:1757.24 11:05:26 INFO - PROCESS | 1661 | Values: 337.5 344.1 346.5 347.3 351.0 6484.6 6519.1 6552.5 6564.1 6582.0 6459.2 6470.3 6476.1 6478.6 6488.5 4698.6 4773.1 4792.4 4873.4 4924.4 4860.9 4883.5 4902.6 4913.0 4914.7 3887.3 4837.2 4842.7 4860.3 4868.0 4591.3 4686.2 4798.9 4818.8 4834.3 4157.2 4162.3 4166.3 4188.1 4193.5 5109.4 5894.0 6145.9 6147.0 6175.0 5675.1 5685.8 5691.8 5693.5 5698.8 5958.7 6469.5 6866.6 6869.6 6879.5 4319.5 4486.3 4493.0 4493.1 4507.9 5748.8 6610.6 7086.5 7217.3 7227.0 4151.4 4618.1 4618.7 4620.9 4624.7 4683.0 4685.8 4689.1 4689.3 4698.4 4478.4 5486.8 5493.0 5493.8 5501.7 6639.8 6828.9 6833.4 6869.3 6890.2 1605.4 1618.8 1638.9 1639.7 1640.2 862.4 976.7 1015.1 1034.4 1059.4 5367.3 6532.0 6626.8 6658.6 6663.2 7203.3 7219.0 7240.9 7245.0 7250.3 6506.8 6530.6 6553.2 6562.4 6616.4 3767.9 3808.3 3827.4 3835.3 3839.1 6032.4 7297.1 7542.9 7552.0 7560.0 7321.9 7452.0 7471.9 7481.4 7485.5 7544.0 7574.3 7578.2 7583.1 7586.7 6468.0 7224.7 7232.6 7239.8 7249.4 6137.6 7030.6 7054.8 7080.1 7093.6 7517.2 7524.0 7524.2 7524.3 7546.5 4595.9 4640.5 4646.3 4649.1 4661.1 7119.3 7120.0 7120.1 7132.6 7137.5 6757.5 6926.5 6987.4 6989.2 7017.7 6260.2 6936.7 6938.2 6966.4 6985.5 6789.2 6806.6 6828.9 6843.0 6843.2 5625.0 6659.6 6924.5 6955.7 6962.0 6594.7 6718.3 6783.9 6792.7 6808.2 11:05:26 INFO - PROCESS | 1661 | 11:05:26 INFO - PROCESS | 1661 | [#5] yui.html Cycles:180 Average:18821.67 Median:598.53 stddev:26296.11 (4393.5%) stddev-sans-first:26334.57 11:05:26 INFO - PROCESS | 1661 | Values: 671.5 686.8 718.9 725.3 807.2 15377.4 15777.2 15796.4 15822.0 15823.2 14411.9 14469.9 14541.6 14541.6 14573.1 798.9 808.2 810.9 812.9 956.7 964.0 992.1 992.7 994.9 995.6 1046.9 1051.3 1056.2 1056.5 1058.6 838.3 1028.8 1045.0 1048.4 1049.3 782.4 784.3 785.5 785.9 786.1 15463.5 15549.9 15557.6 15572.8 15609.3 12419.6 12845.1 12898.2 13053.9 13280.7 10162.3 10293.0 10349.6 10452.8 11096.9 3530.1 3601.2 3618.1 3677.3 3695.9 82382.6 85094.6 85165.0 85183.0 85254.7 9344.5 9539.2 9559.9 9736.2 9842.9 21783.5 22023.4 22086.2 22137.0 23478.6 7740.2 7747.2 7877.9 8019.2 8034.6 4217.5 4261.6 4274.1 4300.9 4365.3 3606.7 3628.7 3629.0 3629.2 3647.6 638.1 655.3 659.9 661.3 675.6 603.4 606.5 608.8 610.1 615.6 8338.2 8398.8 8498.4 8629.0 8952.7 593.7 608.8 616.5 619.2 630.7 3910.6 3935.7 3952.2 4037.3 4153.7 88898.2 90156.6 90384.1 90475.0 90606.0 80285.2 80489.0 81288.0 82079.6 82725.2 57701.8 67387.0 73821.6 74102.9 75354.9 8583.0 8850.6 8867.8 8927.8 8937.6 51212.7 51659.2 51787.7 53069.5 54580.7 63283.7 71624.6 74903.6 75034.6 75976.6 11078.7 11179.0 11232.0 11524.9 11646.9 12073.7 12106.9 12291.4 12445.4 12871.1 11531.0 11736.5 11756.7 11866.3 12053.8 9790.9 11893.8 11900.2 11927.0 12254.3 11100.5 11630.3 11840.3 11877.6 11922.3 8535.7 9626.9 9828.6 9848.2 10111.7 9579.0 9770.5 9776.9 9787.5 9845.8 11:05:26 INFO - PROCESS | 1661 | -------- Summary: end -------- 11:05:26 INFO - PROCESS | 1661 | 11:05:27 INFO - TEST-INFO | 1661: exit 0 11:05:27 INFO - TEST-OK | dromaeo_css | took 1111577ms 11:05:27 INFO - TEST-START | kraken 11:05:27 INFO - operating with platform_type : mac_ 11:05:27 INFO - Initialising browser for kraken test... 11:05:27 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/tmpUYz92n/profile http://localhost:49283/getInfo.html) 11:05:29 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 11:05:29 INFO - PROCESS | 1671 | colorDepth:24 11:05:29 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 11:05:29 INFO - PROCESS | 1671 | __metrics 11:05:29 INFO - PROCESS | 1671 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:05:29 INFO - PROCESS | 1671 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:05:29 INFO - TEST-INFO | 1671: exit 0 11:05:29 INFO - Browser initialized. 11:05:29 INFO - Running cycle 1/1 for kraken test... 11:05:29 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/tmpUYz92n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:05:41 INFO - PROCESS | 1674 | RSS: Main: 157216768 11:05:41 INFO - PROCESS | 1674 | 11:05:44 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-beat-detection) 11:05:44 INFO - PROCESS | 1674 | RSS: Main: 213213184 11:05:44 INFO - PROCESS | 1674 | 11:05:47 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-dft) 11:05:48 INFO - PROCESS | 1674 | RSS: Main: 223395840 11:05:48 INFO - PROCESS | 1674 | 11:05:51 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-fft) 11:05:51 INFO - PROCESS | 1674 | RSS: Main: 212742144 11:05:51 INFO - PROCESS | 1674 | 11:05:53 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-oscillator) 11:05:54 INFO - PROCESS | 1674 | RSS: Main: 215068672 11:05:54 INFO - PROCESS | 1674 | 11:05:56 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49283/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:05:56 INFO - PROCESS | 1674 | RSS: Main: 214683648 11:05:56 INFO - PROCESS | 1674 | 11:05:59 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49283/tests/kraken/driver.html?testName=imaging-darkroom) 11:06:00 INFO - PROCESS | 1674 | RSS: Main: 214597632 11:06:00 INFO - PROCESS | 1674 | 11:06:03 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49283/tests/kraken/driver.html?testName=imaging-desaturate) 11:06:03 INFO - PROCESS | 1674 | RSS: Main: 214650880 11:06:03 INFO - PROCESS | 1674 | 11:06:06 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49283/tests/kraken/driver.html?testName=json-parse-financial) 11:06:06 INFO - PROCESS | 1674 | RSS: Main: 215179264 11:06:06 INFO - PROCESS | 1674 | 11:06:08 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49283/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:06:09 INFO - PROCESS | 1674 | RSS: Main: 249896960 11:06:09 INFO - PROCESS | 1674 | 11:06:10 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:06:11 INFO - PROCESS | 1674 | RSS: Main: 249241600 11:06:11 INFO - PROCESS | 1674 | 11:06:13 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:06:14 INFO - PROCESS | 1674 | RSS: Main: 254853120 11:06:14 INFO - PROCESS | 1674 | 11:06:16 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:06:17 INFO - PROCESS | 1674 | RSS: Main: 256335872 11:06:17 INFO - PROCESS | 1674 | 11:06:19 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:06:20 INFO - PROCESS | 1674 | RSS: Main: 256352256 11:06:20 INFO - PROCESS | 1674 | 11:06:22 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49283/tests/kraken/driver.html?testName=ai-astar) 11:06:22 INFO - PROCESS | 1674 | RSS: Main: 319545344 11:06:22 INFO - PROCESS | 1674 | 11:06:22 INFO - PROCESS | 1674 | __start_tp_report 11:06:22 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 11:06:22 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 11:06:22 INFO - PROCESS | 1674 | |i|pagename|runs| 11:06:22 INFO - PROCESS | 1674 | |0;ai-astar;112;110;109;109;111;111;119;111;110;110 11:06:22 INFO - PROCESS | 1674 | |1;audio-beat-detection;151;119;155;149;116;139;119;147;150;117 11:06:22 INFO - PROCESS | 1674 | |2;audio-dft;184;186;185;182;185;183;183;183;183;184 11:06:22 INFO - PROCESS | 1674 | |3;audio-fft;74;75;72;115;55;57;58;59;146;47 11:06:22 INFO - PROCESS | 1674 | |4;audio-oscillator;91;92;127;80;77;86;113;76;79;108 11:06:22 INFO - PROCESS | 1674 | |5;imaging-gaussian-blur;88;87;90;86;89;85;89;86;90;86 11:06:22 INFO - PROCESS | 1674 | |6;imaging-darkroom;111;149;107;93;93;94;94;94;94;93 11:06:22 INFO - PROCESS | 1674 | |7;imaging-desaturate;84;85;86;84;84;86;84;83;84;84 11:06:22 INFO - PROCESS | 1674 | |8;json-parse-financial;55;58;58;58;57;59;58;58;53;51 11:06:22 INFO - PROCESS | 1674 | |9;json-stringify-tinderbox;62;60;71;74;69;66;66;67;65;66 11:06:22 INFO - PROCESS | 1674 | |10;stanford-crypto-aes;92;103;95;80;82;79;79;77;81;84 11:06:22 INFO - PROCESS | 1674 | |11;stanford-crypto-ccm;137;125;127;123;130;117;116;126;126;128 11:06:22 INFO - PROCESS | 1674 | |12;stanford-crypto-pbkdf2;134;124;135;135;135;126;133;134;132;136 11:06:22 INFO - PROCESS | 1674 | |13;stanford-crypto-sha256-iterative;67;69;91;93;94;82;67;65;64;66 11:06:22 INFO - PROCESS | 1674 | __end_tp_report 11:06:22 INFO - PROCESS | 1674 | __start_cc_report 11:06:22 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,1206 11:06:22 INFO - PROCESS | 1674 | __end_cc_report 11:06:22 INFO - PROCESS | 1674 | __startTimestamp1461780382395__endTimestamp 11:06:22 INFO - PROCESS | 1674 | 11:06:22 INFO - PROCESS | 1674 | ------- Summary: start ------- 11:06:22 INFO - PROCESS | 1674 | Number of tests: 14 11:06:22 INFO - PROCESS | 1674 | 11:06:22 INFO - PROCESS | 1674 | [#0] ai-astar Cycles:10 Average:111.20 Median:111.00 stddev:2.90 (2.6%) stddev-sans-first:3.06 11:06:22 INFO - PROCESS | 1674 | Values: 112.0 110.0 109.0 109.0 111.0 111.0 119.0 111.0 110.0 110.0 11:06:22 INFO - PROCESS | 1674 | 11:06:22 INFO - PROCESS | 1674 | [#1] audio-beat-detection Cycles:10 Average:136.20 Median:148.00 stddev:16.40 (11.1%) stddev-sans-first:16.49 11:06:22 INFO - PROCESS | 1674 | Values: 151.0 119.0 155.0 149.0 116.0 139.0 119.0 147.0 150.0 117.0 11:06:22 INFO - PROCESS | 1674 | 11:06:22 INFO - PROCESS | 1674 | [#2] audio-dft Cycles:10 Average:183.80 Median:184.00 stddev:1.23 (0.7%) stddev-sans-first:1.30 11:06:22 INFO - PROCESS | 1674 | Values: 184.0 186.0 185.0 182.0 185.0 183.0 183.0 183.0 183.0 184.0 11:06:22 INFO - PROCESS | 1674 | 11:06:22 INFO - PROCESS | 1674 | [#3] audio-fft Cycles:10 Average:75.80 Median:58.50 stddev:31.09 (53.1%) stddev-sans-first:32.97 11:06:22 INFO - PROCESS | 1674 | Values: 74.0 75.0 72.0 115.0 55.0 57.0 58.0 59.0 146.0 47.0 11:06:22 INFO - PROCESS | 1674 | 11:06:22 INFO - PROCESS | 1674 | [#4] audio-oscillator Cycles:10 Average:92.90 Median:79.50 stddev:17.46 (22.0%) stddev-sans-first:18.51 11:06:22 INFO - PROCESS | 1674 | Values: 91.0 92.0 127.0 80.0 77.0 86.0 113.0 76.0 79.0 108.0 11:06:22 INFO - PROCESS | 1674 | 11:06:22 INFO - PROCESS | 1674 | [#5] imaging-gaussian-blur Cycles:10 Average:87.60 Median:88.50 stddev:1.84 (2.1%) stddev-sans-first:1.94 11:06:22 INFO - PROCESS | 1674 | Values: 88.0 87.0 90.0 86.0 89.0 85.0 89.0 86.0 90.0 86.0 11:06:22 INFO - PROCESS | 1674 | 11:06:22 INFO - PROCESS | 1674 | [#6] imaging-darkroom Cycles:10 Average:102.20 Median:93.50 stddev:17.68 (18.9%) stddev-sans-first:18.46 11:06:22 INFO - PROCESS | 1674 | Values: 111.0 149.0 107.0 93.0 93.0 94.0 94.0 94.0 94.0 93.0 11:06:22 INFO - PROCESS | 1674 | 11:06:22 INFO - PROCESS | 1674 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.00 stddev:0.97 (1.2%) stddev-sans-first:1.01 11:06:22 INFO - PROCESS | 1674 | Values: 84.0 85.0 86.0 84.0 84.0 86.0 84.0 83.0 84.0 84.0 11:06:22 INFO - PROCESS | 1674 | 11:06:22 INFO - PROCESS | 1674 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:58.00 stddev:2.64 (4.5%) stddev-sans-first:2.74 11:06:22 INFO - PROCESS | 1674 | Values: 55.0 58.0 58.0 58.0 57.0 59.0 58.0 58.0 53.0 51.0 11:06:22 INFO - PROCESS | 1674 | 11:06:22 INFO - PROCESS | 1674 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:66.50 stddev:4.06 (6.1%) stddev-sans-first:3.95 11:06:22 INFO - PROCESS | 1674 | Values: 62.0 60.0 71.0 74.0 69.0 66.0 66.0 67.0 65.0 66.0 11:06:22 INFO - PROCESS | 1674 | 11:06:22 INFO - PROCESS | 1674 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:81.50 stddev:8.56 (10.5%) stddev-sans-first:8.72 11:06:22 INFO - PROCESS | 1674 | Values: 92.0 103.0 95.0 80.0 82.0 79.0 79.0 77.0 81.0 84.0 11:06:22 INFO - PROCESS | 1674 | 11:06:22 INFO - PROCESS | 1674 | [#11] stanford-crypto-ccm Cycles:10 Average:125.50 Median:126.50 stddev:6.06 (4.8%) stddev-sans-first:4.79 11:06:22 INFO - PROCESS | 1674 | Values: 137.0 125.0 127.0 123.0 130.0 117.0 116.0 126.0 126.0 128.0 11:06:22 INFO - PROCESS | 1674 | 11:06:22 INFO - PROCESS | 1674 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:132.40 Median:134.50 stddev:4.09 (3.0%) stddev-sans-first:4.29 11:06:22 INFO - PROCESS | 1674 | Values: 134.0 124.0 135.0 135.0 135.0 126.0 133.0 134.0 132.0 136.0 11:06:22 INFO - PROCESS | 1674 | 11:06:22 INFO - PROCESS | 1674 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.80 Median:75.50 stddev:12.69 (16.8%) stddev-sans-first:13.06 11:06:22 INFO - PROCESS | 1674 | Values: 67.0 69.0 91.0 93.0 94.0 82.0 67.0 65.0 64.0 66.0 11:06:22 INFO - PROCESS | 1674 | -------- Summary: end -------- 11:06:22 INFO - PROCESS | 1674 | 11:06:23 INFO - TEST-INFO | 1674: exit 0 11:06:23 INFO - TEST-OK | kraken | took 55905ms 11:06:23 INFO - SUITE-END | took 1167s 11:06:23 INFO - Completed test suite (00:19:27) 11:06:23 INFO - javascript benchmark 11:06:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3508.736844736645, 3566.090646885042, 3567.32220878033, 3589.5692516897966, 3637.3816451203293, 5743.942560574393, 5785.27684039495, 5785.710714464276, 5796.681182534959, 5820.505257053151, 5762.481376676098, 5826.038703613898, 5831.562632802546, 5840.883182336351, 5847.006008978473, 5219.947800521984, 5237.083510385677, 5267.947320526784, 5294.629375943686, 5315.202719592054, 5343.118385466413, 5344.518993290603, 5345.4387289334645, 5349.277847490597, 5361.490658387447, 5326.946730532683, 5358.410574836765, 5378.220158077076, 5381.650192737479, 5383.0, 5362.8123015694455, 5375.865603359908, 5416.51251387377, 5417.729113544347, 5480.26016487773, 5146.330976973007, 5305.920411193835, 5316.175992721096, 5347.224652425377, 5349.358077030743, 5665.036943719578, 5715.942840571583, 5722.2561067061015, 5744.597878148531, 5749.59752817303, 6218.906716399258, 6348.079528468393, 6351.269603995507, 6361.141245931786, 6378.394052565045, 5318.574514038867, 5944.7027648617395, 6003.129546215774, 6294.402031806971, 6366.840828979266, 5964.105384192362, 5978.940210597882, 5983.0, 5996.820095397145, 6001.159837622737, 6300.684965751786, 6311.779087731908, 6413.775517856852, 6415.775447859302, 6435.613863168225, 6283.96858015707, 6284.308726040132, 6306.842328941813, 6326.715297811517, 6340.587861788969, 6318.778842740482, 6342.904856427157, 6349.873002539924, 6352.936470635234, 6371.713272902731, 5878.177055212188, 6172.629642221481, 6203.131561581382, 6327.11420401135, 6366.236051673829, 6332.873342533216, 6364.045393190966, 6368.235811702625, 6377.840553986188, 6383.042543618401, 4952.628552858478, 4960.404751429852, 4982.128127577659, 4986.650934434555, 4989.176785830297, 4400.207962566705, 4522.4346956630425, 4530.637548996073, 4538.9546104539195, 4543.659225558096, 5890.852728681817, 5919.6152250103605, 5928.584999050111, 5930.7924222652, 5945.583809133319, 6247.625142491374, 6320.968395157995, 6342.841428964312, 6352.205974253218, 6357.11000459936, 5969.940300597025, 5991.490723288569, 5994.970025149846, 6002.939970600325, 6011.579189456696, 5459.071957767189, 5468.0, 5469.179623056573, 5471.316085489314, 5478.287822583039, 6291.1192433059405, 6416.935830641727, 6450.935490645127, 6467.223933128054, 6468.773592924225, 6317.273513546001, 6320.020396838498, 6340.365963403808, 6357.554971151975, 6364.363563643598, 6507.251666058464, 6508.902366464602, 6512.218533775977, 6512.739490420519, 6518.902216466662, 6138.694953005908, 6232.937670623236, 6239.75040998355, 6349.14286571307, 6349.68251587428, 6316.873662526816, 6329.651869147241, 6332.208473940757, 6341.809745707452, 6370.55406121567, 6265.028920517327, 6272.933601287701, 6282.937170628235, 6286.15136956505, 6293.056041593798, 6100.420460056288, 6140.41222487552, 6190.1952746142715, 6243.750249989949, 6257.2491301044165, 6042.939570604238, 6063.787767428119, 6084.878302433838, 6086.1175129606845, 6090.330063692902, 6081.361457047124, 6090.512758979359, 6162.322144564184, 6165.599236049642, 6210.441060304594, 6102.572819902564, 6166.691665416622, 6184.350643182401, 6189.81430557084, 6201.317855036033], "unit": "score", "name": "dojo.html", "value": 5821.296770507507}, {"lowerIsBetter": false, "replicates": [473.39878354489775, 571.5684658083146, 597.1252115650572, 622.5984240165092, 651.4397618048479, 31967.84016079919, 33392.49911251333, 41013.0, 41215.79392103035, 41252.17495650085, 43662.0, 44292.0, 44340.55659443405, 44353.55646443534, 44402.77798611002, 8576.228139467446, 9850.162736167416, 10082.546285417136, 10083.19334453242, 10086.0, 9713.125818676317, 9851.655192068243, 9852.50737463124, 9857.852132218022, 9875.160611348045, 9828.655997040105, 9975.800483990315, 9992.200623950102, 9998.800023999516, 10009.549570269355, 9913.801723965516, 9952.203823694088, 9954.402735835873, 9979.550920208609, 9989.350692204984, 9816.950915245377, 9855.852162217572, 9956.950215248877, 9958.352707074017, 9961.252906032005, 43217.35173972393, 43675.34486982698, 43762.12475750499, 43848.56151438509, 43871.683849484565, 3317.2204531934976, 3448.775829571095, 3561.893143205708, 3832.9041773955596, 4063.9593604063875, 27875.581866272023, 29124.708752912622, 29145.854270728723, 29378.55932161019, 29455.0, 2814.8311101333984, 2824.7034061423665, 2866.226118947893, 2897.9710202897913, 2899.405621847516, 467267.6636616829, 468976.0, 472868.0, 473120.0, 473592.0, 48429.75785121052, 49016.0, 49126.75436622794, 73672.63163684147, 74260.0, 49823.75088124536, 49877.0, 50020.249696254585, 50081.0, 50084.0, 15253.466128685443, 17530.824691752918, 18110.5472363192, 18297.176627051813, 18321.63356732858, 14652.487162949246, 14750.262486875614, 14750.704985900222, 14757.852421475647, 14758.778618320519, 15776.842231577766, 15777.0, 15777.633354996613, 15785.921070394805, 15824.68350632981, 6664.600123992576, 6764.526483146133, 6817.829554261084, 6818.2159051708695, 6819.897701534481, 906.465185540521, 1047.61238341814, 1190.2441949362217, 1193.91045671575, 1208.709909621702, 31251.37497250088, 31358.37283254368, 31506.048477762488, 31549.52675709866, 31714.207144821103, 1176.8411264479187, 1182.9704257393462, 1249.28790589365, 1253.9059570532247, 1263.646179069862, 14169.079009864532, 15484.993475424062, 15722.764158537631, 16065.598360041093, 16119.919400402923, 492506.0, 498255.0, 498476.50761746685, 498948.5052574714, 500114.0, 51951.48048519466, 52466.21300680493, 61794.0, 63840.36159638437, 63969.36030639727, 1452.469848505288, 1489.113977183574, 1501.8347981722002, 1554.3627112883664, 1598.8401159884152, 29931.401371972002, 30138.9451369201, 30920.226994325323, 32287.0, 33334.499982499794, 46740.0, 57619.84760304854, 58352.70823646025, 58443.415565843796, 58444.415555843894, 476360.47279054916, 479689.0, 481187.0, 481206.0, 482043.0, 38562.421563677126, 47027.0, 47954.76022619865, 48171.27743083927, 49116.77208069827, 45829.54170458253, 45952.77023614861, 46028.7698561505, 47668.0, 47694.28458573193, 37895.81052094722, 38316.0, 39349.40975885421, 39630.603693962694, 40655.7967210162, 33484.330313394086, 37932.0, 38701.80649096736, 38944.61055389523, 39612.0, 39296.01759956024, 40701.0, 41087.38368924409, 42176.0, 42255.366169508095, 31837.522437163, 33802.830985844914, 33817.81637642671, 33843.830780845936, 34116.0, 26193.869030655485, 26203.29678570887, 26240.8687956559, 26422.603660945486, 26614.600780987912], "unit": "score", "name": "ext.html", "value": 20370.5626177748}, {"lowerIsBetter": false, "replicates": [377.9508663873696, 380.2584959329308, 385.7589006870706, 389.91811719538896, 390.625, 19851.50371240718, 21028.264010759627, 21777.0, 22487.437814054658, 22528.0, 21440.571188576258, 21909.794961277123, 22175.334739957827, 22228.555428891414, 22305.776942230572, 5904.970475147618, 5908.1728558001805, 6147.969260153693, 6178.443940045395, 6196.78311259106, 6008.639481631094, 6104.236970378703, 6130.141780150782, 6130.203073600448, 6137.232845894263, 5907.616004959686, 6010.36891126432, 6076.361981991893, 6079.969600151993, 6094.207752992127, 5847.678377689225, 5971.313298970631, 5989.940100599004, 6029.668368239745, 6032.849178770522, 5095.159298715707, 5227.45111763267, 5251.894962100737, 5258.211268309784, 5267.473252674702, 20234.494137646678, 25968.480630387287, 26056.8697156513, 26200.737992620212, 26358.604620930702, 2323.3610757041947, 2594.818362714611, 2681.9195424137306, 2871.899483518088, 3021.214484234115, 14653.926730366387, 14957.700845983129, 15000.099994000286, 15139.167345795977, 15438.305276262596, 1751.9211635476433, 1854.1378259109579, 1856.5544269375387, 1901.4390754727388, 1901.982389787263, 98629.50685246527, 100139.99999999927, 102108.48945755298, 103138.48430757874, 104909.0, 10712.517936692868, 10729.570817167381, 10813.21581938987, 11021.173411994132, 11344.319340839576, 12752.17110887808, 12781.233126012283, 12969.286689231994, 13071.346432678329, 13206.27365494907, 8807.867881981776, 8991.28069754418, 8993.23557497607, 8997.505137217517, 9088.681896133736, 9274.44353338802, 9406.952965235267, 9433.716988490356, 9513.809723805485, 9556.426614403159, 5373.596980226499, 6322.146510221153, 6332.68336583169, 6341.302456729756, 6348.77779277723, 1858.8605854560963, 1859.4514618187668, 1864.2729335559143, 1864.7575815143944, 1872.9511473574569, 780.4575819805294, 872.8472517309445, 918.7565295196778, 980.2207245239908, 1062.2776511971933, 19315.90342048281, 20233.49416264576, 20891.477713057295, 20917.37247882566, 20979.0, 1080.4327727942737, 1080.6811990462832, 1100.6037826382496, 1140.1843281515703, 1145.6047663556226, 11486.310821350746, 11896.405179740977, 11923.926846583849, 11935.164538482222, 11936.52253909834, 635881.0, 647875.0, 658239.0, 658763.0, 659069.7046514737, 84144.0, 105003.42494862583, 107245.0, 108169.0, 108918.0, 1047.4972013433442, 1072.9088027517591, 1085.0614218700925, 1085.8371244313416, 1090.6019302954523, 17991.730124048412, 18056.187471564073, 18064.096795159927, 18089.63820723552, 18812.435626931216, 50891.49108508867, 51309.743451282506, 51354.0, 53017.7349113252, 56863.86272274449, 71510.28489715036, 77169.2283077162, 80648.59675701584, 81593.0, 82891.0, 8040.356771458152, 8255.628496717782, 8356.456830306011, 8470.449420787629, 8503.829923401621, 9669.806603868024, 13222.867771322548, 13376.732465350833, 13830.515931942333, 13988.440462381392, 11655.242409243372, 11762.529498819951, 12035.819462708241, 12071.155019148575, 12162.513499460276, 11640.243384180001, 11662.300261984308, 11770.17608767378, 11784.057275417774, 11975.041996640422, 9415.670451534163, 11436.398904153259, 12045.578404755792, 12144.33206173669, 12220.816687749513, 6971.825704357431, 8359.623816928131, 8385.0, 8426.95786521088, 8474.74575762728, 8606.526641034552, 11028.944855275993, 11842.0, 11872.584459543874, 12110.51557937708], "unit": "score", "name": "jquery.html", "value": 9901.656156457511}, {"lowerIsBetter": false, "replicates": [1506.3673257231962, 1661.6344404231068, 1692.1454665393974, 2031.2281333093422, 2106.2206983416127, 8421.621027053781, 8938.553072346382, 9180.678676246325, 9186.265098792097, 9188.81622367554, 8966.327525435601, 9273.933497647773, 9289.024652411485, 9292.628294868196, 9302.023287554794, 2576.987115064422, 2603.7005744339453, 2605.6873175219002, 2605.973940260592, 2606.335384476956, 2534.42975330551, 2586.6508021417058, 2587.042794166161, 2588.2623452316093, 2589.0, 2581.5224183526107, 2594.7924166066764, 2607.4785042991384, 2613.163787587973, 2616.0451435226196, 2584.5257629637827, 2594.2995391244353, 2602.0112357304292, 2607.9478410431684, 2608.1653870761365, 2578.12343803106, 2605.59613259945, 2614.7646711795837, 2623.0425894548353, 2625.3042943619957, 9152.359334846564, 9210.263178945735, 9232.030636783109, 9239.076092390775, 9249.982501924784, 5586.525145362649, 5776.768929242825, 5778.3643799182055, 5784.768609255625, 5788.565857560699, 3625.021244264034, 3673.3938900081453, 3787.6591106800242, 3790.639889210521, 3793.620637936212, 1032.5611615063567, 1056.1339701444817, 1060.48566445274, 1087.8150714378496, 1087.8422628718793, 12401.689957751038, 12434.62696119118, 12473.126881118325, 12475.875241247653, 12478.937605312007, 4933.975330123399, 4989.451160372356, 5042.4705405931845, 5080.415752188472, 5125.513076257749, 10476.214283928735, 10494.790104198026, 10513.947430262953, 10525.631602894015, 10531.104856087166, 5706.828795136153, 5712.143178523254, 5720.08478643415, 5743.310802703702, 5748.7125643717645, 4288.50682171548, 4713.670043097019, 4816.964352664194, 4819.397575303087, 4861.9027619447415, 3668.816559172031, 4040.91918161641, 4108.383742438598, 4110.301248787713, 4133.937990930139, 1347.5148946379295, 1356.0981947005132, 1365.481117175467, 1368.1585824717927, 1371.4171477122184, 1428.4214892968364, 1432.1120905038943, 1447.1317209674112, 1472.749632562467, 1475.859793319633, 8464.788380290542, 8502.872456913152, 8526.488410695378, 8535.615897284637, 8554.230119289294, 1259.9622011339675, 1271.0, 1280.5326055989497, 1288.2141893444991, 1299.6750812296925, 6384.808455746335, 6405.391487808651, 6458.2895881453005, 6474.838129046811, 6501.057346684799, 10952.726181845517, 11254.831177532344, 11290.040346570633, 11317.83023254652, 11437.542498300141, 10964.17768667353, 10972.177086718528, 11091.72270693239, 11164.553417863195, 11204.0, 8689.826203475895, 8705.608247628872, 8788.824223515494, 8791.428557143892, 8835.160659737314, 8072.959635201786, 8207.630656620586, 8267.62795674184, 8274.710385136492, 8275.379346549153, 9802.460864652512, 9972.750681233027, 10058.698239052841, 10133.695989120339, 10258.897411026093, 9828.508574571386, 10212.336198147394, 10447.425391603534, 10490.632827850988, 10633.680989570325, 7012.439004879496, 7103.431725462054, 7196.280371962762, 7521.7743467696055, 7786.26030527099, 7188.748393806191, 8555.786105347415, 8569.828603427772, 8570.914290857012, 8618.956905215684, 7462.813429664085, 7594.772156835304, 7623.428242881695, 7697.499662522142, 7709.306162445407, 7417.851642967218, 7473.962630186814, 7492.175860655215, 7569.772906812805, 7585.469017168745, 7987.720429784929, 8037.23646253605, 8056.83886322282, 8097.109317975136, 8146.877796832934, 7199.1001124859395, 7328.120625524971, 7329.377002954809, 7332.926670733438, 7397.667104980396, 7428.851422971402, 7440.181580026085, 7457.440691948234, 7489.363404110493, 7492.0], "unit": "score", "name": "mootools.html", "value": 5181.091707993821}, {"lowerIsBetter": false, "replicates": [337.4903895118371, 344.093314117301, 346.54775517949065, 347.322432650299, 350.9912252193695, 6484.610923344597, 6519.1199188109595, 6552.47580193584, 6564.146660934072, 6581.967090164542, 6459.160309159803, 6470.320616335288, 6476.1257230273895, 6478.578892371993, 6488.513361497895, 4698.624110071203, 4773.11697335994, 4792.353032340624, 4873.390826146731, 4924.359833221676, 4860.854174374756, 4883.487233840449, 4902.58328042115, 4912.950870491285, 4914.729689867056, 3887.319719049169, 4837.153498137812, 4842.709437433748, 4860.270959356108, 4867.951320486785, 4591.334256532801, 4686.226772582537, 4798.880027999293, 4818.807247710088, 4834.323194752737, 4157.230912281208, 4162.292410290228, 4166.312558427856, 4188.078622703, 4193.454850869368, 5109.41241757199, 5894.0, 6145.910390467217, 6146.969265153691, 6175.0, 5675.120356344773, 5685.8009969651275, 5691.7723291068305, 5693.516051135658, 5698.772049118031, 5958.672273024982, 6469.450096741735, 6866.622335771531, 6869.622170780605, 6879.484038697067, 4319.524852266248, 4486.327050942352, 4492.9775351123035, 4493.101379724036, 4507.873031742064, 5748.7987920423, 6610.570312929693, 7086.503944723871, 7217.314355136254, 7227.0, 4151.356539736345, 4618.099470603267, 4618.699784513996, 4620.930686039712, 4624.699394539344, 4682.953170468251, 4685.812567497262, 4689.109069276895, 4689.343491911135, 4698.412698412699, 4478.350639157304, 5486.753096110685, 5492.972535137299, 5493.7802487900835, 5501.724913754377, 6639.840994563387, 6828.897566536506, 6833.350831670983, 6869.313068693091, 6890.20762612306, 1605.4300723243314, 1618.8138364088045, 1638.8852780305504, 1639.7294446416447, 1640.2126979050122, 862.3618522293458, 976.7156189610781, 1015.1472762879217, 1034.384541197986, 1059.4173204737363, 5367.329083864517, 6531.967340163269, 6626.768063117768, 6658.6337751424135, 6663.167104111986, 7203.279672032755, 7218.963905180441, 7240.927590724131, 7245.0, 7250.347468727839, 6506.837329066717, 6530.595921876819, 6553.246376666649, 6562.442192413699, 6616.4045235929, 3767.9246415071543, 3808.333541630204, 3827.4067519534515, 3835.347990841564, 3839.117003089305, 6032.3967603239325, 7297.124345078624, 7542.868569714587, 7552.0, 7559.962200188964, 7321.853562928712, 7452.031235939293, 7471.925280747231, 7481.364084052808, 7485.513441626277, 7543.962280188564, 7574.3183113520045, 7578.204288549733, 7583.05211848519, 7586.696532138763, 6467.997460393646, 7224.74713385029, 7232.63836808147, 7239.819004524929, 7249.383802376646, 6137.631742095488, 7030.613316267654, 7054.753083642048, 7080.114985626797, 7093.574385536885, 7517.1731109579, 7524.021877155935, 7524.209957954336, 7524.2851929066655, 7546.471746977659, 4595.908081838412, 4640.535946405333, 4646.326282689059, 4649.070185962889, 4661.091087237956, 7119.323664252095, 7120.003199551963, 7120.1099862517185, 7132.607706576188, 7137.536060156073, 6757.493188011017, 6926.480513961373, 6987.441004719712, 6989.161300643752, 7017.7192912282935, 6260.154879091447, 6936.653167341512, 6938.202106757787, 6966.3730264276455, 6985.511014228955, 6789.15135608049, 6806.55757375769, 6828.931710682829, 6842.965785171043, 6843.178818541807, 5624.971875140762, 6659.633720145439, 6924.480663950123, 6955.721771129301, 6962.025316455599, 6594.670266486753, 6718.2609912908565, 6783.932160678528, 6792.66036698173, 6808.217055038734], "unit": "score", "name": "prototype.html", "value": 5054.425835423045}, {"lowerIsBetter": false, "replicates": [671.5494531811282, 686.8488932434863, 718.888572271298, 725.2819708488598, 807.160553024854, 15377.384904603816, 15777.21113944301, 15796.44712435065, 15822.0, 15823.20883955802, 14411.919106067035, 14469.855301447009, 14541.636459088502, 14541.636459088528, 14573.05275157114, 798.8881556582054, 808.2483290539795, 810.8540462716738, 812.8943237379133, 956.7129861041677, 963.9807203855919, 992.136840948376, 992.6525715999414, 994.8557459168417, 995.6166875752851, 1046.853440518328, 1051.295631926611, 1056.1867362131154, 1056.5456853552969, 1058.640062378791, 838.2581415447373, 1028.7993841200969, 1045.002023067972, 1048.355261514167, 1049.2969710294083, 782.4014628808966, 784.2980532423506, 785.4541093939714, 785.8939043229148, 786.1431040166246, 15463.5360939172, 15549.922250388676, 15557.611059723484, 15572.766408503881, 15609.297581608742, 12419.627411177678, 12845.100842940998, 12898.161619494704, 13053.934730326288, 13280.667983300398, 10162.339447935861, 10293.0, 10349.63776267827, 10452.843207351896, 11096.889031109666, 3530.064532898784, 3601.171730501973, 3618.113562177257, 3677.3013127505687, 3695.907602309937, 82382.58808705978, 85094.57452712697, 85165.0, 85183.0, 85254.72117918236, 9344.486053267136, 9539.236861051098, 9559.856602150834, 9736.172425343924, 9842.901570984342, 21783.455413614785, 22023.449413764785, 22086.226982055552, 22137.0, 23478.64782028271, 7740.187280335596, 7747.186545412763, 7877.881831772528, 8019.198080192051, 8034.638441270157, 4217.451731274976, 4261.552536983572, 4274.123804620045, 4300.892477688083, 4365.345198220229, 3606.6573675500786, 3628.727845411605, 3629.0, 3629.165291982859, 3647.5805282392867, 638.084348959245, 655.2562841175301, 659.8713250916026, 661.2990230355838, 675.6115233740619, 603.3604379357895, 606.5450911816138, 608.7534548507862, 610.1214251477858, 615.6490800243818, 8338.166183381612, 8398.83202335962, 8498.447600906045, 8629.0, 8952.731418057469, 593.6942474625571, 608.7808388979963, 616.5406771954832, 619.2445216835454, 630.6657471540091, 3910.550286717064, 3935.704822138351, 3952.2490726761825, 4037.313656678372, 4153.709240353207, 88898.22203555892, 90156.6476502853, 90384.09615903888, 90475.0, 90606.0, 80285.17576005988, 80489.0, 81288.0, 82079.58960205161, 82725.17274827295, 57701.845963081345, 67387.0, 73821.63089184627, 74102.88845667211, 75354.86967695488, 8582.959641255606, 8850.645974160961, 8867.822643546964, 8927.776805579913, 8937.553122343726, 51212.74393628008, 51659.22511162411, 51787.74106129596, 53069.469305308, 54580.72709636585, 63283.6835815818, 71624.64187679028, 74903.62548187442, 75034.6248268777, 75976.62011689907, 11078.723031924266, 11179.049780768726, 11231.989120979151, 11524.884751152382, 11646.883531164918, 12073.69815754578, 12106.939465302617, 12291.385430728607, 12445.439955202219, 12871.099023068295, 11531.019863311378, 11736.471858766205, 11756.654144352915, 11866.347350895438, 12053.75892482163, 9790.853137202805, 11893.821592675944, 11900.16698831108, 11927.0, 12254.264744115382, 11100.500477478694, 11630.302181869114, 11840.28958262507, 11877.643670689893, 11922.284662920252, 8535.658573656985, 9626.9037309626, 9828.606855725977, 9848.162906153057, 10111.696649100539, 9579.0, 9770.462624555717, 9776.85334719994, 9787.46168960714, 9845.803083938137], "unit": "score", "name": "yui.html", "value": 7152.811776580389}], "name": "dromaeo_css", "value": 7769.431233430915}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 110.0, 109.0, 109.0, 111.0, 111.0, 119.0, 111.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.2}, {"lowerIsBetter": true, "replicates": [151.0, 119.0, 155.0, 149.0, 116.0, 139.0, 119.0, 147.0, 150.0, 117.0], "unit": "score", "name": "audio-beat-detection", "value": 136.2}, {"lowerIsBetter": true, "replicates": [184.0, 186.0, 185.0, 182.0, 185.0, 183.0, 183.0, 183.0, 183.0, 184.0], "unit": "score", "name": "audio-dft", "value": 183.8}, {"lowerIsBetter": true, "replicates": [74.0, 75.0, 72.0, 115.0, 55.0, 57.0, 58.0, 59.0, 146.0, 47.0], "unit": "score", "name": "audio-fft", "value": 75.8}, {"lowerIsBetter": true, "replicates": [91.0, 92.0, 127.0, 80.0, 77.0, 86.0, 113.0, 76.0, 79.0, 108.0], "unit": "score", "name": "audio-oscillator", "value": 92.9}, {"lowerIsBetter": true, "replicates": [88.0, 87.0, 90.0, 86.0, 89.0, 85.0, 89.0, 86.0, 90.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 87.6}, {"lowerIsBetter": true, "replicates": [111.0, 149.0, 107.0, 93.0, 93.0, 94.0, 94.0, 94.0, 94.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 102.2}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 86.0, 84.0, 84.0, 86.0, 84.0, 83.0, 84.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 84.4}, {"lowerIsBetter": true, "replicates": [55.0, 58.0, 58.0, 58.0, 57.0, 59.0, 58.0, 58.0, 53.0, 51.0], "unit": "score", "name": "json-parse-financial", "value": 56.5}, {"lowerIsBetter": true, "replicates": [62.0, 60.0, 71.0, 74.0, 69.0, 66.0, 66.0, 67.0, 65.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.6}, {"lowerIsBetter": true, "replicates": [92.0, 103.0, 95.0, 80.0, 82.0, 79.0, 79.0, 77.0, 81.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.2}, {"lowerIsBetter": true, "replicates": [137.0, 125.0, 127.0, 123.0, 130.0, 117.0, 116.0, 126.0, 126.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.5}, {"lowerIsBetter": true, "replicates": [134.0, 124.0, 135.0, 135.0, 135.0, 126.0, 133.0, 134.0, 132.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 132.4}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 91.0, 93.0, 94.0, 82.0, 67.0, 65.0, 64.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 75.8}], "name": "kraken", "value": 1416.1000000000001}]} 11:06:23 INFO - Return code: 0 11:06:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:06:23 INFO - # TBPL SUCCESS # 11:06:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:06:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:06:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:06:23 INFO - 2016-04-27 11:06:23.672 screenresolution[1678:10127] starting screenresolution argv=screenresolution get 11:06:23 INFO - 2016-04-27 11:06:23.675 screenresolution[1678:10127] Display 0: 1600x1200x32@60 11:06:23 INFO - 2016-04-27 11:06:23.681 screenresolution[1679:10130] starting screenresolution argv=screenresolution list 11:06:23 INFO - Available Modes on Display 0 11:06:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:06:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:06:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:06:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:06:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:06:23 INFO - Intel Iris: 11:06:23 INFO - Chipset Model: Intel Iris 11:06:23 INFO - Type: GPU 11:06:23 INFO - Bus: Built-In 11:06:23 INFO - VRAM (Dynamic, Max): 1536 MB 11:06:23 INFO - Vendor: Intel (0x8086) 11:06:23 INFO - Device ID: 0x0a2e 11:06:23 INFO - Revision ID: 0x0009 11:06:23 INFO - Displays: 11:06:23 INFO - Display: 11:06:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:06:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:06:23 INFO - Display Serial Number: 1600x1200 60 11:06:23 INFO - Main Display: Yes 11:06:23 INFO - Mirror: Off 11:06:23 INFO - Online: Yes 11:06:23 INFO - Rotation: Supported 11:06:23 INFO - Return code: 0 11:06:23 INFO - Running post-action listener: _resource_record_post_action 11:06:23 INFO - Running post-run listener: _resource_record_post_run 11:06:24 INFO - Total resource usage - Wall time: 1192s; CPU: 52.0%; Read bytes: 38209024; Write bytes: 508576768; Read time: 395; Write time: 1902 11:06:24 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 195666432; Write bytes: 197359104; Read time: 17972; Write time: 489 11:06:24 INFO - run-tests - Wall time: 1170s; CPU: 52.0%; Read bytes: 37254656; Write bytes: 300301824; Read time: 380; Write time: 1379 11:06:24 INFO - Running post-run listener: _upload_blobber_files 11:06:24 INFO - Blob upload gear active. 11:06:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:06:24 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:06:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:06:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:06:25 INFO - (blobuploader) - INFO - Open directory for files ... 11:06:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:06:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:06:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:06:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:06:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:06:26 INFO - (blobuploader) - INFO - Done attempting. 11:06:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:06:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:06:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:06:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:06:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:06:27 INFO - (blobuploader) - INFO - Done attempting. 11:06:27 INFO - (blobuploader) - INFO - Iteration through files over. 11:06:27 INFO - Return code: 0 11:06:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:06:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:06:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dc667a2c6afe239f48d0b1d272c8b1a4bbca2902a162eb4f1dc7e78fe5937c15fed71d646f2e976407fc8f42c911b2fabfcec4c25a08377ff90304184ac36a75", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/544b0f562871e1f25aa919bc424b72925f050bd286712524d05273efdc51eea0f1a20a1afb14dac5a365d2857a0fcb1d576f64a5174c2be51f32fdfe2eb97afb"} 11:06:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:06:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:06:27 INFO - Contents: 11:06:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dc667a2c6afe239f48d0b1d272c8b1a4bbca2902a162eb4f1dc7e78fe5937c15fed71d646f2e976407fc8f42c911b2fabfcec4c25a08377ff90304184ac36a75", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/544b0f562871e1f25aa919bc424b72925f050bd286712524d05273efdc51eea0f1a20a1afb14dac5a365d2857a0fcb1d576f64a5174c2be51f32fdfe2eb97afb"} 11:06:27 INFO - Running post-run listener: copy_logs_to_upload_dir 11:06:27 INFO - Copying logs to upload dir... 11:06:27 INFO - mkdir: /builds/slave/test/build/upload/logs 11:06:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.129470 ========= master_lag: 83.11 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 12 secs) (at 2016-04-27 11:07:50.457207) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 39 secs) (at 2016-04-27 11:07:50.461758) ========= 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.IwxP2X65XC/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.xDoMx62y6g/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dc667a2c6afe239f48d0b1d272c8b1a4bbca2902a162eb4f1dc7e78fe5937c15fed71d646f2e976407fc8f42c911b2fabfcec4c25a08377ff90304184ac36a75", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/544b0f562871e1f25aa919bc424b72925f050bd286712524d05273efdc51eea0f1a20a1afb14dac5a365d2857a0fcb1d576f64a5174c2be51f32fdfe2eb97afb"} build_url:https://queue.taskcluster.net/v1/task/dmZXRcCGTMO-b2qIY_0bKw/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.012264 build_url: 'https://queue.taskcluster.net/v1/task/dmZXRcCGTMO-b2qIY_0bKw/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dc667a2c6afe239f48d0b1d272c8b1a4bbca2902a162eb4f1dc7e78fe5937c15fed71d646f2e976407fc8f42c911b2fabfcec4c25a08377ff90304184ac36a75", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/544b0f562871e1f25aa919bc424b72925f050bd286712524d05273efdc51eea0f1a20a1afb14dac5a365d2857a0fcb1d576f64a5174c2be51f32fdfe2eb97afb"}' ========= master_lag: 39.63 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 39 secs) (at 2016-04-27 11:08:30.100516) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 17 secs) (at 2016-04-27 11:08:30.100813) ========= 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.IwxP2X65XC/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.xDoMx62y6g/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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.005303 ========= master_lag: 17.39 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 17 secs) (at 2016-04-27 11:08:47.496424) ========= ========= Started reboot skipped (results: 3, elapsed: 1 secs) (at 2016-04-27 11:08:47.496697) ========= ========= Finished reboot skipped (results: 3, elapsed: 1 secs) (at 2016-04-27 11:08:49.301468) ========= ========= Total master_lag: 140.92 =========