builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0028 starttime: 1464717189.63 results: success (0) buildid: 20160531080244 builduid: 9e6fa5615c594d0084d665872c3723c9 revision: 6617e62776cdf01627f146087690cfc7c883508a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-31 10:53:09.628921) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-31 10:53:09.629302) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-31 10:53:09.629587) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-31 10:53:09.679214) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 10:53:09.679568) ========= 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.moExLqicrW/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.IEoC63XdkJ/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-05-31 10:53:09-- 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% 16.0M=0.001s 2016-05-31 10:53:10 (16.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.525017 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 10:53:10.234651) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 10:53:10.234955) ========= 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.moExLqicrW/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.IEoC63XdkJ/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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.027366 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 10:53:10.305051) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-31 10:53:10.305372) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6617e62776cdf01627f146087690cfc7c883508a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 6617e62776cdf01627f146087690cfc7c883508a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.moExLqicrW/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.IEoC63XdkJ/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-05-31 10:53:10,382 truncating revision to first 12 chars 2016-05-31 10:53:10,382 Setting DEBUG logging. 2016-05-31 10:53:10,383 attempt 1/10 2016-05-31 10:53:10,383 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6617e62776cd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-31 10:53:11,507 unpacking tar archive at: fx-team-6617e62776cd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.382449 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-31 10:53:11.718946) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-31 10:53:11.719306) ========= script_repo_revision: 6617e62776cdf01627f146087690cfc7c883508a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-31 10:53:11.719727) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-31 10:53:11.720029) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-31 10:53:11.739710) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 13 secs) (at 2016-05-31 10:53:11.740357) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.moExLqicrW/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.IEoC63XdkJ/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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:53:11 INFO - MultiFileLogger online at 20160531 10:53:11 in /builds/slave/test 10:53:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 10:53:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:53:11 INFO - {'append_to_log': False, 10:53:11 INFO - 'base_work_dir': '/builds/slave/test', 10:53:11 INFO - 'blob_upload_branch': 'Fx-Team', 10:53:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:53:11 INFO - 'branch': 'Fx-Team', 10:53:11 INFO - 'buildbot_json_path': 'buildprops.json', 10:53:11 INFO - 'config_files': ('talos/mac_config.py',), 10:53:11 INFO - 'default_actions': ('clobber', 10:53:11 INFO - 'read-buildbot-config', 10:53:11 INFO - 'download-and-extract', 10:53:11 INFO - 'populate-webroot', 10:53:11 INFO - 'create-virtualenv', 10:53:11 INFO - 'install', 10:53:11 INFO - 'run-tests'), 10:53:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:53:11 INFO - 'download_minidump_stackwalk': True, 10:53:11 INFO - 'download_symbols': 'ondemand', 10:53:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:53:11 INFO - 'tooltool.py': '/tools/tooltool.py', 10:53:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:53:11 INFO - '/tools/misc-python/virtualenv.py')}, 10:53:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:53:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:53:11 INFO - 'installer_path': 'installer.exe', 10:53:11 INFO - 'log_level': 'info', 10:53:11 INFO - 'log_name': 'talos', 10:53:11 INFO - 'log_to_console': True, 10:53:11 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:53:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:53:11 INFO - 'opt_config_files': (), 10:53:11 INFO - 'pip_index': False, 10:53:11 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:53:11 INFO - 'cmd': ('bash', 10:53:11 INFO - '-c', 10:53:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:53:11 INFO - 'enabled': True, 10:53:11 INFO - 'halt_on_failure': False, 10:53:11 INFO - 'name': 'check_screen_resolution'},), 10:53:11 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:53:11 INFO - 'cmd': ('bash', 10:53:11 INFO - '-c', 10:53:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:53:11 INFO - 'enabled': True, 10:53:11 INFO - 'halt_on_failure': False, 10:53:11 INFO - 'name': 'check_screen_resolution'},), 10:53:11 INFO - 'run_cmd_checks_enabled': True, 10:53:11 INFO - 'sps_profile': False, 10:53:11 INFO - 'sps_profile_interval': 0, 10:53:11 INFO - 'suite': 'dromaeojs-e10s', 10:53:11 INFO - 'system_bits': '32', 10:53:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:53:11 INFO - 'title': 't-yosemite-r7-0028', 10:53:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:53:11 INFO - 'use_talos_json': True, 10:53:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:53:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:53:11 INFO - 'work_dir': 'build'} 10:53:11 INFO - ##### 10:53:11 INFO - ##### Running clobber step. 10:53:11 INFO - ##### 10:53:11 INFO - Running pre-action listener: _resource_record_pre_action 10:53:11 INFO - Running main action method: clobber 10:53:11 INFO - rmtree: /builds/slave/test/build 10:53:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:53:13 INFO - Running post-action listener: _resource_record_post_action 10:53:13 INFO - ##### 10:53:13 INFO - ##### Finished clobber step (success) 10:53:13 INFO - ##### 10:53:13 INFO - ##### 10:53:13 INFO - ##### Running read-buildbot-config step. 10:53:13 INFO - ##### 10:53:13 INFO - Running pre-action listener: _resource_record_pre_action 10:53:13 INFO - Running main action method: read_buildbot_config 10:53:13 INFO - Using buildbot properties: 10:53:13 INFO - { 10:53:13 INFO - "project": "", 10:53:13 INFO - "product": "firefox", 10:53:13 INFO - "script_repo_revision": "production", 10:53:13 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 10:53:13 INFO - "repository": "", 10:53:13 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 10:53:13 INFO - "buildid": "20160531080244", 10:53:13 INFO - "pgo_build": "False", 10:53:13 INFO - "basedir": "/builds/slave/test", 10:53:13 INFO - "buildnumber": 16, 10:53:13 INFO - "slavename": "t-yosemite-r7-0028", 10:53:13 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 10:53:13 INFO - "platform": "yosemite_r7", 10:53:13 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 10:53:13 INFO - "branch": "fx-team", 10:53:13 INFO - "repo_path": "integration/fx-team", 10:53:13 INFO - "revision": "6617e62776cdf01627f146087690cfc7c883508a", 10:53:13 INFO - "stage_platform": "macosx64", 10:53:13 INFO - "builduid": "9e6fa5615c594d0084d665872c3723c9", 10:53:13 INFO - "slavebuilddir": "test" 10:53:13 INFO - } 10:53:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/BwEkG5PrRji6Z4ow8xcquQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 10:53:13 INFO - Running post-action listener: _resource_record_post_action 10:53:13 INFO - ##### 10:53:13 INFO - ##### Finished read-buildbot-config step (success) 10:53:13 INFO - ##### 10:53:13 INFO - ##### 10:53:13 INFO - ##### Running download-and-extract step. 10:53:13 INFO - ##### 10:53:13 INFO - Running pre-action listener: _resource_record_pre_action 10:53:13 INFO - Running main action method: download_and_extract 10:53:13 INFO - mkdir: /builds/slave/test/build/tests 10:53: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:53:13 INFO - https://queue.taskcluster.net/v1/task/BwEkG5PrRji6Z4ow8xcquQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 10:53:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwEkG5PrRji6Z4ow8xcquQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 10:53:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwEkG5PrRji6Z4ow8xcquQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 10:53:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwEkG5PrRji6Z4ow8xcquQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 10:53:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwEkG5PrRji6Z4ow8xcquQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 10:53:44 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwEkG5PrRji6Z4ow8xcquQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json: timed out 10:53:44 INFO - retry: attempt #1 caught exception: timed out 10:53:44 INFO - retry: Failed, sleeping 30 seconds before retrying 10:54:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwEkG5PrRji6Z4ow8xcquQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #2 10:54:20 INFO - Downloaded 1199 bytes. 10:54:20 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 10:54:20 INFO - Using the following test package requirements: 10:54:20 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 10:54:20 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 10:54:20 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 10:54:20 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 10:54:20 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 10:54:20 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 10:54:20 INFO - u'jsshell-mac.zip'], 10:54:20 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 10:54:20 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 10:54:20 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 10:54:20 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 10:54:20 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 10:54:20 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 10:54:20 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 10:54:20 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 10:54:20 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 10:54:20 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 10:54:20 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 10:54:20 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:54:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:20 INFO - https://queue.taskcluster.net/v1/task/BwEkG5PrRji6Z4ow8xcquQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:54:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwEkG5PrRji6Z4ow8xcquQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 10:54:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwEkG5PrRji6Z4ow8xcquQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 10:54:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwEkG5PrRji6Z4ow8xcquQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 10:54:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwEkG5PrRji6Z4ow8xcquQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:54:22 INFO - Downloaded 18687100 bytes. 10:54:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:54:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:54:25 INFO - Return code: 0 10:54:25 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:54:25 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:54:25 INFO - https://queue.taskcluster.net/v1/task/BwEkG5PrRji6Z4ow8xcquQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:54:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwEkG5PrRji6Z4ow8xcquQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 10:54:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwEkG5PrRji6Z4ow8xcquQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 10:54:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwEkG5PrRji6Z4ow8xcquQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 10:54:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwEkG5PrRji6Z4ow8xcquQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:54:27 INFO - Downloaded 18687100 bytes. 10:54:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:54:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:54:30 INFO - Return code: 0 10:54:30 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:54:30 INFO - https://queue.taskcluster.net/v1/task/BwEkG5PrRji6Z4ow8xcquQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:54:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwEkG5PrRji6Z4ow8xcquQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 10:54:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwEkG5PrRji6Z4ow8xcquQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 10:54:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwEkG5PrRji6Z4ow8xcquQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 10:54:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwEkG5PrRji6Z4ow8xcquQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:54:31 INFO - Downloaded 10834055 bytes. 10:54:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:54:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 10:54:32 INFO - Return code: 0 10:54:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:32 INFO - https://queue.taskcluster.net/v1/task/BwEkG5PrRji6Z4ow8xcquQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 10:54:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwEkG5PrRji6Z4ow8xcquQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 10:54:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwEkG5PrRji6Z4ow8xcquQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 10:54:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwEkG5PrRji6Z4ow8xcquQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 10:54:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BwEkG5PrRji6Z4ow8xcquQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 10:54:36 INFO - Downloaded 110987123 bytes. 10:54:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BwEkG5PrRji6Z4ow8xcquQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 10:54:36 INFO - mkdir: /builds/slave/test/properties 10:54:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:54:36 INFO - Writing to file /builds/slave/test/properties/build_url 10:54:36 INFO - Contents: 10:54:36 INFO - build_url:https://queue.taskcluster.net/v1/task/BwEkG5PrRji6Z4ow8xcquQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 10:54:37 INFO - Running post-action listener: _resource_record_post_action 10:54:37 INFO - Running post-action listener: set_extra_try_arguments 10:54:37 INFO - ##### 10:54:37 INFO - ##### Finished download-and-extract step (success) 10:54:37 INFO - ##### 10:54:37 INFO - ##### 10:54:37 INFO - ##### Running populate-webroot step. 10:54:37 INFO - ##### 10:54:37 INFO - Running pre-action listener: _resource_record_pre_action 10:54:37 INFO - Running main action method: populate_webroot 10:54:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:54:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:54:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:54:37 INFO - '--tppagecycles', 10:54:37 INFO - '7'], 10:54:37 INFO - 'tests': ['tsvgm']}}, 10:54:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:54:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:54:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:54:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:54:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:54:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:54:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:37 INFO - 'talos_options': ['--disable-e10s'], 10:54:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:54:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:54:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:37 INFO - 'talos_options': ['--disable-e10s'], 10:54:37 INFO - 'tests': ['damp', 'tps']}, 10:54:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:37 INFO - 'tests': ['damp', 'tps']}, 10:54:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:54:37 INFO - 'tests': ['dromaeo_dom']}, 10:54:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:54:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:54:37 INFO - 'tests': ['a11yr', 10:54:37 INFO - 'ts_paint', 10:54:37 INFO - 'tpaint', 10:54:37 INFO - 'sessionrestore', 10:54:37 INFO - 'sessionrestore_no_auto_restore', 10:54:37 INFO - 'tabpaint']}, 10:54:37 INFO - 'other-e10s': {'tests': ['a11yr', 10:54:37 INFO - 'ts_paint', 10:54:37 INFO - 'tpaint', 10:54:37 INFO - 'sessionrestore', 10:54:37 INFO - 'sessionrestore_no_auto_restore', 10:54:37 INFO - 'tabpaint']}, 10:54:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:54:37 INFO - 'ts_paint', 10:54:37 INFO - 'tpaint', 10:54:37 INFO - 'sessionrestore', 10:54:37 INFO - 'sessionrestore_no_auto_restore', 10:54:37 INFO - 'tabpaint']}, 10:54:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:54:37 INFO - 'ts_paint', 10:54:37 INFO - 'tpaint', 10:54:37 INFO - 'sessionrestore', 10:54:37 INFO - 'sessionrestore_no_auto_restore', 10:54:37 INFO - 'tabpaint']}, 10:54:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:54:37 INFO - 'tests': ['a11yr', 10:54:37 INFO - 'ts_paint', 10:54:37 INFO - 'tpaint', 10:54:37 INFO - 'sessionrestore', 10:54:37 INFO - 'sessionrestore_no_auto_restore', 10:54:37 INFO - 'tabpaint']}, 10:54:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:54:37 INFO - 'tests': ['a11yr', 10:54:37 INFO - 'ts_paint', 10:54:37 INFO - 'tpaint', 10:54:37 INFO - 'sessionrestore', 10:54:37 INFO - 'sessionrestore_no_auto_restore', 10:54:37 INFO - 'tabpaint']}, 10:54:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:54:37 INFO - 'tests': ['tsvgx', 10:54:37 INFO - 'tsvgr_opacity', 10:54:37 INFO - 'tart', 10:54:37 INFO - 'tscrollx', 10:54:37 INFO - 'cart']}, 10:54:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:54:37 INFO - 'tsvgr_opacity', 10:54:37 INFO - 'tart', 10:54:37 INFO - 'tscrollx', 10:54:37 INFO - 'cart']}, 10:54:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:37 INFO - 'talos_options': ['--disable-e10s'], 10:54:37 INFO - 'tests': ['tp5o']}, 10:54:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:37 INFO - 'tests': ['tp5o']}, 10:54:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:37 INFO - 'talos_options': ['--disable-e10s', 10:54:37 INFO - '--xperf_path', 10:54:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:54:37 INFO - 'tests': ['tp5n']}, 10:54:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:37 INFO - 'talos_options': ['--xperf_path', 10:54:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:54:37 INFO - 'tests': ['tp5n']}}, 10:54:37 INFO - 'talos.zip': {'path': '', 10:54:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:54:37 INFO - Running post-action listener: _resource_record_post_action 10:54:37 INFO - ##### 10:54:37 INFO - ##### Finished populate-webroot step (success) 10:54:37 INFO - ##### 10:54:37 INFO - ##### 10:54:37 INFO - ##### Running create-virtualenv step. 10:54:37 INFO - ##### 10:54:37 INFO - Running pre-action listener: _resource_record_pre_action 10:54:37 INFO - Running main action method: create_virtualenv 10:54:37 INFO - Creating virtualenv /builds/slave/test/build/venv 10:54:37 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:54:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:54:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:54:37 INFO - Using real prefix '/tools/python27' 10:54:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:54:38 INFO - Installing distribute.............................................................................................................................................................................................done. 10:54:41 INFO - Installing pip.................done. 10:54:41 INFO - Return code: 0 10:54:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:54: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:54:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54: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:54:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b835a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b83b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddb8c94000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6d9d30>, '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 0x10b4fddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6d0b20>, '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.moExLqicrW/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.IEoC63XdkJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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:54:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:54:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:54:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.moExLqicrW/Render', 10:54:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:41 INFO - 'HOME': '/Users/cltbld', 10:54:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:41 INFO - 'LOGNAME': 'cltbld', 10:54:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:41 INFO - 'MOZ_NO_REMOTE': '1', 10:54:41 INFO - 'NO_EM_RESTART': '1', 10:54:41 INFO - 'PAGER': '/bin/cat', 10:54:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:41 INFO - 'PWD': '/builds/slave/test', 10:54:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:41 INFO - 'SHELL': '/bin/bash', 10:54:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IEoC63XdkJ/Listeners', 10:54:41 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 10:54:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:41 INFO - 'USER': 'cltbld', 10:54:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:41 INFO - 'XPC_FLAGS': '0x0', 10:54:41 INFO - 'XPC_SERVICE_NAME': '0', 10:54:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:41 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:54:41 INFO - Cleaning up... 10:54:41 INFO - Return code: 0 10:54:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:54: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:54:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54: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:54:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b835a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b83b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddb8c94000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6d9d30>, '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 0x10b4fddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6d0b20>, '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.moExLqicrW/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.IEoC63XdkJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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:54:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:54:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:54:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.moExLqicrW/Render', 10:54:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:41 INFO - 'HOME': '/Users/cltbld', 10:54:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:41 INFO - 'LOGNAME': 'cltbld', 10:54:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:41 INFO - 'MOZ_NO_REMOTE': '1', 10:54:41 INFO - 'NO_EM_RESTART': '1', 10:54:41 INFO - 'PAGER': '/bin/cat', 10:54:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:41 INFO - 'PWD': '/builds/slave/test', 10:54:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:41 INFO - 'SHELL': '/bin/bash', 10:54:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IEoC63XdkJ/Listeners', 10:54:41 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 10:54:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:41 INFO - 'USER': 'cltbld', 10:54:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:41 INFO - 'XPC_FLAGS': '0x0', 10:54:41 INFO - 'XPC_SERVICE_NAME': '0', 10:54:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:41 INFO - Downloading/unpacking psutil>=3.1.1 10:54:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:54:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:54:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:54:44 INFO - Installing collected packages: psutil 10:54:44 INFO - Running setup.py install for psutil 10:54:44 INFO - building 'psutil._psutil_osx' extension 10:54:44 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:54:45 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:54:45 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:54:45 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:54:45 INFO - building 'psutil._psutil_posix' extension 10:54:45 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:54:45 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:54:45 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:54:45 INFO - ^ 10:54:45 INFO - 1 warning generated. 10:54:45 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:54:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:54:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:54:45 INFO - Successfully installed psutil 10:54:45 INFO - Cleaning up... 10:54:45 INFO - Return code: 0 10:54:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:54: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:54:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54: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:54:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:45 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b835a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b83b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddb8c94000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6d9d30>, '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 0x10b4fddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6d0b20>, '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.moExLqicrW/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.IEoC63XdkJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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:54:45 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.3'] in /builds/slave/test/build 10:54:45 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.3 10:54:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.moExLqicrW/Render', 10:54:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:45 INFO - 'HOME': '/Users/cltbld', 10:54:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:45 INFO - 'LOGNAME': 'cltbld', 10:54:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:45 INFO - 'MOZ_NO_REMOTE': '1', 10:54:45 INFO - 'NO_EM_RESTART': '1', 10:54:45 INFO - 'PAGER': '/bin/cat', 10:54:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:45 INFO - 'PWD': '/builds/slave/test', 10:54:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:45 INFO - 'SHELL': '/bin/bash', 10:54:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IEoC63XdkJ/Listeners', 10:54:45 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 10:54:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:45 INFO - 'USER': 'cltbld', 10:54:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:45 INFO - 'XPC_FLAGS': '0x0', 10:54:45 INFO - 'XPC_SERVICE_NAME': '0', 10:54:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:54:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:54:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:54:48 INFO - Installing collected packages: mozsystemmonitor 10:54:48 INFO - Running setup.py install for mozsystemmonitor 10:54:48 INFO - Successfully installed mozsystemmonitor 10:54:48 INFO - Cleaning up... 10:54:48 INFO - Return code: 0 10:54:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:54:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:48 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 0x10b835a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b83b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddb8c94000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6d9d30>, '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 0x10b4fddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6d0b20>, '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.moExLqicrW/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.IEoC63XdkJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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:54:48 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:54:48 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:54:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.moExLqicrW/Render', 10:54:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:48 INFO - 'HOME': '/Users/cltbld', 10:54:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:48 INFO - 'LOGNAME': 'cltbld', 10:54:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:48 INFO - 'MOZ_NO_REMOTE': '1', 10:54:48 INFO - 'NO_EM_RESTART': '1', 10:54:48 INFO - 'PAGER': '/bin/cat', 10:54:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:48 INFO - 'PWD': '/builds/slave/test', 10:54:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:48 INFO - 'SHELL': '/bin/bash', 10:54:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IEoC63XdkJ/Listeners', 10:54:48 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 10:54:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:48 INFO - 'USER': 'cltbld', 10:54:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:48 INFO - 'XPC_FLAGS': '0x0', 10:54:48 INFO - 'XPC_SERVICE_NAME': '0', 10:54:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:49 INFO - Downloading/unpacking blobuploader==1.2.4 10:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:51 INFO - Downloading blobuploader-1.2.4.tar.gz 10:54:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:54:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:54:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:52 INFO - Downloading docopt-0.6.1.tar.gz 10:54:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:54:52 INFO - Installing collected packages: blobuploader, requests, docopt 10:54:52 INFO - Running setup.py install for blobuploader 10:54:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:54:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:54:52 INFO - Running setup.py install for requests 10:54:53 INFO - Running setup.py install for docopt 10:54:53 INFO - Successfully installed blobuploader requests docopt 10:54:53 INFO - Cleaning up... 10:54:53 INFO - Return code: 0 10:54:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:54: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:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54: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:54:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:53 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 0x10b835a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b83b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddb8c94000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6d9d30>, '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 0x10b4fddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6d0b20>, '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.moExLqicrW/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.IEoC63XdkJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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:54:53 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:54:53 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:54:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.moExLqicrW/Render', 10:54:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:53 INFO - 'HOME': '/Users/cltbld', 10:54:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:53 INFO - 'LOGNAME': 'cltbld', 10:54:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:53 INFO - 'MOZ_NO_REMOTE': '1', 10:54:53 INFO - 'NO_EM_RESTART': '1', 10:54:53 INFO - 'PAGER': '/bin/cat', 10:54:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:53 INFO - 'PWD': '/builds/slave/test', 10:54:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:53 INFO - 'SHELL': '/bin/bash', 10:54:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IEoC63XdkJ/Listeners', 10:54:53 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 10:54:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:53 INFO - 'USER': 'cltbld', 10:54:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:53 INFO - 'XPC_FLAGS': '0x0', 10:54:53 INFO - 'XPC_SERVICE_NAME': '0', 10:54:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:54:53 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-SWsQs_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:54:54 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-fVTpZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:54:54 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-K1XfPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:54:54 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-wS20M_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:54:54 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-Y5t4A2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:54:54 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-fq9Zpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:54:54 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-nDm1Xw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:54:54 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-DQdJ19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:54:54 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-AeTiBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:54:54 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-IRSErQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:54:54 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-eqcLXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:54:55 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-IWMLwj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:54:55 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-j6OHoO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:54:55 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-rk02sQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:54:55 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-5vPY0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:54:55 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-hFGnaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:54:55 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-kE8Niw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:54:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:54:55 INFO - Running setup.py install for manifestparser 10:54:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:54:55 INFO - Running setup.py install for mozcrash 10:54:55 INFO - Running setup.py install for mozdebug 10:54:56 INFO - Running setup.py install for mozdevice 10:54:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:54:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:54:56 INFO - Running setup.py install for mozfile 10:54:56 INFO - Running setup.py install for mozhttpd 10:54:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:54:56 INFO - Running setup.py install for mozinfo 10:54:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:54:56 INFO - Running setup.py install for mozInstall 10:54:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:54:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:54:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:54:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:54:56 INFO - Running setup.py install for mozleak 10:54:56 INFO - Running setup.py install for mozlog 10:54:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:54:57 INFO - Running setup.py install for moznetwork 10:54:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:54:57 INFO - Running setup.py install for mozprocess 10:54:57 INFO - Running setup.py install for mozprofile 10:54:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:54:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:54:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:54:57 INFO - Running setup.py install for mozrunner 10:54:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:54:57 INFO - Running setup.py install for mozscreenshot 10:54:57 INFO - Running setup.py install for moztest 10:54:58 INFO - Running setup.py install for mozversion 10:54:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:54:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:54:58 INFO - Cleaning up... 10:54:58 INFO - Return code: 0 10:54:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:54:58 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:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:58 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:54:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:58 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 0x10b835a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b83b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddb8c94000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6d9d30>, '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 0x10b4fddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6d0b20>, '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.moExLqicrW/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.IEoC63XdkJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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:54:58 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:54:58 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:54:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.moExLqicrW/Render', 10:54:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:58 INFO - 'HOME': '/Users/cltbld', 10:54:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:58 INFO - 'LOGNAME': 'cltbld', 10:54:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:58 INFO - 'MOZ_NO_REMOTE': '1', 10:54:58 INFO - 'NO_EM_RESTART': '1', 10:54:58 INFO - 'PAGER': '/bin/cat', 10:54:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:58 INFO - 'PWD': '/builds/slave/test', 10:54:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:58 INFO - 'SHELL': '/bin/bash', 10:54:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IEoC63XdkJ/Listeners', 10:54:58 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 10:54:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:58 INFO - 'USER': 'cltbld', 10:54:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:58 INFO - 'XPC_FLAGS': '0x0', 10:54:58 INFO - 'XPC_SERVICE_NAME': '0', 10:54:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:54:58 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-lqaozB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:54:58 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:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:54:58 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-NP0moq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:54:58 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:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:54:58 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-YjdD5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:54:58 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:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:54:58 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-rGgxCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:54:58 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:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:54:58 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-lknGd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:54:58 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:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:54:58 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-g5TWQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:54:59 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:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:54:59 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-kn6Gxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:54:59 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:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:54:59 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-POw03k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:54:59 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:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:54:59 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-qy3GZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:54:59 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:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:54:59 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-F1aNh_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:54:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:54:59 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-Ooh3pi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:54:59 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:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:54:59 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-ytrQ7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:54:59 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:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:54:59 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-Ob46sf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:54:59 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:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:54:59 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-pL3nSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:54:59 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:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:54:59 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-pOmJ0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:55:00 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:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:55:00 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-DYrTtx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:55:00 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:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:55:00 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-pw4qQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:55:00 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:55:00 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:55:00 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:55:00 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:55:00 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:55:00 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:55:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:55:00 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:55:00 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:55:00 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:55:00 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:55:00 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:55:00 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:55:02 INFO - Downloading blessings-1.6.tar.gz 10:55:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:55:02 INFO - Installing collected packages: blessings 10:55:02 INFO - Running setup.py install for blessings 10:55:02 INFO - Successfully installed blessings 10:55:02 INFO - Cleaning up... 10:55:03 INFO - Return code: 0 10:55:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:55:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:55:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:55:03 INFO - Reading from file tmpfile_stdout 10:55:03 INFO - Current package versions: 10:55:03 INFO - blessings == 1.6 10:55:03 INFO - blobuploader == 1.2.4 10:55:03 INFO - docopt == 0.6.1 10:55:03 INFO - manifestparser == 1.1 10:55:03 INFO - mozInstall == 1.12 10:55:03 INFO - mozcrash == 0.17 10:55:03 INFO - mozdebug == 0.1 10:55:03 INFO - mozdevice == 0.48 10:55:03 INFO - mozfile == 1.2 10:55:03 INFO - mozhttpd == 0.7 10:55:03 INFO - mozinfo == 0.9 10:55:03 INFO - mozleak == 0.1 10:55:03 INFO - mozlog == 3.2 10:55:03 INFO - moznetwork == 0.27 10:55:03 INFO - mozprocess == 0.22 10:55:03 INFO - mozprofile == 0.28 10:55:03 INFO - mozrunner == 6.11 10:55:03 INFO - mozscreenshot == 0.1 10:55:03 INFO - mozsystemmonitor == 0.3 10:55:03 INFO - moztest == 0.7 10:55:03 INFO - mozversion == 1.4 10:55:03 INFO - psutil == 3.1.1 10:55:03 INFO - requests == 1.2.3 10:55:03 INFO - wsgiref == 0.1.2 10:55:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:55:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:03 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 0x10b835a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b83b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddb8c94000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6d9d30>, '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 0x10b4fddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6d0b20>, '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.moExLqicrW/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.IEoC63XdkJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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:55:03 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:55:03 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:55:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.moExLqicrW/Render', 10:55:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:55:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:55:03 INFO - 'HOME': '/Users/cltbld', 10:55:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:55:03 INFO - 'LOGNAME': 'cltbld', 10:55:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:03 INFO - 'MOZ_NO_REMOTE': '1', 10:55:03 INFO - 'NO_EM_RESTART': '1', 10:55:03 INFO - 'PAGER': '/bin/cat', 10:55:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:55:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:55:03 INFO - 'PWD': '/builds/slave/test', 10:55:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:55:03 INFO - 'SHELL': '/bin/bash', 10:55:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IEoC63XdkJ/Listeners', 10:55:03 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 10:55:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:55:03 INFO - 'USER': 'cltbld', 10:55:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:55:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:55:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:03 INFO - 'XPC_FLAGS': '0x0', 10:55:03 INFO - 'XPC_SERVICE_NAME': '0', 10:55:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:55:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:03 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:55:03 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:55:03 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:55:03 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:55:03 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:55:03 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:55:03 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:55:03 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:55:03 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:55:03 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:55:03 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:55:03 INFO - Cleaning up... 10:55:03 INFO - Return code: 0 10:55:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:55:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:03 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 0x10b835a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b83b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddb8c94000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6d9d30>, '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 0x10b4fddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6d0b20>, '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.moExLqicrW/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.IEoC63XdkJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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:55:03 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:55:03 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:55:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.moExLqicrW/Render', 10:55:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:55:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:55:03 INFO - 'HOME': '/Users/cltbld', 10:55:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:55:03 INFO - 'LOGNAME': 'cltbld', 10:55:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:03 INFO - 'MOZ_NO_REMOTE': '1', 10:55:03 INFO - 'NO_EM_RESTART': '1', 10:55:03 INFO - 'PAGER': '/bin/cat', 10:55:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:55:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:55:03 INFO - 'PWD': '/builds/slave/test', 10:55:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:55:03 INFO - 'SHELL': '/bin/bash', 10:55:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IEoC63XdkJ/Listeners', 10:55:03 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 10:55:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:55:03 INFO - 'USER': 'cltbld', 10:55:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:55:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:55:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:03 INFO - 'XPC_FLAGS': '0x0', 10:55:03 INFO - 'XPC_SERVICE_NAME': '0', 10:55:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:55:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:03 INFO - Downloading/unpacking jsonschema 10:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:55:06 INFO - Downloading/unpacking functools32 (from jsonschema) 10:55:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:06 INFO - Downloading functools32-3.2.3-2.tar.gz 10:55:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:55:06 INFO - warning: no files found matching '*.txt' 10:55:06 INFO - no previously-included directories found matching 'build' 10:55:06 INFO - no previously-included directories found matching 'dist' 10:55:06 INFO - no previously-included directories found matching '.git*' 10:55:06 INFO - Installing collected packages: jsonschema, functools32 10:55:06 INFO - Running setup.py install for functools32 10:55:06 INFO - warning: no files found matching '*.txt' 10:55:06 INFO - no previously-included directories found matching 'build' 10:55:06 INFO - no previously-included directories found matching 'dist' 10:55:06 INFO - no previously-included directories found matching '.git*' 10:55:06 INFO - Successfully installed jsonschema functools32 10:55:06 INFO - Cleaning up... 10:55:07 INFO - Return code: 0 10:55:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:55:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:07 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 0x10b835a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b83b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddb8c94000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6d9d30>, '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 0x10b4fddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6d0b20>, '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.moExLqicrW/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.IEoC63XdkJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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:55:07 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:55:07 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:55:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.moExLqicrW/Render', 10:55:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:55:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:55:07 INFO - 'HOME': '/Users/cltbld', 10:55:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:55:07 INFO - 'LOGNAME': 'cltbld', 10:55:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:07 INFO - 'MOZ_NO_REMOTE': '1', 10:55:07 INFO - 'NO_EM_RESTART': '1', 10:55:07 INFO - 'PAGER': '/bin/cat', 10:55:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:55:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:55:07 INFO - 'PWD': '/builds/slave/test', 10:55:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:55:07 INFO - 'SHELL': '/bin/bash', 10:55:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IEoC63XdkJ/Listeners', 10:55:07 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 10:55:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:55:07 INFO - 'USER': 'cltbld', 10:55:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:55:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:55:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:07 INFO - 'XPC_FLAGS': '0x0', 10:55:07 INFO - 'XPC_SERVICE_NAME': '0', 10:55:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:55:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:07 INFO - Downloading/unpacking flake8 10:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:55:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:55:09 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:55:09 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:55:09 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:55:09 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:55:09 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:55:09 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:55:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:55:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:55:10 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:55:10 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:55:10 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:55:10 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:55:10 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:55:10 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:55:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:55:10 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:55:10 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:55:10 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:55:10 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:55:10 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:55:10 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:55:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:55:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:55:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:55:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:55:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:55:11 INFO - no previously-included directories found matching 'docs/_build' 10:55:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:55:11 INFO - Running setup.py install for pep8 10:55:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:55:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:55:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:55:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:55:11 INFO - no previously-included directories found matching 'docs/_build' 10:55:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:55:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:55:11 INFO - Cleaning up... 10:55:11 INFO - Return code: 0 10:55:11 INFO - Running post-action listener: _resource_record_post_action 10:55:11 INFO - Running post-action listener: _start_resource_monitoring 10:55:11 INFO - Starting resource monitoring. 10:55:11 INFO - ##### 10:55:11 INFO - ##### Finished create-virtualenv step (success) 10:55:11 INFO - ##### 10:55:11 INFO - ##### 10:55:11 INFO - ##### Running install step. 10:55:11 INFO - ##### 10:55:11 INFO - Running pre-action listener: _resource_record_pre_action 10:55:11 INFO - Running main action method: install 10:55:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:55:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:55:11 INFO - Reading from file tmpfile_stdout 10:55:11 INFO - Detecting whether we're running mozinstall >=1.0... 10:55:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:55:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:55:11 INFO - Reading from file tmpfile_stdout 10:55:11 INFO - Output received: 10:55:11 INFO - Usage: mozinstall [options] installer 10:55:11 INFO - Options: 10:55:11 INFO - -h, --help show this help message and exit 10:55:11 INFO - -d DEST, --destination=DEST 10:55:11 INFO - Directory to install application into. [default: 10:55:11 INFO - "/builds/slave/test"] 10:55:11 INFO - --app=APP Application being installed. [default: firefox] 10:55:11 INFO - mkdir: /builds/slave/test/build/application 10:55:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:55:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:55:45 INFO - Reading from file tmpfile_stdout 10:55:45 INFO - Output received: 10:55:45 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:55:45 INFO - Running post-action listener: _resource_record_post_action 10:55:45 INFO - ##### 10:55:45 INFO - ##### Finished install step (success) 10:55:45 INFO - ##### 10:55:45 INFO - ##### 10:55:45 INFO - ##### Running run-tests step. 10:55:45 INFO - ##### 10:55:45 INFO - Running pre-action listener: _resource_record_pre_action 10:55:45 INFO - Running main action method: run_tests 10:55:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:55:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:55:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:55:45 INFO - 2016-05-31 10:55:45.265 screenresolution[1644:8247] starting screenresolution argv=screenresolution get 10:55:45 INFO - 2016-05-31 10:55:45.267 screenresolution[1644:8247] Display 0: 1600x1200x32@60 10:55:45 INFO - 2016-05-31 10:55:45.273 screenresolution[1645:8249] starting screenresolution argv=screenresolution list 10:55:45 INFO - Available Modes on Display 0 10:55:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:55:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:55:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:55:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:55:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:55:45 INFO - Intel Iris: 10:55:45 INFO - Chipset Model: Intel Iris 10:55:45 INFO - Type: GPU 10:55:45 INFO - Bus: Built-In 10:55:45 INFO - VRAM (Dynamic, Max): 1536 MB 10:55:45 INFO - Vendor: Intel (0x8086) 10:55:45 INFO - Device ID: 0x0a2e 10:55:45 INFO - Revision ID: 0x0009 10:55:45 INFO - Displays: 10:55:45 INFO - Display: 10:55:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:55:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:55:45 INFO - Display Serial Number: 1600x1200 60 10:55:45 INFO - Main Display: Yes 10:55:45 INFO - Mirror: Off 10:55:45 INFO - Online: Yes 10:55:45 INFO - Rotation: Supported 10:55:45 INFO - Return code: 0 10:55:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:55:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:55:45 INFO - Python 2.7.3 10:55:45 INFO - Return code: 0 10:55:45 INFO - grabbing minidump binary from tooltool 10:55: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:55:45 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6d9d30>, '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 0x10b4fddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6d0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:55:45 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:55:45 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:55:45 INFO - Calling ['/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'] with output_timeout 600 10:55:45 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:55:45 INFO - Return code: 0 10:55:45 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:55:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:55:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:55:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:55:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:55:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:55:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:55:46 INFO - Return code: 0 10:55:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BwEkG5PrRji6Z4ow8xcquQ/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:55:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BwEkG5PrRji6Z4ow8xcquQ/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0028 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:55:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.moExLqicrW/Render', 10:55:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:55:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:55:46 INFO - 'HOME': '/Users/cltbld', 10:55:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:55:46 INFO - 'LOGNAME': 'cltbld', 10:55:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:55:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:55:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:46 INFO - 'MOZ_NO_REMOTE': '1', 10:55:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:55:46 INFO - 'NO_EM_RESTART': '1', 10:55:46 INFO - 'PAGER': '/bin/cat', 10:55:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:55:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:55:46 INFO - 'PWD': '/builds/slave/test', 10:55:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:55:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:55:46 INFO - 'SHELL': '/bin/bash', 10:55:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IEoC63XdkJ/Listeners', 10:55:46 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 10:55:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:55:46 INFO - 'USER': 'cltbld', 10:55:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:55:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:55:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:46 INFO - 'XPC_FLAGS': '0x0', 10:55:46 INFO - 'XPC_SERVICE_NAME': '0', 10:55:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:55:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BwEkG5PrRji6Z4ow8xcquQ/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:55:46 INFO - mozversion application_buildid: 20160531080244 10:55:46 INFO - mozversion application_changeset: 6617e62776cdf01627f146087690cfc7c883508a 10:55:46 INFO - mozversion application_display_name: Nightly 10:55:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:55:46 INFO - mozversion application_name: Firefox 10:55:46 INFO - mozversion application_remotingname: firefox 10:55:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:55:46 INFO - mozversion application_vendor: Mozilla 10:55:46 INFO - mozversion application_version: 49.0a1 10:55:46 INFO - mozversion platform_buildid: 20160531080244 10:55:46 INFO - mozversion platform_changeset: 6617e62776cdf01627f146087690cfc7c883508a 10:55:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:55:46 INFO - mozversion platform_version: 49.0a1 10:55:46 INFO - using testdate: 1464717346 10:55:46 INFO - actual date: 1464717346 10:55:46 INFO - starting webserver on 'localhost:49279' 10:55:46 INFO - SUITE-START | Running 2 tests 10:55:46 INFO - TEST-START | dromaeo_css 10:55:46 INFO - operating with platform_type : mac_ 10:55:46 INFO - Initialising browser for dromaeo_css test... 10:55:46 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmpDRtur6/profile http://localhost:49279/getInfo.html) 10:55:50 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 10:55:50 INFO - PROCESS | 1663 | colorDepth:24 10:55:50 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 10:55:50 INFO - PROCESS | 1663 | __metrics 10:55:50 ERROR - PROCESS | 1663 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 10:55:50 INFO - TEST-INFO | 1663: exit 0 10:55:50 INFO - Browser initialized. 10:55:50 INFO - Running cycle 1/1 for dromaeo_css test... 10:55:50 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmpDRtur6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:56:02 INFO - PROCESS | 1667 | RSS: Main: 252305408 10:56:02 INFO - PROCESS | 1667 | 10:56:52 INFO - PROCESS | 1667 | 1464717412441 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:59:03 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 10:59:04 INFO - PROCESS | 1667 | RSS: Main: 264708096 10:59:04 INFO - PROCESS | 1667 | 11:02:06 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 11:02:07 INFO - PROCESS | 1667 | RSS: Main: 276172800 11:02:07 INFO - PROCESS | 1667 | 11:05:09 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 11:05:09 INFO - PROCESS | 1667 | RSS: Main: 278351872 11:05:09 INFO - PROCESS | 1667 | 11:08:11 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 11:08:12 INFO - PROCESS | 1667 | RSS: Main: 279691264 11:08:12 INFO - PROCESS | 1667 | 11:11:14 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 11:11:15 INFO - PROCESS | 1667 | RSS: Main: 283516928 11:11:15 INFO - PROCESS | 1667 | 11:14:18 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 11:14:18 INFO - PROCESS | 1667 | RSS: Main: 283734016 11:14:18 INFO - PROCESS | 1667 | 11:14:18 INFO - PROCESS | 1667 | __start_tp_report 11:14:18 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 11:14:18 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 11:14:18 INFO - PROCESS | 1667 | |i|pagename|runs| 11:14:18 INFO - PROCESS | 1667 | |0;dojo.html;3461.238527523944;3482.7736197147187;3493.668101530355;3505.7020153286953;3508.263264714409;5695.544356451484;5703.401142879995;5742.138679198112;5798.681072541009;5871.29544454666;5390.5418039466695;5637.9718101409435;5728.283964504437;5797.362290148091;5861.325947516037;5110.412302585194;5154.226865970116;5224.660397074178;5233.712145831978;5254.605904557155;783.6715019744887;5132.615053870956;5171.37943446785;5194.662346947436;5212.895742085156;5190.403103643072;5201.843944681627;5217.765200565984;5229.320188375525;5235.110031294651;4265.488141423018;5211.765470553834;5240.109181439165;5258.868528286824;5273.288106105665;4300.8709738707885;4820.650217938983;5123.641345105844;5155.66488178271;5198.480151984809;4083.1425400665894;4678.415198100238;5412.15986564566;5438.238646589481;5564.638298510625;5358.33020872391;6060.151578778975;6093.6039157454625;6106;6228.5017198624;5148.3564554430695;6249.343818899041;6280.811575652692;6292;6303.968480157616;5848.532117430638;5946.405359464019;5950.672713000827;5957.281977682545;6002.39976002405;5497.670139791625;6008.489278411296;6222.937770622327;6246.625202487774;6317.368263173646;6102.368068311519;6195;6196.008638617799;6205.689715514206;6215.223097112861;6302.243730752339;6315.463185629181;6316.589421687576;6322.841928951721;6335.176427064544;6125.173101631222;6142.959235178615;6167.537434692416;6259.906101408483;6298.874022519615;6250.687465626791;6299.590526615755;6318.336574659686;6321.273053598803;6324;4879.487653796371;4925.039617274669;4931.988942266827;4936.358273424432;4939.185034469344;4345.934810977775;4353.6299414549485;4372.540883207217;4411.1618792429335;4455.888602784957;5649.54803615718;5711.171880077365;5730.398308177665;5766.394528574523;5768.74040668171;6307.24313082433;6325;6332.208473940757;6336.303006669263;6345.111684364193;5521.309836270466;5697.601167918206;5717.656940583495;5733.512651424676;5762.2509073820975;5413.810516631977;5416.268803711528;5416.404195538487;5423.593230507728;5425.02349577072;6345.270293916166;6372.904406433907;6377.904331435032;6379.936200638027;6391.872162556816;6154.076888466766;6215.782447614311;6246.063090536456;6276.780312689034;6288.717007734755;6382.3617638237665;6393.520485963664;6394.360563943568;6418.390252925965;6505.804825855232;6242.063690446469;6247.187865577446;6264.123022776724;6274.027525733519;6278.215223097113;6127.617148554337;6145.1564530639735;6187.752489900354;6195.101710251898;6285.748570057147;6172.166757487682;6187.412195841388;6190.442860142609;6191.226096737908;6205.22434695663;6020.397960203944;6155.4767844731905;6185.041318595625;6188.257409110935;6195.287541932736;5853.770708151336;5860.531157507304;5967.76128954837;5995.790147344822;6006.399360063959;6175.876482470236;6184.288806787277;6187.071939208975;6193.504519638328;6216.129741836237;5840.970795145997;5930.347661757117;5997.790077347272;6014.338422773579;6015.037593984942 11:14:18 INFO - PROCESS | 1667 | |1;ext.html;508.9363829521312;517.867943674363;530.6736357140355;542.530710935041;574.4542684449773;34297.31405371894;36237.81881090591;41606.58393416065;41618.58381416185;41689.58310416895;42727.786361068225;42783;43423.131537369234;43618.7819060905;43623.56376436235;9491.715248542538;9699.224062075053;9727.075927786884;9733.756656083584;9786.902130978706;9648.986856380085;9694.757631059209;9743.025697430272;9748.512574371289;9771.462569558671;9716.514174291293;9763.609455621767;9785;9791.461469619167;9799.461029643368;9714.854277185848;9746.561404736804;9779.364341317792;9781.119699227032;9792.90207097927;9635.13283804461;9735.659251926148;9741.659041933499;9749.902500974971;9770.951145244228;39065;39560.40659390111;39629.009274768076;39895;40183.7990810047;3086.6913308669177;3374.59504859416;3411.0619579615554;3443.8794642187404;3530.5939816921127;29589.55615665767;30124;30927.226819329473;31129.533057004162;31465.84267078673;3161.9367612647848;3169.666588832636;3222.758293128025;3235.498497732855;3243.0919342584116;444626;450114;450330;453111;456004.719976398;33418.49872251918;33593.16017099592;33826.32347353039;33915.830420847735;33964.150896227795;34502.82748586241;34624.48063279053;34713.65286347155;35711.64288357135;35800.462993055124;16668.916520426134;16769.7484537732;16804.327826886787;16872.987620742795;16915.746263806053;12388;12798.16811907223;12811.935940320238;12946.741065178643;12954.546590869462;16270;16956.576085597713;18143.18355673998;19467.318643847397;19573.804261957197;8207.302379297707;8360.862394554972;8373.539455329894;8383.874241886377;8398.664053437795;896.4979611417497;1020.5713600287897;1080.2600218850114;1096.1614365010773;1136.403388221174;27090.478237828956;28888.566671499946;30801.845990769903;31193.22016949549;31260.374792504022;1080.9729756756144;1105.4914739219887;1129.5255992483176;1142.3659868772745;1144.4792619358172;14160.85839141616;15914.60213494672;15943.521694349189;15973.920130399274;15996.120213388376;692710;705930.470347645;707015;707715;710627;58984.41015589875;60182.09726854101;60817.39182608117;60835.39164608386;61040;1372.1218420211073;1379.296558755022;1393.6933874547583;1401.5304872867703;1402.642326206831;26442.603360949986;30159.774342413213;30747.231319216302;31077.223069423446;31086.37827243488;52206.47793522016;52211.47788522066;52312;52421;52756.47243527669;607194;607726;608848;610890;612012;23601.40996475102;26233.34416639523;26454.470910582066;26824;27052.32369190786;49020.2646960303;49117.01765964589;49737;50234.24648630201;50236.49763502464;39522;40934.59065409308;40979.795101024305;41295.380569290886;41557;39424.605753942094;40049.59950400459;40169.39745903872;40337;40445.797771010955;38818;38896;39023;39786.20427591374;40084.39873401843;31024.379512410076;35605.64394356127;35662.28675426529;36505.452418213215;36624.81687591545;24533.38666533351;25535.36161595975;26034.08880689167;26203.606945895444;26548.734512654628 11:14:18 INFO - PROCESS | 1667 | |2;jquery.html;355.4898720336317;384.96342847429486;398.49789265525436;405.50528355406396;412.6678024190525;18556;19861.602767944667;20745.585088298227;20768.584628307424;20777.584448311023;11827.994620457272;12018.978386837129;12106.031517478603;12354.567590134347;12363.19639223452;5444.945550544493;5616.438356164372;5662.207290979266;5667.829965101054;5668.433156684319;3915.2756740003047;5920.437558431942;6227.377262273759;6240.687965601702;6289.779857704982;5276.34045744282;6175.845603859894;6263.906041409383;6266.624002559838;6704.966475167642;5823.737931793058;6800.489963252776;6900.102986611733;6900.930990690129;6914.412274956635;4318.740875547446;4670.883227919295;4899.118158731427;5501.614886957915;6206.224221972254;9867.60529578816;10037.949810250902;12261.754764904741;12281.01751859849;13441.395137218751;2038.918478071685;2125.8511904166717;2180.6292930201903;2218.678291647702;2401.9639705404434;9240.768980775534;9858.260630452673;10531.894681053169;12312.630621081382;14560.053596516298;1795.07553609891;1887.4672176746415;1934.4680212941414;1934.7484826972545;1943.805619438059;115584.42207788992;122747;123043.76956230412;131191;131315.6868431313;11046.723831904266;11550.942245288888;11714.062874969983;11725.355105469282;12003.039756819433;13691.315434228249;14695.706085878437;14742.336594853257;14771.261436928111;14818.92590537062;8496.745097647081;8596.52719100443;8699.043105258417;8757.430767000125;8759.335726211999;8584.399092063495;8585.656573737106;8634.740957771277;8741.388102832741;8753.781155471037;4450.109978004412;4548.545145485491;4578.9771051144535;4599.356090147382;4629.745364005012;1738.3915629529563;1803.809485739432;1827.3315599317182;1981.6333978214077;1994.9102290396968;868.1665601022962;950.254050570299;953.270747877874;959.7696552827272;978.7406337320616;20189.091490882947;21082;21289.78710212909;21387.67918481224;21391;970.3304719743354;971.5093877591771;981.6122631560636;982.4596471940547;983.2822039910905;9913.107820296207;11279.210455268216;11284.040856527123;11332.376719280519;11355.148363872742;570049;571182;599647;601573;612865;130829;135864.32067839598;142217.57782422044;146170;155055;955.6082006377491;981.1120935553336;1041.068243921686;1043.940400493515;1047.3297089862494;18258.72611910796;18805.90597047061;19102.426927192206;19240.615187696447;19335.129919153955;40000.799995999834;45345.319820202065;46073;47572;54453.1832022512;61765.691171543855;70877.64561177162;71715.20711982241;78639.60680196562;80017;6460.321666224979;6835.965820171066;8159.755207343552;8274;8310.958445207978;10434.478276086316;10648.733781655521;10792.460376981277;11088.833667494833;13055.738885222432;9364.518402623175;9943.850842237516;10181.898181018096;11164.832527511931;11243.10055195566;9640.71077867665;9926.858411282506;10899.727506812393;10994.505247263733;11055.949684779933;9106.95446522763;9704.417734935927;10834.241603087708;11147.83278250843;11294.774104517699;7021.262767409348;7361.1166660001145;7458.291462311072;7602.239776022354;7655.349295309738;10031.899681003097;11249.212555121063;11348.319100853645;11355.772884542428;11433.1996760226 11:14:18 INFO - PROCESS | 1667 | |3;mootools.html;1580.905145691259;1617.5309160343502;1843.7142242952339;1916.3675986924325;1959.4905324615613;8191.344692424606;8615.31077513799;8750.431221970575;9308.8603670945;9314.161725444708;8541.402101852873;8680.262177714902;8687.56562171892;8773.912260877389;8824.735257942257;2369.786719195272;2426.8301218914685;2429.259075981825;2429.963550546743;2432.1973748662986;2041.9489512762152;2348.9647655285185;2380;2384.546936082139;2439.7072351317865;2017.3040301096098;2402.8077753779658;2412.553677569655;2428.0530593068715;2434.221049264236;2368.7631236876346;2385.4751954569965;2395.101836811196;2405;2411.9397015074587;2389.749076346976;2393.1743548475747;2394.7246066702205;2405.458771776336;2406.7713567211085;8883.067277935788;8928.196462318358;9009.954950225272;9023.187913087788;9063;4703.988642441857;5219.947800521984;5452.345718513764;5499.285092937933;5504.972475137639;3653;3688.870889518854;3762.247550489913;3785.356489396809;3786;1035.7100011996654;1054.2725519391672;1074.4090750087498;1084.9891501084967;1086.7717779266363;11592.652220433316;11653.126015548867;11692.649220523397;11830.349330786803;11939.34333611651;4732.905341893143;4740.478547359788;4850.514948505192;4866.099771542276;4868.367112275452;10245.334053286513;10302.742431439125;10310.175185985103;10313.535890884928;10325.225608079425;5324.840254792362;5358.6248962572245;5412.052890744104;5419.132938729785;5422.783088676409;4452.287633978548;4812.639052071108;4930.704157750546;4935.087008903364;4977.800887964513;4101.323281658493;4102.774347410921;4129.91138772613;4167.999680076759;4169.0411205422315;1316.1116246533552;1333.9866601333863;1341.530464337474;1346.750851092551;1351.189286428155;937.9588656591178;941.6562954521551;961.5288508630861;985.014985014985;1013.7871047080048;6049.3950604939155;6069.484093852072;6072.635641861502;6073.696315184223;6169.56813023084;457.1588277569289;462.61140641861;467.18243074619414;1026.810040142576;1066.8613080299667;3832.6358995895343;4111.239420707178;4138.606832350922;4213.325867861189;4256.29771087767;10365.533550990223;10665.893341066645;10763.83854242187;10798.352098873935;10827.025567698787;10618.575256989634;10709.625163119254;10725.570977160825;10759.78480430387;10817.729556761144;8349.791255218668;8442.366822488339;8455.112213217524;8508.361872859561;8510.914890851012;5839.416058394297;5968.880622387441;6117.900468191327;6142.692865356804;6180.412860778219;9817.263705221994;10021.999999999709;10062.245331600014;10349.430781307101;10377.014183652542;10314.349704047316;10474.581016759244;10493.317934334244;10500.684979450629;10534.262601617813;6592.736290548324;6943.201531823905;7083.6541057198965;7157.1769246537315;7246.202917679157;8415.3267738582;8469.068402475847;8500.957495212484;8548.615312310836;8566.400351975302;6463.515236357386;6609.966950165219;6762.985552167018;7021.543599666005;7445.888311675221;5632.493075623213;6291.937080629318;7369.705211791683;7447.962760186165;7549.622518874145;5687.459691329317;6929.653517324215;7126.180489243596;7152.463565232524;7179.784606461814;5079.746012699424;5110.795568177231;5122.00120976406;5137.5889928806355;5220.530152286313;5080.46655101209;5130.51260130287;5151.793928242828;5284.682919024871;5298.099323115002 11:14:18 INFO - PROCESS | 1667 | |4;prototype.html;306.2878806774249;317.66169029983075;321.8390804597701;322.9208843833258;325.9348130373926;4895.485973972726;5487.807926722566;5661.405552416999;5684.289463817023;5768.653880767151;4795.544423279792;5082.03441346144;5180.6891586504835;5464.3442786865535;5647.322321321447;4073.755574665515;4207.263728847454;4263.829446822124;4277.871663850089;4282.314829627245;3774.131949651568;3949.3286141355893;4261.914761704764;4280.678949078816;4307.935380969288;4178.853740119096;4201.873943781691;4205.243056249874;4210.642095421893;4218.873433796991;4049.5950404959417;4243.469566304212;4254.680898932593;4254.723442976212;4264.573542645741;3250.9187270318193;3642.2715456908722;3658.8412836426637;3670.632936706308;3671.375866102769;4907.294992280805;5051;5412.783488660488;5420.186971954199;5464.836054918359;4107.993541582302;4294.763787991659;4666.416697912761;4795.832145874912;4855.441624213226;4728.4562275338085;5744.540436765049;5942.762289508414;5959.255093113361;5984.700764961734;3723.119824488616;3992.461017762594;4006.939895901564;4010.819513121887;4022.6379625833815;5127.282180494696;5286.894262114736;6227.844303892393;6284.962981108111;6346.3662580029695;4039.1719697462536;4048.4129801178665;4049.036217434542;4049.5950404959267;4055.4322394864744;3782.7730336179366;4037.5154981401834;4081.9795901020307;4083.8774836754947;4129.752214867118;4038.1519880825354;4419.955800442019;4833.492483289274;4835.960268542281;4882.8779280517565;5272.710000949908;5726.255586773693;5977.491913187341;6035.758569657252;6061.363556826558;1248.525560287085;1346.4986540007822;1358.8573199814075;1395.427874571421;1399.6221020324658;728.8287252495659;799.6281728996045;807.8788181772782;821.9287395762764;850.6554845287668;3913.5715463855486;4406.427164468599;4702.952970470252;4744.644151688637;4787.755183652275;4774;4929.309896614477;5009.323741294951;5256.395514515803;5263.499967503081;4080.571539988318;4513.533101741947;4702.482726900038;4728.203282752532;4791.329213910055;2530.025940013108;2932.9001624390853;3202.087405089585;3246.951295730566;3267.2485328374605;5949.137375080589;6023.457888789942;6132.938670613236;6181.690915454209;6554.541182117301;6134;6355.904661430082;6360.7137678804565;6400.583962042452;6421.550491465646;6470.741170353227;6482.57863238888;6492.707828147744;6533.216014078246;6533.444657204001;5275.182346736262;5788.305403351456;6109.869674110304;6135.576447303201;6215.720292586935;5235.65968212065;5915.615484993462;6024.518038556993;6075.696215189135;6132.264128304632;6005.249343832021;6195.473384762346;6460.515461340325;6479.967600162157;6484.773032943825;3377.5102610121885;3774.50931378919;4015.257177422186;4042.029912820961;4053.6757059435763;5486.561075113901;5891.1457838614015;6104.4200800923845;6137.508999280136;6187.195664563578;5302.39022512416;5600.411956744483;5836.912446313224;5921.733521991607;6035.637861728311;5572.690417751744;5930.703464826827;5976.342602313655;5984.611000284967;6033.276006879202;5671.120976248688;5689.805140920453;5853.853653658693;5863.20846685692;5863.706814659336;5132.717700526507;5724.227229323988;5970.208937318874;6025.909611355745;6029.3669164737075;4885.5358740919555;5493.258410114743;5529.474699903502;5571.442855714558;5893.675847828411 11:14:18 INFO - PROCESS | 1667 | |5;yui.html;609.9634021958683;613.3590398034054;682.8258794007526;787.342568954923;799.1209669363705;14594.927025364872;15134.621634459145;15252.084874907514;15303.923480382611;15339.923300383496;13758.587242382719;13790.65523361914;13876.93061534691;13882.652933676663;14019.859801401983;878.3544095090103;890.4301247201764;901.0268909577641;903.0743487924864;905.8324210021167;702.785650376635;862.4825104937019;882.7395918204113;891.6121487153076;894.2532984957568;935.6631612619485;936.8688383626297;937.6999360204737;938.8497840345547;941.2281928818337;895.0825403960927;912.2792993535099;928.475411392561;937.9155875971161;940.031767279703;687.9920915858241;691.1257259566652;698.7763915547027;699.2098928211088;701.1586096684;14550.272486375745;14637.41450341985;14668.486602968951;14671.77992330116;14685;13916.721665566733;13921.651958701113;13963.441462341494;14032.92983535086;14222.288885555681;11704;11719;11733.647990560297;11871.940640296829;12054.457549410297;3281.9343613127603;3883.184531248441;3914.275858966072;4009.7794621296107;4023.517177938637;66253;67624.98562521616;69139.3086069138;74801.50396992084;76723.6163819183;8097.109317975018;9745.269104817167;10556.841647375295;10649.094826939641;10707.625233116803;19703.704444433344;20077.799222007885;20265.29071482491;20285;20340.288089917078;7635.618219089023;7723.729669461542;7767.067951845815;7768.92231077682;7873.5275883447175;4461.910761784746;4497.955020449819;4529.252673308933;4530.796114174804;4538.410006699174;3381.408253555618;3386.305807309496;3467.150548115728;3477.3393055319916;3477.7391695622423;661.781612068026;667.0594461808827;674.1270055278426;674.8076798112514;678.7013713965839;592.3247497852452;638.543441439373;651.7099890548756;661.6096503063216;676.9120014398097;8941.865872011926;8973.955130224438;8990.910090899008;9043.547822608974;9242.445453272825;566.7251383079204;585.645684360964;587.5358466811172;644.3846126948753;654.7904670505393;4219.852305169305;4278.572142785696;4296.720713153635;4336.718113322624;4666.556677115668;97898;98109;98463;99900;100974.49512752536;39629.81110566688;42885.57114428816;44965.10069798586;84932.15067849366;86652.56673716591;57220;72050.79492050858;72949;73404;73635;7948;9699.66051188205;9778.804423911624;9783.0706082922;9818.705438836847;31395.529067063555;45491.94463467118;45945.31082033839;45971.540284596726;47867;60380.09429858644;61693.69153154385;62673;63293.36706632875;63383.68308158614;12778.936105319413;12826.23042617446;12881.613551593467;12956.481740730265;13120.343982801012;13966.162030278216;13996.230207338695;14153.292335382983;14159.36282867294;14849.331780069706;12893.226406415644;13188.80216796768;13475.73048539004;13500.257485838372;13651.522196723066;10957;13222.933885330896;13285.933570332472;13291.734165316446;13330.333483325989;13218;13254.602361929157;13304.201747895157;13305.667358315732;13726.656833578842;11037.503312350804;11191.552337906392;11298.209125361474;11845.348505831917;11855.881441185822;10933.405080067374;11347.319160850375;11365.431728413712;11481.885181148416;11529.884701152881 11:14:18 INFO - PROCESS | 1667 | __end_tp_report 11:14:18 INFO - PROCESS | 1667 | __start_cc_report 11:14:18 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,419 11:14:18 INFO - PROCESS | 1667 | __end_cc_report 11:14:18 INFO - PROCESS | 1667 | __startTimestamp1464718458326__endTimestamp 11:14:18 INFO - PROCESS | 1667 | 11:14:18 INFO - PROCESS | 1667 | ------- Summary: start ------- 11:14:18 INFO - PROCESS | 1667 | Number of tests: 6 11:14:18 INFO - PROCESS | 1667 | 11:14:18 INFO - PROCESS | 1667 | [#0] dojo.html Cycles:165 Average:5698.53 Median:5997.79 stddev:780.78 (13.0%) stddev-sans-first:763.19 11:14:18 INFO - PROCESS | 1667 | Values: 3461.2 3482.8 3493.7 3505.7 3508.3 5695.5 5703.4 5742.1 5798.7 5871.3 5390.5 5638.0 5728.3 5797.4 5861.3 5110.4 5154.2 5224.7 5233.7 5254.6 783.7 5132.6 5171.4 5194.7 5212.9 5190.4 5201.8 5217.8 5229.3 5235.1 4265.5 5211.8 5240.1 5258.9 5273.3 4300.9 4820.7 5123.6 5155.7 5198.5 4083.1 4678.4 5412.2 5438.2 5564.6 5358.3 6060.2 6093.6 6106.0 6228.5 5148.4 6249.3 6280.8 6292.0 6304.0 5848.5 5946.4 5950.7 5957.3 6002.4 5497.7 6008.5 6222.9 6246.6 6317.4 6102.4 6195.0 6196.0 6205.7 6215.2 6302.2 6315.5 6316.6 6322.8 6335.2 6125.2 6143.0 6167.5 6259.9 6298.9 6250.7 6299.6 6318.3 6321.3 6324.0 4879.5 4925.0 4932.0 4936.4 4939.2 4345.9 4353.6 4372.5 4411.2 4455.9 5649.5 5711.2 5730.4 5766.4 5768.7 6307.2 6325.0 6332.2 6336.3 6345.1 5521.3 5697.6 5717.7 5733.5 5762.3 5413.8 5416.3 5416.4 5423.6 5425.0 6345.3 6372.9 6377.9 6379.9 6391.9 6154.1 6215.8 6246.1 6276.8 6288.7 6382.4 6393.5 6394.4 6418.4 6505.8 6242.1 6247.2 6264.1 6274.0 6278.2 6127.6 6145.2 6187.8 6195.1 6285.7 6172.2 6187.4 6190.4 6191.2 6205.2 6020.4 6155.5 6185.0 6188.3 6195.3 5853.8 5860.5 5967.8 5995.8 6006.4 6175.9 6184.3 6187.1 6193.5 6216.1 5841.0 5930.3 5997.8 6014.3 6015.0 11:14:18 INFO - PROCESS | 1667 | 11:14:18 INFO - PROCESS | 1667 | [#1] ext.html Cycles:180 Average:70741.59 Median:39473.30 stddev:160229.50 (405.9%) stddev-sans-first:160592.21 11:14:18 INFO - PROCESS | 1667 | Values: 508.9 517.9 530.7 542.5 574.5 34297.3 36237.8 41606.6 41618.6 41689.6 42727.8 42783.0 43423.1 43618.8 43623.6 9491.7 9699.2 9727.1 9733.8 9786.9 9649.0 9694.8 9743.0 9748.5 9771.5 9716.5 9763.6 9785.0 9791.5 9799.5 9714.9 9746.6 9779.4 9781.1 9792.9 9635.1 9735.7 9741.7 9749.9 9771.0 39065.0 39560.4 39629.0 39895.0 40183.8 3086.7 3374.6 3411.1 3443.9 3530.6 29589.6 30124.0 30927.2 31129.5 31465.8 3161.9 3169.7 3222.8 3235.5 3243.1 444626.0 450114.0 450330.0 453111.0 456004.7 33418.5 33593.2 33826.3 33915.8 33964.2 34502.8 34624.5 34713.7 35711.6 35800.5 16668.9 16769.7 16804.3 16873.0 16915.7 12388.0 12798.2 12811.9 12946.7 12954.5 16270.0 16956.6 18143.2 19467.3 19573.8 8207.3 8360.9 8373.5 8383.9 8398.7 896.5 1020.6 1080.3 1096.2 1136.4 27090.5 28888.6 30801.8 31193.2 31260.4 1081.0 1105.5 1129.5 1142.4 1144.5 14160.9 15914.6 15943.5 15973.9 15996.1 692710.0 705930.5 707015.0 707715.0 710627.0 58984.4 60182.1 60817.4 60835.4 61040.0 1372.1 1379.3 1393.7 1401.5 1402.6 26442.6 30159.8 30747.2 31077.2 31086.4 52206.5 52211.5 52312.0 52421.0 52756.5 607194.0 607726.0 608848.0 610890.0 612012.0 23601.4 26233.3 26454.5 26824.0 27052.3 49020.3 49117.0 49737.0 50234.2 50236.5 39522.0 40934.6 40979.8 41295.4 41557.0 39424.6 40049.6 40169.4 40337.0 40445.8 38818.0 38896.0 39023.0 39786.2 40084.4 31024.4 35605.6 35662.3 36505.5 36624.8 24533.4 25535.4 26034.1 26203.6 26548.7 11:14:18 INFO - PROCESS | 1667 | 11:14:18 INFO - PROCESS | 1667 | [#2] jquery.html Cycles:180 Average:34404.34 Median:2156.89 stddev:99376.39 (4607.4%) stddev-sans-first:99622.28 11:14:18 INFO - PROCESS | 1667 | Values: 355.5 385.0 398.5 405.5 412.7 18556.0 19861.6 20745.6 20768.6 20777.6 11828.0 12019.0 12106.0 12354.6 12363.2 5444.9 5616.4 5662.2 5667.8 5668.4 3915.3 5920.4 6227.4 6240.7 6289.8 5276.3 6175.8 6263.9 6266.6 6705.0 5823.7 6800.5 6900.1 6900.9 6914.4 4318.7 4670.9 4899.1 5501.6 6206.2 9867.6 10037.9 12261.8 12281.0 13441.4 2038.9 2125.9 2180.6 2218.7 2402.0 9240.8 9858.3 10531.9 12312.6 14560.1 1795.1 1887.5 1934.5 1934.7 1943.8 115584.4 122747.0 123043.8 131191.0 131315.7 11046.7 11550.9 11714.1 11725.4 12003.0 13691.3 14695.7 14742.3 14771.3 14818.9 8496.7 8596.5 8699.0 8757.4 8759.3 8584.4 8585.7 8634.7 8741.4 8753.8 4450.1 4548.5 4579.0 4599.4 4629.7 1738.4 1803.8 1827.3 1981.6 1994.9 868.2 950.3 953.3 959.8 978.7 20189.1 21082.0 21289.8 21387.7 21391.0 970.3 971.5 981.6 982.5 983.3 9913.1 11279.2 11284.0 11332.4 11355.1 570049.0 571182.0 599647.0 601573.0 612865.0 130829.0 135864.3 142217.6 146170.0 155055.0 955.6 981.1 1041.1 1043.9 1047.3 18258.7 18805.9 19102.4 19240.6 19335.1 40000.8 45345.3 46073.0 47572.0 54453.2 61765.7 70877.6 71715.2 78639.6 80017.0 6460.3 6836.0 8159.8 8274.0 8311.0 10434.5 10648.7 10792.5 11088.8 13055.7 9364.5 9943.9 10181.9 11164.8 11243.1 9640.7 9926.9 10899.7 10994.5 11055.9 9107.0 9704.4 10834.2 11147.8 11294.8 7021.3 7361.1 7458.3 7602.2 7655.3 10031.9 11249.2 11348.3 11355.8 11433.2 11:14:18 INFO - PROCESS | 1667 | 11:14:18 INFO - PROCESS | 1667 | [#3] mootools.html Cycles:180 Average:5764.12 Median:2585.59 stddev:3225.31 (124.7%) stddev-sans-first:3219.04 11:14:18 INFO - PROCESS | 1667 | Values: 1580.9 1617.5 1843.7 1916.4 1959.5 8191.3 8615.3 8750.4 9308.9 9314.2 8541.4 8680.3 8687.6 8773.9 8824.7 2369.8 2426.8 2429.3 2430.0 2432.2 2041.9 2349.0 2380.0 2384.5 2439.7 2017.3 2402.8 2412.6 2428.1 2434.2 2368.8 2385.5 2395.1 2405.0 2411.9 2389.7 2393.2 2394.7 2405.5 2406.8 8883.1 8928.2 9010.0 9023.2 9063.0 4704.0 5219.9 5452.3 5499.3 5505.0 3653.0 3688.9 3762.2 3785.4 3786.0 1035.7 1054.3 1074.4 1085.0 1086.8 11592.7 11653.1 11692.6 11830.3 11939.3 4732.9 4740.5 4850.5 4866.1 4868.4 10245.3 10302.7 10310.2 10313.5 10325.2 5324.8 5358.6 5412.1 5419.1 5422.8 4452.3 4812.6 4930.7 4935.1 4977.8 4101.3 4102.8 4129.9 4168.0 4169.0 1316.1 1334.0 1341.5 1346.8 1351.2 938.0 941.7 961.5 985.0 1013.8 6049.4 6069.5 6072.6 6073.7 6169.6 457.2 462.6 467.2 1026.8 1066.9 3832.6 4111.2 4138.6 4213.3 4256.3 10365.5 10665.9 10763.8 10798.4 10827.0 10618.6 10709.6 10725.6 10759.8 10817.7 8349.8 8442.4 8455.1 8508.4 8510.9 5839.4 5968.9 6117.9 6142.7 6180.4 9817.3 10022.0 10062.2 10349.4 10377.0 10314.3 10474.6 10493.3 10500.7 10534.3 6592.7 6943.2 7083.7 7157.2 7246.2 8415.3 8469.1 8501.0 8548.6 8566.4 6463.5 6610.0 6763.0 7021.5 7445.9 5632.5 6291.9 7369.7 7448.0 7549.6 5687.5 6929.7 7126.2 7152.5 7179.8 5079.7 5110.8 5122.0 5137.6 5220.5 5080.5 5130.5 5151.8 5284.7 5298.1 11:14:18 INFO - PROCESS | 1667 | 11:14:18 INFO - PROCESS | 1667 | [#4] prototype.html Cycles:180 Average:4723.83 Median:5130.00 stddev:1500.70 (29.3%) stddev-sans-first:1467.83 11:14:18 INFO - PROCESS | 1667 | Values: 306.3 317.7 321.8 322.9 325.9 4895.5 5487.8 5661.4 5684.3 5768.7 4795.5 5082.0 5180.7 5464.3 5647.3 4073.8 4207.3 4263.8 4277.9 4282.3 3774.1 3949.3 4261.9 4280.7 4307.9 4178.9 4201.9 4205.2 4210.6 4218.9 4049.6 4243.5 4254.7 4254.7 4264.6 3250.9 3642.3 3658.8 3670.6 3671.4 4907.3 5051.0 5412.8 5420.2 5464.8 4108.0 4294.8 4666.4 4795.8 4855.4 4728.5 5744.5 5942.8 5959.3 5984.7 3723.1 3992.5 4006.9 4010.8 4022.6 5127.3 5286.9 6227.8 6285.0 6346.4 4039.2 4048.4 4049.0 4049.6 4055.4 3782.8 4037.5 4082.0 4083.9 4129.8 4038.2 4420.0 4833.5 4836.0 4882.9 5272.7 5726.3 5977.5 6035.8 6061.4 1248.5 1346.5 1358.9 1395.4 1399.6 728.8 799.6 807.9 821.9 850.7 3913.6 4406.4 4703.0 4744.6 4787.8 4774.0 4929.3 5009.3 5256.4 5263.5 4080.6 4513.5 4702.5 4728.2 4791.3 2530.0 2932.9 3202.1 3247.0 3267.2 5949.1 6023.5 6132.9 6181.7 6554.5 6134.0 6355.9 6360.7 6400.6 6421.6 6470.7 6482.6 6492.7 6533.2 6533.4 5275.2 5788.3 6109.9 6135.6 6215.7 5235.7 5915.6 6024.5 6075.7 6132.3 6005.2 6195.5 6460.5 6480.0 6484.8 3377.5 3774.5 4015.3 4042.0 4053.7 5486.6 5891.1 6104.4 6137.5 6187.2 5302.4 5600.4 5836.9 5921.7 6035.6 5572.7 5930.7 5976.3 5984.6 6033.3 5671.1 5689.8 5853.9 5863.2 5863.7 5132.7 5724.2 5970.2 6025.9 6029.4 4885.5 5493.3 5529.5 5571.4 5893.7 11:14:18 INFO - PROCESS | 1667 | 11:14:18 INFO - PROCESS | 1667 | [#5] yui.html Cycles:180 Average:17874.87 Median:4534.60 stddev:24238.88 (534.5%) stddev-sans-first:24272.21 11:14:18 INFO - PROCESS | 1667 | Values: 610.0 613.4 682.8 787.3 799.1 14594.9 15134.6 15252.1 15303.9 15339.9 13758.6 13790.7 13876.9 13882.7 14019.9 878.4 890.4 901.0 903.1 905.8 702.8 862.5 882.7 891.6 894.3 935.7 936.9 937.7 938.8 941.2 895.1 912.3 928.5 937.9 940.0 688.0 691.1 698.8 699.2 701.2 14550.3 14637.4 14668.5 14671.8 14685.0 13916.7 13921.7 13963.4 14032.9 14222.3 11704.0 11719.0 11733.6 11871.9 12054.5 3281.9 3883.2 3914.3 4009.8 4023.5 66253.0 67625.0 69139.3 74801.5 76723.6 8097.1 9745.3 10556.8 10649.1 10707.6 19703.7 20077.8 20265.3 20285.0 20340.3 7635.6 7723.7 7767.1 7768.9 7873.5 4461.9 4498.0 4529.3 4530.8 4538.4 3381.4 3386.3 3467.2 3477.3 3477.7 661.8 667.1 674.1 674.8 678.7 592.3 638.5 651.7 661.6 676.9 8941.9 8974.0 8990.9 9043.5 9242.4 566.7 585.6 587.5 644.4 654.8 4219.9 4278.6 4296.7 4336.7 4666.6 97898.0 98109.0 98463.0 99900.0 100974.5 39629.8 42885.6 44965.1 84932.2 86652.6 57220.0 72050.8 72949.0 73404.0 73635.0 7948.0 9699.7 9778.8 9783.1 9818.7 31395.5 45491.9 45945.3 45971.5 47867.0 60380.1 61693.7 62673.0 63293.4 63383.7 12778.9 12826.2 12881.6 12956.5 13120.3 13966.2 13996.2 14153.3 14159.4 14849.3 12893.2 13188.8 13475.7 13500.3 13651.5 10957.0 13222.9 13285.9 13291.7 13330.3 13218.0 13254.6 13304.2 13305.7 13726.7 11037.5 11191.6 11298.2 11845.3 11855.9 10933.4 11347.3 11365.4 11481.9 11529.9 11:14:18 INFO - PROCESS | 1667 | -------- Summary: end -------- 11:14:18 INFO - PROCESS | 1667 | 11:14:18 INFO - TEST-INFO | 1667: exit 0 11:14:18 INFO - TEST-OK | dromaeo_css | took 1111935ms 11:14:18 INFO - TEST-START | kraken 11:14:18 INFO - operating with platform_type : mac_ 11:14:18 INFO - Initialising browser for kraken test... 11:14:18 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmpfN4a98/profile http://localhost:49279/getInfo.html) 11:14:21 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 11:14:21 INFO - PROCESS | 1676 | colorDepth:24 11:14:21 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 11:14:21 INFO - PROCESS | 1676 | __metrics 11:14:22 ERROR - PROCESS | 1676 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 11:14:22 INFO - TEST-INFO | 1676: exit 0 11:14:22 INFO - Browser initialized. 11:14:22 INFO - Running cycle 1/1 for kraken test... 11:14:22 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmpfN4a98/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:14:34 INFO - PROCESS | 1678 | RSS: Main: 252432384 11:14:34 INFO - PROCESS | 1678 | 11:14:37 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 11:14:38 INFO - PROCESS | 1678 | RSS: Main: 265347072 11:14:38 INFO - PROCESS | 1678 | 11:14:41 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 11:14:41 INFO - PROCESS | 1678 | RSS: Main: 269463552 11:14:41 INFO - PROCESS | 1678 | 11:14:45 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 11:14:45 INFO - PROCESS | 1678 | RSS: Main: 269967360 11:14:45 INFO - PROCESS | 1678 | 11:14:47 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 11:14:48 INFO - PROCESS | 1678 | RSS: Main: 270876672 11:14:48 INFO - PROCESS | 1678 | 11:14:50 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:14:50 INFO - PROCESS | 1678 | RSS: Main: 271527936 11:14:50 INFO - PROCESS | 1678 | 11:14:53 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 11:14:54 INFO - PROCESS | 1678 | RSS: Main: 272322560 11:14:54 INFO - PROCESS | 1678 | 11:14:57 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 11:14:58 INFO - PROCESS | 1678 | RSS: Main: 272470016 11:14:58 INFO - PROCESS | 1678 | 11:15:01 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 11:15:01 INFO - PROCESS | 1678 | RSS: Main: 273022976 11:15:01 INFO - PROCESS | 1678 | 11:15:03 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:15:03 INFO - PROCESS | 1678 | RSS: Main: 272400384 11:15:03 INFO - PROCESS | 1678 | 11:15:05 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:15:06 INFO - PROCESS | 1678 | RSS: Main: 271929344 11:15:06 INFO - PROCESS | 1678 | 11:15:08 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:15:09 INFO - PROCESS | 1678 | RSS: Main: 272273408 11:15:09 INFO - PROCESS | 1678 | 11:15:12 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:15:12 INFO - PROCESS | 1678 | RSS: Main: 272318464 11:15:12 INFO - PROCESS | 1678 | 11:15:15 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:15:16 INFO - PROCESS | 1678 | RSS: Main: 272191488 11:15:16 INFO - PROCESS | 1678 | 11:15:18 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 11:15:18 INFO - PROCESS | 1678 | RSS: Main: 273211392 11:15:18 INFO - PROCESS | 1678 | 11:15:18 INFO - PROCESS | 1678 | __start_tp_report 11:15:18 INFO - PROCESS | 1678 | _x_x_mozilla_page_load 11:15:18 INFO - PROCESS | 1678 | _x_x_mozilla_page_load_details 11:15:18 INFO - PROCESS | 1678 | |i|pagename|runs| 11:15:18 INFO - PROCESS | 1678 | |0;ai-astar;139;157;157;117;117;116;114;114;117;117 11:15:18 INFO - PROCESS | 1678 | |1;audio-beat-detection;154;120;150;173;109;136;155;146;198;146 11:15:18 INFO - PROCESS | 1678 | |2;audio-dft;203;200;223;260;198;195;194;200;189;161 11:15:18 INFO - PROCESS | 1678 | |3;audio-fft;65;77;75;137;58;57;59;64;128;58 11:15:18 INFO - PROCESS | 1678 | |4;audio-oscillator;69;70;113;72;72;91;113;83;102;113 11:15:18 INFO - PROCESS | 1678 | |5;imaging-gaussian-blur;82;132;89;86;90;74;136;86;136;120 11:15:18 INFO - PROCESS | 1678 | |6;imaging-darkroom;96;97;96;104;143;96;105;128;95;100 11:15:18 INFO - PROCESS | 1678 | |7;imaging-desaturate;92;96;94;92;122;140;116;91;93;92 11:15:18 INFO - PROCESS | 1678 | |8;json-parse-financial;58;59;55;58;55;60;58;55;57;57 11:15:18 INFO - PROCESS | 1678 | |9;json-stringify-tinderbox;67;70;74;72;77;73;72;69;70;71 11:15:18 INFO - PROCESS | 1678 | |10;stanford-crypto-aes;86;95;89;84;88;92;79;88;115;87 11:15:18 INFO - PROCESS | 1678 | |11;stanford-crypto-ccm;142;139;139;158;148;149;138;140;164;142 11:15:18 INFO - PROCESS | 1678 | |12;stanford-crypto-pbkdf2;166;164;166;175;159;175;161;225;171;165 11:15:18 INFO - PROCESS | 1678 | |13;stanford-crypto-sha256-iterative;75;81;85;61;59;57;70;80;84;83 11:15:18 INFO - PROCESS | 1678 | __end_tp_report 11:15:18 INFO - PROCESS | 1678 | __start_cc_report 11:15:18 INFO - PROCESS | 1678 | _x_x_mozilla_cycle_collect,1055 11:15:18 INFO - PROCESS | 1678 | __end_cc_report 11:15:18 INFO - PROCESS | 1678 | __startTimestamp1464718518272__endTimestamp 11:15:18 INFO - PROCESS | 1678 | 11:15:18 INFO - PROCESS | 1678 | ------- Summary: start ------- 11:15:18 INFO - PROCESS | 1678 | Number of tests: 14 11:15:18 INFO - PROCESS | 1678 | 11:15:18 INFO - PROCESS | 1678 | [#0] ai-astar Cycles:10 Average:126.50 Median:117.00 stddev:17.64 (15.1%) stddev-sans-first:18.12 11:15:18 INFO - PROCESS | 1678 | Values: 139.0 157.0 157.0 117.0 117.0 116.0 114.0 114.0 117.0 117.0 11:15:18 INFO - PROCESS | 1678 | 11:15:18 INFO - PROCESS | 1678 | [#1] audio-beat-detection Cycles:10 Average:148.70 Median:152.00 stddev:25.09 (16.5%) stddev-sans-first:26.54 11:15:18 INFO - PROCESS | 1678 | Values: 154.0 120.0 150.0 173.0 109.0 136.0 155.0 146.0 198.0 146.0 11:15:18 INFO - PROCESS | 1678 | 11:15:18 INFO - PROCESS | 1678 | [#2] audio-dft Cycles:10 Average:202.30 Median:200.00 stddev:25.37 (12.7%) stddev-sans-first:26.91 11:15:18 INFO - PROCESS | 1678 | Values: 203.0 200.0 223.0 260.0 198.0 195.0 194.0 200.0 189.0 161.0 11:15:18 INFO - PROCESS | 1678 | 11:15:18 INFO - PROCESS | 1678 | [#3] audio-fft Cycles:10 Average:77.80 Median:61.50 stddev:29.74 (48.3%) stddev-sans-first:31.18 11:15:18 INFO - PROCESS | 1678 | Values: 65.0 77.0 75.0 137.0 58.0 57.0 59.0 64.0 128.0 58.0 11:15:18 INFO - PROCESS | 1678 | 11:15:18 INFO - PROCESS | 1678 | [#4] audio-oscillator Cycles:10 Average:89.80 Median:71.00 stddev:19.06 (26.8%) stddev-sans-first:18.67 11:15:18 INFO - PROCESS | 1678 | Values: 69.0 70.0 113.0 72.0 72.0 91.0 113.0 83.0 102.0 113.0 11:15:18 INFO - PROCESS | 1678 | 11:15:18 INFO - PROCESS | 1678 | [#5] imaging-gaussian-blur Cycles:10 Average:103.10 Median:84.00 stddev:24.79 (29.5%) stddev-sans-first:25.10 11:15:18 INFO - PROCESS | 1678 | Values: 82.0 132.0 89.0 86.0 90.0 74.0 136.0 86.0 136.0 120.0 11:15:18 INFO - PROCESS | 1678 | 11:15:18 INFO - PROCESS | 1678 | [#6] imaging-darkroom Cycles:10 Average:106.00 Median:95.50 stddev:16.32 (17.1%) stddev-sans-first:16.90 11:15:18 INFO - PROCESS | 1678 | Values: 96.0 97.0 96.0 104.0 143.0 96.0 105.0 128.0 95.0 100.0 11:15:18 INFO - PROCESS | 1678 | 11:15:18 INFO - PROCESS | 1678 | [#7] imaging-desaturate Cycles:10 Average:102.80 Median:92.00 stddev:17.11 (18.6%) stddev-sans-first:17.70 11:15:18 INFO - PROCESS | 1678 | Values: 92.0 96.0 94.0 92.0 122.0 140.0 116.0 91.0 93.0 92.0 11:15:18 INFO - PROCESS | 1678 | 11:15:18 INFO - PROCESS | 1678 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:58.00 stddev:1.75 (3.0%) stddev-sans-first:1.83 11:15:18 INFO - PROCESS | 1678 | Values: 58.0 59.0 55.0 58.0 55.0 60.0 58.0 55.0 57.0 57.0 11:15:18 INFO - PROCESS | 1678 | 11:15:18 INFO - PROCESS | 1678 | [#9] json-stringify-tinderbox Cycles:10 Average:71.50 Median:72.00 stddev:2.80 (3.9%) stddev-sans-first:2.45 11:15:18 INFO - PROCESS | 1678 | Values: 67.0 70.0 74.0 72.0 77.0 73.0 72.0 69.0 70.0 71.0 11:15:18 INFO - PROCESS | 1678 | 11:15:18 INFO - PROCESS | 1678 | [#10] stanford-crypto-aes Cycles:10 Average:90.30 Median:88.00 stddev:9.68 (11.0%) stddev-sans-first:10.15 11:15:18 INFO - PROCESS | 1678 | Values: 86.0 95.0 89.0 84.0 88.0 92.0 79.0 88.0 115.0 87.0 11:15:18 INFO - PROCESS | 1678 | 11:15:18 INFO - PROCESS | 1678 | [#11] stanford-crypto-ccm Cycles:10 Average:145.90 Median:145.00 stddev:8.89 (6.1%) stddev-sans-first:9.31 11:15:18 INFO - PROCESS | 1678 | Values: 142.0 139.0 139.0 158.0 148.0 149.0 138.0 140.0 164.0 142.0 11:15:18 INFO - PROCESS | 1678 | 11:15:18 INFO - PROCESS | 1678 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.70 Median:168.50 stddev:19.14 (11.4%) stddev-sans-first:20.15 11:15:18 INFO - PROCESS | 1678 | Values: 166.0 164.0 166.0 175.0 159.0 175.0 161.0 225.0 171.0 165.0 11:15:18 INFO - PROCESS | 1678 | 11:15:18 INFO - PROCESS | 1678 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.50 Median:80.50 stddev:10.98 (13.6%) stddev-sans-first:11.63 11:15:18 INFO - PROCESS | 1678 | Values: 75.0 81.0 85.0 61.0 59.0 57.0 70.0 80.0 84.0 83.0 11:15:18 INFO - PROCESS | 1678 | -------- Summary: end -------- 11:15:18 INFO - PROCESS | 1678 | 11:15:19 INFO - TEST-INFO | 1678: exit 0 11:15:19 INFO - TEST-OK | kraken | took 60163ms 11:15:19 INFO - SUITE-END | took 1172s 11:15:19 INFO - Completed test suite (00:19:32) 11:15:19 INFO - javascript benchmark 11:15:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7236.518611825305, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3461.238527523944, 3482.7736197147187, 3493.668101530355, 3505.7020153286953, 3508.263264714409, 5695.544356451484, 5703.401142879995, 5742.138679198112, 5798.681072541009, 5871.29544454666, 5390.5418039466695, 5637.9718101409435, 5728.283964504437, 5797.362290148091, 5861.325947516037, 5110.412302585194, 5154.226865970116, 5224.660397074178, 5233.712145831978, 5254.605904557155, 783.6715019744887, 5132.615053870956, 5171.37943446785, 5194.662346947436, 5212.895742085156, 5190.403103643072, 5201.843944681627, 5217.765200565984, 5229.320188375525, 5235.110031294651, 4265.488141423018, 5211.765470553834, 5240.109181439165, 5258.868528286824, 5273.288106105665, 4300.8709738707885, 4820.650217938983, 5123.641345105844, 5155.66488178271, 5198.480151984809, 4083.1425400665894, 4678.415198100238, 5412.15986564566, 5438.238646589481, 5564.638298510625, 5358.33020872391, 6060.151578778975, 6093.6039157454625, 6106.0, 6228.5017198624, 5148.3564554430695, 6249.343818899041, 6280.811575652692, 6292.0, 6303.968480157616, 5848.532117430638, 5946.405359464019, 5950.672713000827, 5957.281977682545, 6002.39976002405, 5497.670139791625, 6008.489278411296, 6222.937770622327, 6246.625202487774, 6317.368263173646, 6102.368068311519, 6195.0, 6196.008638617799, 6205.689715514206, 6215.223097112861, 6302.243730752339, 6315.463185629181, 6316.589421687576, 6322.841928951721, 6335.176427064544, 6125.173101631222, 6142.959235178615, 6167.537434692416, 6259.906101408483, 6298.874022519615, 6250.687465626791, 6299.590526615755, 6318.336574659686, 6321.273053598803, 6324.0, 4879.487653796371, 4925.039617274669, 4931.988942266827, 4936.358273424432, 4939.185034469344, 4345.934810977775, 4353.6299414549485, 4372.540883207217, 4411.1618792429335, 4455.888602784957, 5649.54803615718, 5711.171880077365, 5730.398308177665, 5766.394528574523, 5768.74040668171, 6307.24313082433, 6325.0, 6332.208473940757, 6336.303006669263, 6345.111684364193, 5521.309836270466, 5697.601167918206, 5717.656940583495, 5733.512651424676, 5762.2509073820975, 5413.810516631977, 5416.268803711528, 5416.404195538487, 5423.593230507728, 5425.02349577072, 6345.270293916166, 6372.904406433907, 6377.904331435032, 6379.936200638027, 6391.872162556816, 6154.076888466766, 6215.782447614311, 6246.063090536456, 6276.780312689034, 6288.717007734755, 6382.3617638237665, 6393.520485963664, 6394.360563943568, 6418.390252925965, 6505.804825855232, 6242.063690446469, 6247.187865577446, 6264.123022776724, 6274.027525733519, 6278.215223097113, 6127.617148554337, 6145.1564530639735, 6187.752489900354, 6195.101710251898, 6285.748570057147, 6172.166757487682, 6187.412195841388, 6190.442860142609, 6191.226096737908, 6205.22434695663, 6020.397960203944, 6155.4767844731905, 6185.041318595625, 6188.257409110935, 6195.287541932736, 5853.770708151336, 5860.531157507304, 5967.76128954837, 5995.790147344822, 6006.399360063959, 6175.876482470236, 6184.288806787277, 6187.071939208975, 6193.504519638328, 6216.129741836237, 5840.970795145997, 5930.347661757117, 5997.790077347272, 6014.338422773579, 6015.037593984942], "value": 5650.0870413827, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [508.9363829521312, 517.867943674363, 530.6736357140355, 542.530710935041, 574.4542684449773, 34297.31405371894, 36237.81881090591, 41606.58393416065, 41618.58381416185, 41689.58310416895, 42727.786361068225, 42783.0, 43423.131537369234, 43618.7819060905, 43623.56376436235, 9491.715248542538, 9699.224062075053, 9727.075927786884, 9733.756656083584, 9786.902130978706, 9648.986856380085, 9694.757631059209, 9743.025697430272, 9748.512574371289, 9771.462569558671, 9716.514174291293, 9763.609455621767, 9785.0, 9791.461469619167, 9799.461029643368, 9714.854277185848, 9746.561404736804, 9779.364341317792, 9781.119699227032, 9792.90207097927, 9635.13283804461, 9735.659251926148, 9741.659041933499, 9749.902500974971, 9770.951145244228, 39065.0, 39560.40659390111, 39629.009274768076, 39895.0, 40183.7990810047, 3086.6913308669177, 3374.59504859416, 3411.0619579615554, 3443.8794642187404, 3530.5939816921127, 29589.55615665767, 30124.0, 30927.226819329473, 31129.533057004162, 31465.84267078673, 3161.9367612647848, 3169.666588832636, 3222.758293128025, 3235.498497732855, 3243.0919342584116, 444626.0, 450114.0, 450330.0, 453111.0, 456004.719976398, 33418.49872251918, 33593.16017099592, 33826.32347353039, 33915.830420847735, 33964.150896227795, 34502.82748586241, 34624.48063279053, 34713.65286347155, 35711.64288357135, 35800.462993055124, 16668.916520426134, 16769.7484537732, 16804.327826886787, 16872.987620742795, 16915.746263806053, 12388.0, 12798.16811907223, 12811.935940320238, 12946.741065178643, 12954.546590869462, 16270.0, 16956.576085597713, 18143.18355673998, 19467.318643847397, 19573.804261957197, 8207.302379297707, 8360.862394554972, 8373.539455329894, 8383.874241886377, 8398.664053437795, 896.4979611417497, 1020.5713600287897, 1080.2600218850114, 1096.1614365010773, 1136.403388221174, 27090.478237828956, 28888.566671499946, 30801.845990769903, 31193.22016949549, 31260.374792504022, 1080.9729756756144, 1105.4914739219887, 1129.5255992483176, 1142.3659868772745, 1144.4792619358172, 14160.85839141616, 15914.60213494672, 15943.521694349189, 15973.920130399274, 15996.120213388376, 692710.0, 705930.470347645, 707015.0, 707715.0, 710627.0, 58984.41015589875, 60182.09726854101, 60817.39182608117, 60835.39164608386, 61040.0, 1372.1218420211073, 1379.296558755022, 1393.6933874547583, 1401.5304872867703, 1402.642326206831, 26442.603360949986, 30159.774342413213, 30747.231319216302, 31077.223069423446, 31086.37827243488, 52206.47793522016, 52211.47788522066, 52312.0, 52421.0, 52756.47243527669, 607194.0, 607726.0, 608848.0, 610890.0, 612012.0, 23601.40996475102, 26233.34416639523, 26454.470910582066, 26824.0, 27052.32369190786, 49020.2646960303, 49117.01765964589, 49737.0, 50234.24648630201, 50236.49763502464, 39522.0, 40934.59065409308, 40979.795101024305, 41295.380569290886, 41557.0, 39424.605753942094, 40049.59950400459, 40169.39745903872, 40337.0, 40445.797771010955, 38818.0, 38896.0, 39023.0, 39786.20427591374, 40084.39873401843, 31024.379512410076, 35605.64394356127, 35662.28675426529, 36505.452418213215, 36624.81687591545, 24533.38666533351, 25535.36161595975, 26034.08880689167, 26203.606945895444, 26548.734512654628], "value": 19725.63920111094, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.4898720336317, 384.96342847429486, 398.49789265525436, 405.50528355406396, 412.6678024190525, 18556.0, 19861.602767944667, 20745.585088298227, 20768.584628307424, 20777.584448311023, 11827.994620457272, 12018.978386837129, 12106.031517478603, 12354.567590134347, 12363.19639223452, 5444.945550544493, 5616.438356164372, 5662.207290979266, 5667.829965101054, 5668.433156684319, 3915.2756740003047, 5920.437558431942, 6227.377262273759, 6240.687965601702, 6289.779857704982, 5276.34045744282, 6175.845603859894, 6263.906041409383, 6266.624002559838, 6704.966475167642, 5823.737931793058, 6800.489963252776, 6900.102986611733, 6900.930990690129, 6914.412274956635, 4318.740875547446, 4670.883227919295, 4899.118158731427, 5501.614886957915, 6206.224221972254, 9867.60529578816, 10037.949810250902, 12261.754764904741, 12281.01751859849, 13441.395137218751, 2038.918478071685, 2125.8511904166717, 2180.6292930201903, 2218.678291647702, 2401.9639705404434, 9240.768980775534, 9858.260630452673, 10531.894681053169, 12312.630621081382, 14560.053596516298, 1795.07553609891, 1887.4672176746415, 1934.4680212941414, 1934.7484826972545, 1943.805619438059, 115584.42207788992, 122747.0, 123043.76956230412, 131191.0, 131315.6868431313, 11046.723831904266, 11550.942245288888, 11714.062874969983, 11725.355105469282, 12003.039756819433, 13691.315434228249, 14695.706085878437, 14742.336594853257, 14771.261436928111, 14818.92590537062, 8496.745097647081, 8596.52719100443, 8699.043105258417, 8757.430767000125, 8759.335726211999, 8584.399092063495, 8585.656573737106, 8634.740957771277, 8741.388102832741, 8753.781155471037, 4450.109978004412, 4548.545145485491, 4578.9771051144535, 4599.356090147382, 4629.745364005012, 1738.3915629529563, 1803.809485739432, 1827.3315599317182, 1981.6333978214077, 1994.9102290396968, 868.1665601022962, 950.254050570299, 953.270747877874, 959.7696552827272, 978.7406337320616, 20189.091490882947, 21082.0, 21289.78710212909, 21387.67918481224, 21391.0, 970.3304719743354, 971.5093877591771, 981.6122631560636, 982.4596471940547, 983.2822039910905, 9913.107820296207, 11279.210455268216, 11284.040856527123, 11332.376719280519, 11355.148363872742, 570049.0, 571182.0, 599647.0, 601573.0, 612865.0, 130829.0, 135864.32067839598, 142217.57782422044, 146170.0, 155055.0, 955.6082006377491, 981.1120935553336, 1041.068243921686, 1043.940400493515, 1047.3297089862494, 18258.72611910796, 18805.90597047061, 19102.426927192206, 19240.615187696447, 19335.129919153955, 40000.799995999834, 45345.319820202065, 46073.0, 47572.0, 54453.1832022512, 61765.691171543855, 70877.64561177162, 71715.20711982241, 78639.60680196562, 80017.0, 6460.321666224979, 6835.965820171066, 8159.755207343552, 8274.0, 8310.958445207978, 10434.478276086316, 10648.733781655521, 10792.460376981277, 11088.833667494833, 13055.738885222432, 9364.518402623175, 9943.850842237516, 10181.898181018096, 11164.832527511931, 11243.10055195566, 9640.71077867665, 9926.858411282506, 10899.727506812393, 10994.505247263733, 11055.949684779933, 9106.95446522763, 9704.417734935927, 10834.241603087708, 11147.83278250843, 11294.774104517699, 7021.262767409348, 7361.1166660001145, 7458.291462311072, 7602.239776022354, 7655.349295309738, 10031.899681003097, 11249.212555121063, 11348.319100853645, 11355.772884542428, 11433.1996760226], "value": 9170.4945277208, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1580.905145691259, 1617.5309160343502, 1843.7142242952339, 1916.3675986924325, 1959.4905324615613, 8191.344692424606, 8615.31077513799, 8750.431221970575, 9308.8603670945, 9314.161725444708, 8541.402101852873, 8680.262177714902, 8687.56562171892, 8773.912260877389, 8824.735257942257, 2369.786719195272, 2426.8301218914685, 2429.259075981825, 2429.963550546743, 2432.1973748662986, 2041.9489512762152, 2348.9647655285185, 2380.0, 2384.546936082139, 2439.7072351317865, 2017.3040301096098, 2402.8077753779658, 2412.553677569655, 2428.0530593068715, 2434.221049264236, 2368.7631236876346, 2385.4751954569965, 2395.101836811196, 2405.0, 2411.9397015074587, 2389.749076346976, 2393.1743548475747, 2394.7246066702205, 2405.458771776336, 2406.7713567211085, 8883.067277935788, 8928.196462318358, 9009.954950225272, 9023.187913087788, 9063.0, 4703.988642441857, 5219.947800521984, 5452.345718513764, 5499.285092937933, 5504.972475137639, 3653.0, 3688.870889518854, 3762.247550489913, 3785.356489396809, 3786.0, 1035.7100011996654, 1054.2725519391672, 1074.4090750087498, 1084.9891501084967, 1086.7717779266363, 11592.652220433316, 11653.126015548867, 11692.649220523397, 11830.349330786803, 11939.34333611651, 4732.905341893143, 4740.478547359788, 4850.514948505192, 4866.099771542276, 4868.367112275452, 10245.334053286513, 10302.742431439125, 10310.175185985103, 10313.535890884928, 10325.225608079425, 5324.840254792362, 5358.6248962572245, 5412.052890744104, 5419.132938729785, 5422.783088676409, 4452.287633978548, 4812.639052071108, 4930.704157750546, 4935.087008903364, 4977.800887964513, 4101.323281658493, 4102.774347410921, 4129.91138772613, 4167.999680076759, 4169.0411205422315, 1316.1116246533552, 1333.9866601333863, 1341.530464337474, 1346.750851092551, 1351.189286428155, 937.9588656591178, 941.6562954521551, 961.5288508630861, 985.014985014985, 1013.7871047080048, 6049.3950604939155, 6069.484093852072, 6072.635641861502, 6073.696315184223, 6169.56813023084, 457.1588277569289, 462.61140641861, 467.18243074619414, 1026.810040142576, 1066.8613080299667, 3832.6358995895343, 4111.239420707178, 4138.606832350922, 4213.325867861189, 4256.29771087767, 10365.533550990223, 10665.893341066645, 10763.83854242187, 10798.352098873935, 10827.025567698787, 10618.575256989634, 10709.625163119254, 10725.570977160825, 10759.78480430387, 10817.729556761144, 8349.791255218668, 8442.366822488339, 8455.112213217524, 8508.361872859561, 8510.914890851012, 5839.416058394297, 5968.880622387441, 6117.900468191327, 6142.692865356804, 6180.412860778219, 9817.263705221994, 10021.999999999709, 10062.245331600014, 10349.430781307101, 10377.014183652542, 10314.349704047316, 10474.581016759244, 10493.317934334244, 10500.684979450629, 10534.262601617813, 6592.736290548324, 6943.201531823905, 7083.6541057198965, 7157.1769246537315, 7246.202917679157, 8415.3267738582, 8469.068402475847, 8500.957495212484, 8548.615312310836, 8566.400351975302, 6463.515236357386, 6609.966950165219, 6762.985552167018, 7021.543599666005, 7445.888311675221, 5632.493075623213, 6291.937080629318, 7369.705211791683, 7447.962760186165, 7549.622518874145, 5687.459691329317, 6929.653517324215, 7126.180489243596, 7152.463565232524, 7179.784606461814, 5079.746012699424, 5110.795568177231, 5122.00120976406, 5137.5889928806355, 5220.530152286313, 5080.46655101209, 5130.51260130287, 5151.793928242828, 5284.682919024871, 5298.099323115002], "value": 4623.754322295988, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.2878806774249, 317.66169029983075, 321.8390804597701, 322.9208843833258, 325.9348130373926, 4895.485973972726, 5487.807926722566, 5661.405552416999, 5684.289463817023, 5768.653880767151, 4795.544423279792, 5082.03441346144, 5180.6891586504835, 5464.3442786865535, 5647.322321321447, 4073.755574665515, 4207.263728847454, 4263.829446822124, 4277.871663850089, 4282.314829627245, 3774.131949651568, 3949.3286141355893, 4261.914761704764, 4280.678949078816, 4307.935380969288, 4178.853740119096, 4201.873943781691, 4205.243056249874, 4210.642095421893, 4218.873433796991, 4049.5950404959417, 4243.469566304212, 4254.680898932593, 4254.723442976212, 4264.573542645741, 3250.9187270318193, 3642.2715456908722, 3658.8412836426637, 3670.632936706308, 3671.375866102769, 4907.294992280805, 5051.0, 5412.783488660488, 5420.186971954199, 5464.836054918359, 4107.993541582302, 4294.763787991659, 4666.416697912761, 4795.832145874912, 4855.441624213226, 4728.4562275338085, 5744.540436765049, 5942.762289508414, 5959.255093113361, 5984.700764961734, 3723.119824488616, 3992.461017762594, 4006.939895901564, 4010.819513121887, 4022.6379625833815, 5127.282180494696, 5286.894262114736, 6227.844303892393, 6284.962981108111, 6346.3662580029695, 4039.1719697462536, 4048.4129801178665, 4049.036217434542, 4049.5950404959267, 4055.4322394864744, 3782.7730336179366, 4037.5154981401834, 4081.9795901020307, 4083.8774836754947, 4129.752214867118, 4038.1519880825354, 4419.955800442019, 4833.492483289274, 4835.960268542281, 4882.8779280517565, 5272.710000949908, 5726.255586773693, 5977.491913187341, 6035.758569657252, 6061.363556826558, 1248.525560287085, 1346.4986540007822, 1358.8573199814075, 1395.427874571421, 1399.6221020324658, 728.8287252495659, 799.6281728996045, 807.8788181772782, 821.9287395762764, 850.6554845287668, 3913.5715463855486, 4406.427164468599, 4702.952970470252, 4744.644151688637, 4787.755183652275, 4774.0, 4929.309896614477, 5009.323741294951, 5256.395514515803, 5263.499967503081, 4080.571539988318, 4513.533101741947, 4702.482726900038, 4728.203282752532, 4791.329213910055, 2530.025940013108, 2932.9001624390853, 3202.087405089585, 3246.951295730566, 3267.2485328374605, 5949.137375080589, 6023.457888789942, 6132.938670613236, 6181.690915454209, 6554.541182117301, 6134.0, 6355.904661430082, 6360.7137678804565, 6400.583962042452, 6421.550491465646, 6470.741170353227, 6482.57863238888, 6492.707828147744, 6533.216014078246, 6533.444657204001, 5275.182346736262, 5788.305403351456, 6109.869674110304, 6135.576447303201, 6215.720292586935, 5235.65968212065, 5915.615484993462, 6024.518038556993, 6075.696215189135, 6132.264128304632, 6005.249343832021, 6195.473384762346, 6460.515461340325, 6479.967600162157, 6484.773032943825, 3377.5102610121885, 3774.50931378919, 4015.257177422186, 4042.029912820961, 4053.6757059435763, 5486.561075113901, 5891.1457838614015, 6104.4200800923845, 6137.508999280136, 6187.195664563578, 5302.39022512416, 5600.411956744483, 5836.912446313224, 5921.733521991607, 6035.637861728311, 5572.690417751744, 5930.703464826827, 5976.342602313655, 5984.611000284967, 6033.276006879202, 5671.120976248688, 5689.805140920453, 5853.853653658693, 5863.20846685692, 5863.706814659336, 5132.717700526507, 5724.227229323988, 5970.208937318874, 6025.909611355745, 6029.3669164737075, 4885.5358740919555, 5493.258410114743, 5529.474699903502, 5571.442855714558, 5893.675847828411], "value": 4236.948727655281, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [609.9634021958683, 613.3590398034054, 682.8258794007526, 787.342568954923, 799.1209669363705, 14594.927025364872, 15134.621634459145, 15252.084874907514, 15303.923480382611, 15339.923300383496, 13758.587242382719, 13790.65523361914, 13876.93061534691, 13882.652933676663, 14019.859801401983, 878.3544095090103, 890.4301247201764, 901.0268909577641, 903.0743487924864, 905.8324210021167, 702.785650376635, 862.4825104937019, 882.7395918204113, 891.6121487153076, 894.2532984957568, 935.6631612619485, 936.8688383626297, 937.6999360204737, 938.8497840345547, 941.2281928818337, 895.0825403960927, 912.2792993535099, 928.475411392561, 937.9155875971161, 940.031767279703, 687.9920915858241, 691.1257259566652, 698.7763915547027, 699.2098928211088, 701.1586096684, 14550.272486375745, 14637.41450341985, 14668.486602968951, 14671.77992330116, 14685.0, 13916.721665566733, 13921.651958701113, 13963.441462341494, 14032.92983535086, 14222.288885555681, 11704.0, 11719.0, 11733.647990560297, 11871.940640296829, 12054.457549410297, 3281.9343613127603, 3883.184531248441, 3914.275858966072, 4009.7794621296107, 4023.517177938637, 66253.0, 67624.98562521616, 69139.3086069138, 74801.50396992084, 76723.6163819183, 8097.109317975018, 9745.269104817167, 10556.841647375295, 10649.094826939641, 10707.625233116803, 19703.704444433344, 20077.799222007885, 20265.29071482491, 20285.0, 20340.288089917078, 7635.618219089023, 7723.729669461542, 7767.067951845815, 7768.92231077682, 7873.5275883447175, 4461.910761784746, 4497.955020449819, 4529.252673308933, 4530.796114174804, 4538.410006699174, 3381.408253555618, 3386.305807309496, 3467.150548115728, 3477.3393055319916, 3477.7391695622423, 661.781612068026, 667.0594461808827, 674.1270055278426, 674.8076798112514, 678.7013713965839, 592.3247497852452, 638.543441439373, 651.7099890548756, 661.6096503063216, 676.9120014398097, 8941.865872011926, 8973.955130224438, 8990.910090899008, 9043.547822608974, 9242.445453272825, 566.7251383079204, 585.645684360964, 587.5358466811172, 644.3846126948753, 654.7904670505393, 4219.852305169305, 4278.572142785696, 4296.720713153635, 4336.718113322624, 4666.556677115668, 97898.0, 98109.0, 98463.0, 99900.0, 100974.49512752536, 39629.81110566688, 42885.57114428816, 44965.10069798586, 84932.15067849366, 86652.56673716591, 57220.0, 72050.79492050858, 72949.0, 73404.0, 73635.0, 7948.0, 9699.66051188205, 9778.804423911624, 9783.0706082922, 9818.705438836847, 31395.529067063555, 45491.94463467118, 45945.31082033839, 45971.540284596726, 47867.0, 60380.09429858644, 61693.69153154385, 62673.0, 63293.36706632875, 63383.68308158614, 12778.936105319413, 12826.23042617446, 12881.613551593467, 12956.481740730265, 13120.343982801012, 13966.162030278216, 13996.230207338695, 14153.292335382983, 14159.36282867294, 14849.331780069706, 12893.226406415644, 13188.80216796768, 13475.73048539004, 13500.257485838372, 13651.522196723066, 10957.0, 13222.933885330896, 13285.933570332472, 13291.734165316446, 13330.333483325989, 13218.0, 13254.602361929157, 13304.201747895157, 13305.667358315732, 13726.656833578842, 11037.503312350804, 11191.552337906392, 11298.209125361474, 11845.348505831917, 11855.881441185822, 10933.405080067374, 11347.319160850375, 11365.431728413712, 11481.885181148416, 11529.884701152881], "value": 7171.467465231926, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1568.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 157.0, 157.0, 117.0, 117.0, 116.0, 114.0, 114.0, 117.0, 117.0], "value": 126.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 120.0, 150.0, 173.0, 109.0, 136.0, 155.0, 146.0, 198.0, 146.0], "value": 148.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [203.0, 200.0, 223.0, 260.0, 198.0, 195.0, 194.0, 200.0, 189.0, 161.0], "value": 202.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 77.0, 75.0, 137.0, 58.0, 57.0, 59.0, 64.0, 128.0, 58.0], "value": 77.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 113.0, 72.0, 72.0, 91.0, 113.0, 83.0, 102.0, 113.0], "value": 89.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 132.0, 89.0, 86.0, 90.0, 74.0, 136.0, 86.0, 136.0, 120.0], "value": 103.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 104.0, 143.0, 96.0, 105.0, 128.0, 95.0, 100.0], "value": 106.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 96.0, 94.0, 92.0, 122.0, 140.0, 116.0, 91.0, 93.0, 92.0], "value": 102.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 55.0, 58.0, 55.0, 60.0, 58.0, 55.0, 57.0, 57.0], "value": 57.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 74.0, 72.0, 77.0, 73.0, 72.0, 69.0, 70.0, 71.0], "value": 71.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 95.0, 89.0, 84.0, 88.0, 92.0, 79.0, 88.0, 115.0, 87.0], "value": 90.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 139.0, 139.0, 158.0, 148.0, 149.0, 138.0, 140.0, 164.0, 142.0], "value": 145.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 166.0, 175.0, 159.0, 175.0, 161.0, 225.0, 171.0, 165.0], "value": 172.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 81.0, 85.0, 61.0, 59.0, 57.0, 70.0, 80.0, 84.0, 83.0], "value": 73.5, "unit": "score"}]}]} 11:15:19 INFO - Return code: 0 11:15:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:15:19 ERROR - # TBPL SUCCESS # 11:15:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:15:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:15:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:15:19 INFO - 2016-05-31 11:15:19.577 screenresolution[1683:11003] starting screenresolution argv=screenresolution get 11:15:19 INFO - 2016-05-31 11:15:19.580 screenresolution[1683:11003] Display 0: 1600x1200x32@60 11:15:19 INFO - 2016-05-31 11:15:19.586 screenresolution[1684:11006] starting screenresolution argv=screenresolution list 11:15:19 INFO - Available Modes on Display 0 11:15:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:15:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:15:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:15:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:15:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:15:19 INFO - Intel Iris: 11:15:19 INFO - Chipset Model: Intel Iris 11:15:19 INFO - Type: GPU 11:15:19 INFO - Bus: Built-In 11:15:19 INFO - VRAM (Dynamic, Max): 1536 MB 11:15:19 INFO - Vendor: Intel (0x8086) 11:15:19 INFO - Device ID: 0x0a2e 11:15:19 INFO - Revision ID: 0x0009 11:15:19 INFO - Displays: 11:15:19 INFO - Display: 11:15:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:15:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:15:19 INFO - Display Serial Number: 1600x1200 60 11:15:19 INFO - Main Display: Yes 11:15:19 INFO - Mirror: Off 11:15:19 INFO - Online: Yes 11:15:19 INFO - Rotation: Supported 11:15:19 INFO - Return code: 0 11:15:19 INFO - Running post-action listener: _resource_record_post_action 11:15:19 INFO - ##### 11:15:19 INFO - ##### Finished run-tests step (success) 11:15:19 INFO - ##### 11:15:19 INFO - Running post-run listener: _resource_record_post_run 11:15:19 INFO - Total resource usage - Wall time: 1207s; CPU: 55.0%; Read bytes: 32894464; Write bytes: 699164160; Read time: 325; Write time: 1991 11:15:19 INFO - TinderboxPrint: CPU usage
54.7% 11:15:19 INFO - TinderboxPrint: I/O read bytes / time
32,894,464 / 325 11:15:19 INFO - TinderboxPrint: I/O write bytes / time
699,164,160 / 1,991 11:15:19 INFO - TinderboxPrint: CPU idle
2,186.7 (45.3%) 11:15:19 INFO - TinderboxPrint: CPU system
975.2 (20.2%) 11:15:19 INFO - TinderboxPrint: CPU user
1,667.8 (34.5%) 11:15:19 INFO - TinderboxPrint: Swap in / out
428,150,784 / 0 11:15:19 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 382669312; Write bytes: 376547328; Read time: 28220; Write time: 719 11:15:19 INFO - run-tests - Wall time: 1175s; CPU: 55.0%; Read bytes: 31972864; Write bytes: 297512448; Read time: 310; Write time: 1226 11:15:20 INFO - Running post-run listener: _upload_blobber_files 11:15:20 INFO - Blob upload gear active. 11:15:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:15:20 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:15:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:15:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:15:20 INFO - (blobuploader) - INFO - Open directory for files ... 11:15:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:15:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:15:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:15:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:15:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:15:21 INFO - (blobuploader) - INFO - Done attempting. 11:15:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:15:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:15:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:15:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:15:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:15:22 INFO - (blobuploader) - INFO - Done attempting. 11:15:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:15:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:15:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:15:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:15:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:15:25 INFO - (blobuploader) - INFO - Done attempting. 11:15:25 INFO - (blobuploader) - INFO - Iteration through files over. 11:15:25 INFO - Return code: 0 11:15:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:15:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:15:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9066b222129c2e474cced87b22f5d54e643f640285fddc9a9f87890e23e39601175b768273816df4bed5fa0368ccad1260058f6b8d490c009d850a27e6200911", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c70623247da4c40b76ebd44ee872752176846e9de49c752b5c2b826ef9a6a0964305a3c51724c60b433eee73d9c2a89118a621ab17fe088a7a6ac390ee002023", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6e40116c0294aa012e7890ccd38eec4844548e24926c15897a46fb5b38656f1f94fbef8a2508cb69c7797abf6716f05196ea11a1893cbc96f65884d3a05188f2"} 11:15:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:15:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:15:25 INFO - Contents: 11:15:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9066b222129c2e474cced87b22f5d54e643f640285fddc9a9f87890e23e39601175b768273816df4bed5fa0368ccad1260058f6b8d490c009d850a27e6200911", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c70623247da4c40b76ebd44ee872752176846e9de49c752b5c2b826ef9a6a0964305a3c51724c60b433eee73d9c2a89118a621ab17fe088a7a6ac390ee002023", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6e40116c0294aa012e7890ccd38eec4844548e24926c15897a46fb5b38656f1f94fbef8a2508cb69c7797abf6716f05196ea11a1893cbc96f65884d3a05188f2"} 11:15:25 INFO - Running post-run listener: copy_logs_to_upload_dir 11:15:25 INFO - Copying logs to upload dir... 11:15:25 INFO - mkdir: /builds/slave/test/build/upload/logs 11:15:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1333.763691 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 13 secs) (at 2016-05-31 11:15:25.544796) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-31 11:15:25.548055) ========= 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.moExLqicrW/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.IEoC63XdkJ/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9066b222129c2e474cced87b22f5d54e643f640285fddc9a9f87890e23e39601175b768273816df4bed5fa0368ccad1260058f6b8d490c009d850a27e6200911", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c70623247da4c40b76ebd44ee872752176846e9de49c752b5c2b826ef9a6a0964305a3c51724c60b433eee73d9c2a89118a621ab17fe088a7a6ac390ee002023", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6e40116c0294aa012e7890ccd38eec4844548e24926c15897a46fb5b38656f1f94fbef8a2508cb69c7797abf6716f05196ea11a1893cbc96f65884d3a05188f2"} build_url:https://queue.taskcluster.net/v1/task/BwEkG5PrRji6Z4ow8xcquQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010555 build_url: 'https://queue.taskcluster.net/v1/task/BwEkG5PrRji6Z4ow8xcquQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9066b222129c2e474cced87b22f5d54e643f640285fddc9a9f87890e23e39601175b768273816df4bed5fa0368ccad1260058f6b8d490c009d850a27e6200911", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c70623247da4c40b76ebd44ee872752176846e9de49c752b5c2b826ef9a6a0964305a3c51724c60b433eee73d9c2a89118a621ab17fe088a7a6ac390ee002023", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6e40116c0294aa012e7890ccd38eec4844548e24926c15897a46fb5b38656f1f94fbef8a2508cb69c7797abf6716f05196ea11a1893cbc96f65884d3a05188f2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-31 11:15:25.578365) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 11:15:25.578747) ========= 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.moExLqicrW/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.IEoC63XdkJ/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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.005143 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 11:15:25.627595) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-31 11:15:25.627939) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-31 11:15:25.628334) ========= ========= Total master_lag: 0.21 =========