builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0284 starttime: 1464357228.4 results: success (0) buildid: 20160527044247 builduid: c5fc669c6c944780955deef0b61c414d revision: 08053d1e2cc1f3b6e6901e4aedaf122c4e1de27b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 06:53:48.403993) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 06:53:48.404392) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 06:53:48.404691) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 06:53:48.492970) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 06:53:48.493311) ========= 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.kzeXQmkHmQ/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.n4APxajmty/Listeners TMPDIR=/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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-27 06:53:48-- 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% 8.44M=0.001s 2016-05-27 06:53:48 (8.44 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.137833 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 06:53:48.651379) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 06:53:48.651680) ========= 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.kzeXQmkHmQ/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.n4APxajmty/Listeners TMPDIR=/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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.020142 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 06:53:48.700015) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 06:53:48.700580) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 08053d1e2cc1f3b6e6901e4aedaf122c4e1de27b --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 08053d1e2cc1f3b6e6901e4aedaf122c4e1de27b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kzeXQmkHmQ/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.n4APxajmty/Listeners TMPDIR=/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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-27 06:53:48,780 truncating revision to first 12 chars 2016-05-27 06:53:48,780 Setting DEBUG logging. 2016-05-27 06:53:48,780 attempt 1/10 2016-05-27 06:53:48,781 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/08053d1e2cc1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-27 06:53:49,428 unpacking tar archive at: fx-team-08053d1e2cc1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.916766 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 06:53:49.637258) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 06:53:49.640600) ========= script_repo_revision: 08053d1e2cc1f3b6e6901e4aedaf122c4e1de27b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 06:53:49.641002) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 06:53:49.641297) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 06:53:49.658425) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 44 secs) (at 2016-05-27 06:53:49.658811) ========= /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.kzeXQmkHmQ/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.n4APxajmty/Listeners TMPDIR=/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 06:53:49 INFO - MultiFileLogger online at 20160527 06:53:49 in /builds/slave/test 06:53:49 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 06:53:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:53:49 INFO - {'append_to_log': False, 06:53:49 INFO - 'base_work_dir': '/builds/slave/test', 06:53:49 INFO - 'blob_upload_branch': 'Fx-Team', 06:53:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:53:49 INFO - 'branch': 'Fx-Team', 06:53:49 INFO - 'buildbot_json_path': 'buildprops.json', 06:53:49 INFO - 'config_files': ('talos/mac_config.py',), 06:53:49 INFO - 'default_actions': ('clobber', 06:53:49 INFO - 'read-buildbot-config', 06:53:49 INFO - 'download-and-extract', 06:53:49 INFO - 'populate-webroot', 06:53:49 INFO - 'create-virtualenv', 06:53:49 INFO - 'install', 06:53:49 INFO - 'run-tests'), 06:53:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:53:49 INFO - 'download_minidump_stackwalk': True, 06:53:49 INFO - 'download_symbols': 'ondemand', 06:53:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:53:49 INFO - 'tooltool.py': '/tools/tooltool.py', 06:53:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:53:49 INFO - '/tools/misc-python/virtualenv.py')}, 06:53:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:53:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:53:49 INFO - 'installer_path': 'installer.exe', 06:53:49 INFO - 'log_level': 'info', 06:53:49 INFO - 'log_name': 'talos', 06:53:49 INFO - 'log_to_console': True, 06:53:49 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:53:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:53:49 INFO - 'opt_config_files': (), 06:53:49 INFO - 'pip_index': False, 06:53:49 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:53:49 INFO - 'cmd': ('bash', 06:53:49 INFO - '-c', 06:53:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:53:49 INFO - 'enabled': True, 06:53:49 INFO - 'halt_on_failure': False, 06:53:49 INFO - 'name': 'check_screen_resolution'},), 06:53:49 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:53:49 INFO - 'cmd': ('bash', 06:53:49 INFO - '-c', 06:53:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:53:49 INFO - 'enabled': True, 06:53:49 INFO - 'halt_on_failure': False, 06:53:49 INFO - 'name': 'check_screen_resolution'},), 06:53:49 INFO - 'run_cmd_checks_enabled': True, 06:53:49 INFO - 'sps_profile': False, 06:53:49 INFO - 'sps_profile_interval': 0, 06:53:49 INFO - 'suite': 'dromaeojs-e10s', 06:53:49 INFO - 'system_bits': '32', 06:53:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:53:49 INFO - 'title': 't-yosemite-r7-0284', 06:53:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:53:49 INFO - 'use_talos_json': True, 06:53:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:53:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:53:49 INFO - 'work_dir': 'build'} 06:53:49 INFO - ##### 06:53:49 INFO - ##### Running clobber step. 06:53:49 INFO - ##### 06:53:49 INFO - Running pre-action listener: _resource_record_pre_action 06:53:49 INFO - Running main action method: clobber 06:53:49 INFO - rmtree: /builds/slave/test/build 06:53:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:53:50 INFO - Running post-action listener: _resource_record_post_action 06:53:50 INFO - ##### 06:53:50 INFO - ##### Finished clobber step (success) 06:53:50 INFO - ##### 06:53:50 INFO - ##### 06:53:50 INFO - ##### Running read-buildbot-config step. 06:53:50 INFO - ##### 06:53:50 INFO - Running pre-action listener: _resource_record_pre_action 06:53:50 INFO - Running main action method: read_buildbot_config 06:53:50 INFO - Using buildbot properties: 06:53:50 INFO - { 06:53:50 INFO - "project": "", 06:53:50 INFO - "product": "firefox", 06:53:50 INFO - "script_repo_revision": "production", 06:53:50 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 06:53:50 INFO - "repository": "", 06:53:50 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 06:53:50 INFO - "buildid": "20160527044247", 06:53:50 INFO - "pgo_build": "False", 06:53:50 INFO - "basedir": "/builds/slave/test", 06:53:50 INFO - "buildnumber": 681, 06:53:50 INFO - "slavename": "t-yosemite-r7-0284", 06:53:50 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 06:53:50 INFO - "platform": "yosemite_r7", 06:53:50 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 06:53:50 INFO - "branch": "fx-team", 06:53:50 INFO - "repo_path": "integration/fx-team", 06:53:50 INFO - "revision": "08053d1e2cc1f3b6e6901e4aedaf122c4e1de27b", 06:53:50 INFO - "stage_platform": "macosx64", 06:53:50 INFO - "builduid": "c5fc669c6c944780955deef0b61c414d", 06:53:50 INFO - "slavebuilddir": "test" 06:53:50 INFO - } 06:53:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/MjZG5n8jTRylns8g3OlsCw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 06:53:50 INFO - Running post-action listener: _resource_record_post_action 06:53:50 INFO - ##### 06:53:50 INFO - ##### Finished read-buildbot-config step (success) 06:53:50 INFO - ##### 06:53:50 INFO - ##### 06:53:50 INFO - ##### Running download-and-extract step. 06:53:50 INFO - ##### 06:53:50 INFO - Running pre-action listener: _resource_record_pre_action 06:53:50 INFO - Running main action method: download_and_extract 06:53:50 INFO - mkdir: /builds/slave/test/build/tests 06:53:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:50 INFO - https://queue.taskcluster.net/v1/task/MjZG5n8jTRylns8g3OlsCw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 06:53:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjZG5n8jTRylns8g3OlsCw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 06:53:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjZG5n8jTRylns8g3OlsCw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 06:53:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjZG5n8jTRylns8g3OlsCw/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 06:53:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjZG5n8jTRylns8g3OlsCw/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 06:54:10 INFO - Downloaded 1199 bytes. 06:54:10 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 06:54:10 INFO - Using the following test package requirements: 06:54:10 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 06:54:10 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:54:10 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 06:54:10 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:54:10 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 06:54:10 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:54:10 INFO - u'jsshell-mac.zip'], 06:54:10 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:54:10 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 06:54:10 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 06:54:10 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:54:10 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 06:54:10 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:54:10 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 06:54:10 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:54:10 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 06:54:10 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:54:10 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 06:54:10 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:54:10 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')]} 06:54:10 INFO - https://queue.taskcluster.net/v1/task/MjZG5n8jTRylns8g3OlsCw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:54:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjZG5n8jTRylns8g3OlsCw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 06:54:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjZG5n8jTRylns8g3OlsCw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 06:54:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjZG5n8jTRylns8g3OlsCw/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 06:54:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjZG5n8jTRylns8g3OlsCw/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 06:54:16 INFO - Downloaded 18684722 bytes. 06:54:16 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'] 06:54:16 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 06:54:19 INFO - Return code: 0 06:54:19 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 06:54:19 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')]} 06:54:19 INFO - https://queue.taskcluster.net/v1/task/MjZG5n8jTRylns8g3OlsCw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:54:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjZG5n8jTRylns8g3OlsCw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 06:54:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjZG5n8jTRylns8g3OlsCw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 06:54:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjZG5n8jTRylns8g3OlsCw/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 06:54:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjZG5n8jTRylns8g3OlsCw/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 06:54:30 INFO - Downloaded 18684722 bytes. 06:54:30 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'] 06:54:30 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 06:54:33 INFO - Return code: 0 06:54:33 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')]} 06:54:33 INFO - https://queue.taskcluster.net/v1/task/MjZG5n8jTRylns8g3OlsCw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:54:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjZG5n8jTRylns8g3OlsCw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 06:54:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjZG5n8jTRylns8g3OlsCw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 06:54:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjZG5n8jTRylns8g3OlsCw/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 06:54:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjZG5n8jTRylns8g3OlsCw/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 06:54:34 INFO - Downloaded 10834034 bytes. 06:54:34 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'] 06:54:34 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 06:54:34 INFO - Return code: 0 06:54:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:34 INFO - https://queue.taskcluster.net/v1/task/MjZG5n8jTRylns8g3OlsCw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 06:54:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjZG5n8jTRylns8g3OlsCw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 06:54:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjZG5n8jTRylns8g3OlsCw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 06:54:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjZG5n8jTRylns8g3OlsCw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 06:54:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MjZG5n8jTRylns8g3OlsCw/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 06:54:44 INFO - Downloaded 110483454 bytes. 06:54:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MjZG5n8jTRylns8g3OlsCw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 06:54:44 INFO - mkdir: /builds/slave/test/properties 06:54:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:54:44 INFO - Writing to file /builds/slave/test/properties/build_url 06:54:44 INFO - Contents: 06:54:44 INFO - build_url:https://queue.taskcluster.net/v1/task/MjZG5n8jTRylns8g3OlsCw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 06:54:45 INFO - Running post-action listener: _resource_record_post_action 06:54:45 INFO - Running post-action listener: set_extra_try_arguments 06:54:45 INFO - ##### 06:54:45 INFO - ##### Finished download-and-extract step (success) 06:54:45 INFO - ##### 06:54:45 INFO - ##### 06:54:45 INFO - ##### Running populate-webroot step. 06:54:45 INFO - ##### 06:54:45 INFO - Running pre-action listener: _resource_record_pre_action 06:54:45 INFO - Running main action method: populate_webroot 06:54:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:54:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:54:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:54:45 INFO - '--tppagecycles', 06:54:45 INFO - '7'], 06:54:45 INFO - 'tests': ['tsvgm']}}, 06:54:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:54:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:54:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:54:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:54:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:54:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:54:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:45 INFO - 'talos_options': ['--disable-e10s'], 06:54:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:54:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:54:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:45 INFO - 'talos_options': ['--disable-e10s'], 06:54:45 INFO - 'tests': ['damp', 'tps']}, 06:54:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:45 INFO - 'tests': ['damp', 'tps']}, 06:54:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:54:45 INFO - 'tests': ['dromaeo_dom']}, 06:54:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:54:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:54:45 INFO - 'tests': ['a11yr', 06:54:45 INFO - 'ts_paint', 06:54:45 INFO - 'tpaint', 06:54:45 INFO - 'sessionrestore', 06:54:45 INFO - 'sessionrestore_no_auto_restore', 06:54:45 INFO - 'tabpaint']}, 06:54:45 INFO - 'other-e10s': {'tests': ['a11yr', 06:54:45 INFO - 'ts_paint', 06:54:45 INFO - 'tpaint', 06:54:45 INFO - 'sessionrestore', 06:54:45 INFO - 'sessionrestore_no_auto_restore', 06:54:45 INFO - 'tabpaint']}, 06:54:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:54:45 INFO - 'ts_paint', 06:54:45 INFO - 'tpaint', 06:54:45 INFO - 'sessionrestore', 06:54:45 INFO - 'sessionrestore_no_auto_restore', 06:54:45 INFO - 'tabpaint']}, 06:54:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:54:45 INFO - 'ts_paint', 06:54:45 INFO - 'tpaint', 06:54:45 INFO - 'sessionrestore', 06:54:45 INFO - 'sessionrestore_no_auto_restore', 06:54:45 INFO - 'tabpaint']}, 06:54:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:54:45 INFO - 'tests': ['a11yr', 06:54:45 INFO - 'ts_paint', 06:54:45 INFO - 'tpaint', 06:54:45 INFO - 'sessionrestore', 06:54:45 INFO - 'sessionrestore_no_auto_restore', 06:54:45 INFO - 'tabpaint']}, 06:54:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:54:45 INFO - 'tests': ['a11yr', 06:54:45 INFO - 'ts_paint', 06:54:45 INFO - 'tpaint', 06:54:45 INFO - 'sessionrestore', 06:54:45 INFO - 'sessionrestore_no_auto_restore', 06:54:45 INFO - 'tabpaint']}, 06:54:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:54:45 INFO - 'tests': ['tsvgx', 06:54:45 INFO - 'tsvgr_opacity', 06:54:45 INFO - 'tart', 06:54:45 INFO - 'tscrollx', 06:54:45 INFO - 'cart']}, 06:54:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:54:45 INFO - 'tsvgr_opacity', 06:54:45 INFO - 'tart', 06:54:45 INFO - 'tscrollx', 06:54:45 INFO - 'cart']}, 06:54:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:45 INFO - 'talos_options': ['--disable-e10s'], 06:54:45 INFO - 'tests': ['tp5o']}, 06:54:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:45 INFO - 'tests': ['tp5o']}, 06:54:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:45 INFO - 'talos_options': ['--disable-e10s', 06:54:45 INFO - '--xperf_path', 06:54:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:54:45 INFO - 'tests': ['tp5n']}, 06:54:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:45 INFO - 'talos_options': ['--xperf_path', 06:54:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:54:45 INFO - 'tests': ['tp5n']}}, 06:54:45 INFO - 'talos.zip': {'path': '', 06:54:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:54:45 INFO - Running post-action listener: _resource_record_post_action 06:54:45 INFO - ##### 06:54:45 INFO - ##### Finished populate-webroot step (success) 06:54:45 INFO - ##### 06:54:45 INFO - ##### 06:54:45 INFO - ##### Running create-virtualenv step. 06:54:45 INFO - ##### 06:54:45 INFO - Running pre-action listener: _resource_record_pre_action 06:54:45 INFO - Running main action method: create_virtualenv 06:54:45 INFO - Creating virtualenv /builds/slave/test/build/venv 06:54:45 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 06:54:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:54:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:54:45 INFO - Using real prefix '/tools/python27' 06:54:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:54:46 INFO - Installing distribute.............................................................................................................................................................................................done. 06:54:49 INFO - Installing pip.................done. 06:54:49 INFO - Return code: 0 06:54:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:54:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e40ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e414570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d78ce5ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2b2d30>, '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 0x10e0d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2a9b20>, '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.kzeXQmkHmQ/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.n4APxajmty/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 06:54:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:54:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:54:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kzeXQmkHmQ/Render', 06:54:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:54:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:54:49 INFO - 'HOME': '/Users/cltbld', 06:54:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:54:49 INFO - 'LOGNAME': 'cltbld', 06:54:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:49 INFO - 'MOZ_NO_REMOTE': '1', 06:54:49 INFO - 'NO_EM_RESTART': '1', 06:54:49 INFO - 'PAGER': '/bin/cat', 06:54:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:54:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:49 INFO - 'PWD': '/builds/slave/test', 06:54:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:54:49 INFO - 'SHELL': '/bin/bash', 06:54:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n4APxajmty/Listeners', 06:54:49 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 06:54:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:54:49 INFO - 'USER': 'cltbld', 06:54:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:54:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:54:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:49 INFO - 'XPC_FLAGS': '0x0', 06:54:49 INFO - 'XPC_SERVICE_NAME': '0', 06:54:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:54:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:49 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 06:54:49 INFO - Cleaning up... 06:54:49 INFO - Return code: 0 06:54:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:54:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e40ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e414570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d78ce5ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2b2d30>, '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 0x10e0d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2a9b20>, '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.kzeXQmkHmQ/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.n4APxajmty/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 06:54:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:54:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:54:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kzeXQmkHmQ/Render', 06:54:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:54:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:54:49 INFO - 'HOME': '/Users/cltbld', 06:54:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:54:49 INFO - 'LOGNAME': 'cltbld', 06:54:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:49 INFO - 'MOZ_NO_REMOTE': '1', 06:54:49 INFO - 'NO_EM_RESTART': '1', 06:54:49 INFO - 'PAGER': '/bin/cat', 06:54:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:54:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:49 INFO - 'PWD': '/builds/slave/test', 06:54:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:54:49 INFO - 'SHELL': '/bin/bash', 06:54:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n4APxajmty/Listeners', 06:54:49 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 06:54:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:54:49 INFO - 'USER': 'cltbld', 06:54:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:54:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:54:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:49 INFO - 'XPC_FLAGS': '0x0', 06:54:49 INFO - 'XPC_SERVICE_NAME': '0', 06:54:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:54:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:49 INFO - Downloading/unpacking psutil>=3.1.1 06: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 06: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 06: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 06: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 06: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 06: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 06:54:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:54:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:54:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:54:52 INFO - Installing collected packages: psutil 06:54:52 INFO - Running setup.py install for psutil 06:54:52 INFO - building 'psutil._psutil_osx' extension 06:54:52 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 06:54:52 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 06:54:52 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 06:54:52 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 06:54:52 INFO - building 'psutil._psutil_posix' extension 06:54:52 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 06:54:52 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:54:52 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:54:52 INFO - ^ 06:54:52 INFO - 1 warning generated. 06:54:52 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 06:54:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:54:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:54:53 INFO - Successfully installed psutil 06:54:53 INFO - Cleaning up... 06:54:53 INFO - Return code: 0 06:54:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06: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')]} 06:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06: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')]} 06:54:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:53 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 0x10e40ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e414570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d78ce5ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2b2d30>, '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 0x10e0d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2a9b20>, '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.kzeXQmkHmQ/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.n4APxajmty/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 06:54:53 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 06:54:53 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 06:54:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kzeXQmkHmQ/Render', 06:54:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:54:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:54:53 INFO - 'HOME': '/Users/cltbld', 06:54:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:54:53 INFO - 'LOGNAME': 'cltbld', 06:54:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:53 INFO - 'MOZ_NO_REMOTE': '1', 06:54:53 INFO - 'NO_EM_RESTART': '1', 06:54:53 INFO - 'PAGER': '/bin/cat', 06:54:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:54:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:53 INFO - 'PWD': '/builds/slave/test', 06:54:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:54:53 INFO - 'SHELL': '/bin/bash', 06:54:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n4APxajmty/Listeners', 06:54:53 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 06:54:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:54:53 INFO - 'USER': 'cltbld', 06:54:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:54:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:54:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:53 INFO - 'XPC_FLAGS': '0x0', 06:54:53 INFO - 'XPC_SERVICE_NAME': '0', 06:54:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:54:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:54:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:54:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:54:55 INFO - Installing collected packages: mozsystemmonitor 06:54:55 INFO - Running setup.py install for mozsystemmonitor 06:54:56 INFO - Successfully installed mozsystemmonitor 06:54:56 INFO - Cleaning up... 06:54:56 INFO - Return code: 0 06:54:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:54:56 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')]} 06:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:56 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')]} 06:54:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:56 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 0x10e40ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e414570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d78ce5ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2b2d30>, '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 0x10e0d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2a9b20>, '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.kzeXQmkHmQ/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.n4APxajmty/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 06:54:56 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 06:54:56 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 06:54:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kzeXQmkHmQ/Render', 06:54:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:54:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:54:56 INFO - 'HOME': '/Users/cltbld', 06:54:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:54:56 INFO - 'LOGNAME': 'cltbld', 06:54:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:56 INFO - 'MOZ_NO_REMOTE': '1', 06:54:56 INFO - 'NO_EM_RESTART': '1', 06:54:56 INFO - 'PAGER': '/bin/cat', 06:54:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:54:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:56 INFO - 'PWD': '/builds/slave/test', 06:54:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:54:56 INFO - 'SHELL': '/bin/bash', 06:54:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n4APxajmty/Listeners', 06:54:56 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 06:54:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:54:56 INFO - 'USER': 'cltbld', 06:54:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:54:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:54:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:56 INFO - 'XPC_FLAGS': '0x0', 06:54:56 INFO - 'XPC_SERVICE_NAME': '0', 06:54:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:54:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:56 INFO - Downloading/unpacking blobuploader==1.2.4 06:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:58 INFO - Downloading blobuploader-1.2.4.tar.gz 06:54:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:54:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:54:58 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 06:54:58 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 06:54:58 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 06:54:58 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 06:54:58 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 06:54:58 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 06:54:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:54:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:00 INFO - Downloading docopt-0.6.1.tar.gz 06:55:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:55:00 INFO - Installing collected packages: blobuploader, requests, docopt 06:55:00 INFO - Running setup.py install for blobuploader 06:55:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:55:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:55:00 INFO - Running setup.py install for requests 06:55:00 INFO - Running setup.py install for docopt 06:55:00 INFO - Successfully installed blobuploader requests docopt 06:55:00 INFO - Cleaning up... 06:55:01 INFO - Return code: 0 06:55:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:55:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:01 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 0x10e40ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e414570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d78ce5ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2b2d30>, '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 0x10e0d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2a9b20>, '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.kzeXQmkHmQ/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.n4APxajmty/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 06:55:01 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 06:55:01 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 06:55:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kzeXQmkHmQ/Render', 06:55:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:01 INFO - 'HOME': '/Users/cltbld', 06:55:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:01 INFO - 'LOGNAME': 'cltbld', 06:55:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:01 INFO - 'MOZ_NO_REMOTE': '1', 06:55:01 INFO - 'NO_EM_RESTART': '1', 06:55:01 INFO - 'PAGER': '/bin/cat', 06:55:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:01 INFO - 'PWD': '/builds/slave/test', 06:55:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:01 INFO - 'SHELL': '/bin/bash', 06:55:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n4APxajmty/Listeners', 06:55:01 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 06:55:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:01 INFO - 'USER': 'cltbld', 06:55:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:01 INFO - 'XPC_FLAGS': '0x0', 06:55:01 INFO - 'XPC_SERVICE_NAME': '0', 06:55:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:55:01 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-MUUwPk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:55:01 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-Eb9EvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:55:01 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-ucOrl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:55:01 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-OkrM6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:55:01 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-5WQ4Hz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:55:01 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-wqZSzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:55:01 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-D_8XUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:55:02 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-_Yh025-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:55:02 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-i_9tFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:55:02 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-N7LfJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:55:02 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-wChpDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:55:02 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-unRO6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:55:02 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-F2J2bQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:55:02 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-gHNoSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:55:02 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-pZMSpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:55:02 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-e5P3mR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:55:02 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-vfn3lx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:55:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:55:03 INFO - Running setup.py install for manifestparser 06:55:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:55:03 INFO - Running setup.py install for mozcrash 06:55:03 INFO - Running setup.py install for mozdebug 06:55:03 INFO - Running setup.py install for mozdevice 06:55:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:55:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:55:03 INFO - Running setup.py install for mozfile 06:55:03 INFO - Running setup.py install for mozhttpd 06:55:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:55:03 INFO - Running setup.py install for mozinfo 06:55:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:55:04 INFO - Running setup.py install for mozInstall 06:55:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:55:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:55:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:55:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:55:04 INFO - Running setup.py install for mozleak 06:55:04 INFO - Running setup.py install for mozlog 06:55:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:55:04 INFO - Running setup.py install for moznetwork 06:55:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:55:04 INFO - Running setup.py install for mozprocess 06:55:04 INFO - Running setup.py install for mozprofile 06:55:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:55:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:55:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:55:05 INFO - Running setup.py install for mozrunner 06:55:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:55:05 INFO - Running setup.py install for mozscreenshot 06:55:05 INFO - Running setup.py install for moztest 06:55:05 INFO - Running setup.py install for mozversion 06:55:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:55:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:55:05 INFO - Cleaning up... 06:55:05 INFO - Return code: 0 06:55:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:55:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:05 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 0x10e40ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e414570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d78ce5ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2b2d30>, '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 0x10e0d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2a9b20>, '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.kzeXQmkHmQ/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.n4APxajmty/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 06:55:05 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 06:55:05 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 06:55:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kzeXQmkHmQ/Render', 06:55:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:05 INFO - 'HOME': '/Users/cltbld', 06:55:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:05 INFO - 'LOGNAME': 'cltbld', 06:55:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:05 INFO - 'MOZ_NO_REMOTE': '1', 06:55:05 INFO - 'NO_EM_RESTART': '1', 06:55:05 INFO - 'PAGER': '/bin/cat', 06:55:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:05 INFO - 'PWD': '/builds/slave/test', 06:55:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:05 INFO - 'SHELL': '/bin/bash', 06:55:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n4APxajmty/Listeners', 06:55:05 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 06:55:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:05 INFO - 'USER': 'cltbld', 06:55:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:05 INFO - 'XPC_FLAGS': '0x0', 06:55:05 INFO - 'XPC_SERVICE_NAME': '0', 06:55:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:55:05 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-KSJL1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:55:06 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)) 06:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:55:06 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-pZ_1zJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:55:06 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)) 06:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:55:06 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-P6h_e_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:55:06 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)) 06:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:55:06 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-aYshr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:55:06 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)) 06:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:55:06 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-ZsEO_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:55:06 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)) 06:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:55:06 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-7pSRLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:55:06 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)) 06:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:55:06 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-RxHJX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:55:06 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)) 06:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:55:06 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-RGNNSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:55:06 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)) 06:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:55:06 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-Qefr8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:55:06 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)) 06:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:55:06 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-H68NB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:55:07 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)) 06:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:55:07 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-3WOL2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:55:07 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)) 06:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:55:07 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-LwgOZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:55:07 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)) 06:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:55:07 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-UMa5y7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:55:07 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)) 06:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:55:07 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-6Ecebs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:55:07 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)) 06:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:55:07 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-vE93jm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:55:07 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)) 06:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:55:07 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-IVT80R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:55:07 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)) 06:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:55:07 INFO - Running setup.py (path:/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/pip-3hd_Or-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:55:07 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)) 06:55:07 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)) 06:55:07 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)) 06:55:07 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)) 06:55:07 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)) 06:55:07 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)) 06:55:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06: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 06: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 06: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 06: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 06: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 06: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 06:55:10 INFO - Downloading blessings-1.6.tar.gz 06:55:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:55:10 INFO - Installing collected packages: blessings 06:55:10 INFO - Running setup.py install for blessings 06:55:10 INFO - Successfully installed blessings 06:55:10 INFO - Cleaning up... 06:55:10 INFO - Return code: 0 06:55:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:55:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:55:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:55:10 INFO - Reading from file tmpfile_stdout 06:55:10 INFO - Current package versions: 06:55:10 INFO - blessings == 1.6 06:55:10 INFO - blobuploader == 1.2.4 06:55:10 INFO - docopt == 0.6.1 06:55:10 INFO - manifestparser == 1.1 06:55:10 INFO - mozInstall == 1.12 06:55:10 INFO - mozcrash == 0.17 06:55:10 INFO - mozdebug == 0.1 06:55:10 INFO - mozdevice == 0.48 06:55:10 INFO - mozfile == 1.2 06:55:10 INFO - mozhttpd == 0.7 06:55:10 INFO - mozinfo == 0.9 06:55:10 INFO - mozleak == 0.1 06:55:10 INFO - mozlog == 3.2 06:55:10 INFO - moznetwork == 0.27 06:55:10 INFO - mozprocess == 0.22 06:55:10 INFO - mozprofile == 0.28 06:55:10 INFO - mozrunner == 6.11 06:55:10 INFO - mozscreenshot == 0.1 06:55:10 INFO - mozsystemmonitor == 0.3 06:55:10 INFO - moztest == 0.7 06:55:10 INFO - mozversion == 1.4 06:55:10 INFO - psutil == 3.1.1 06:55:10 INFO - requests == 1.2.3 06:55:10 INFO - wsgiref == 0.1.2 06:55:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:55:10 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')]} 06:55:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:10 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')]} 06:55:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:10 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 0x10e40ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e414570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d78ce5ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2b2d30>, '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 0x10e0d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2a9b20>, '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.kzeXQmkHmQ/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.n4APxajmty/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 06:55:10 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 06:55:10 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 06:55:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kzeXQmkHmQ/Render', 06:55:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:10 INFO - 'HOME': '/Users/cltbld', 06:55:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:10 INFO - 'LOGNAME': 'cltbld', 06:55:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:10 INFO - 'MOZ_NO_REMOTE': '1', 06:55:10 INFO - 'NO_EM_RESTART': '1', 06:55:10 INFO - 'PAGER': '/bin/cat', 06:55:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:10 INFO - 'PWD': '/builds/slave/test', 06:55:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:10 INFO - 'SHELL': '/bin/bash', 06:55:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n4APxajmty/Listeners', 06:55:10 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 06:55:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:10 INFO - 'USER': 'cltbld', 06:55:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:10 INFO - 'XPC_FLAGS': '0x0', 06:55:10 INFO - 'XPC_SERVICE_NAME': '0', 06:55:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:11 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)) 06:55:11 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)) 06:55:11 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)) 06:55:11 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)) 06:55:11 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)) 06:55:11 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)) 06:55:11 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)) 06:55:11 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)) 06:55:11 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)) 06:55:11 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)) 06:55:11 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)) 06:55:11 INFO - Cleaning up... 06:55:11 INFO - Return code: 0 06:55:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:55:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:11 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 0x10e40ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e414570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d78ce5ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2b2d30>, '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 0x10e0d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2a9b20>, '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.kzeXQmkHmQ/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.n4APxajmty/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 06:55:11 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 06:55:11 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 06:55:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kzeXQmkHmQ/Render', 06:55:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:11 INFO - 'HOME': '/Users/cltbld', 06:55:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:11 INFO - 'LOGNAME': 'cltbld', 06:55:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:11 INFO - 'MOZ_NO_REMOTE': '1', 06:55:11 INFO - 'NO_EM_RESTART': '1', 06:55:11 INFO - 'PAGER': '/bin/cat', 06:55:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:11 INFO - 'PWD': '/builds/slave/test', 06:55:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:11 INFO - 'SHELL': '/bin/bash', 06:55:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n4APxajmty/Listeners', 06:55:11 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 06:55:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:11 INFO - 'USER': 'cltbld', 06:55:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:11 INFO - 'XPC_FLAGS': '0x0', 06:55:11 INFO - 'XPC_SERVICE_NAME': '0', 06:55:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:11 INFO - Downloading/unpacking jsonschema 06:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:55:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:55:13 INFO - Downloading/unpacking functools32 (from jsonschema) 06:55:13 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 06:55:13 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 06:55:13 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 06:55:13 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 06:55:13 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 06:55:13 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 06:55:14 INFO - Downloading functools32-3.2.3-2.tar.gz 06:55:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:55:14 INFO - warning: no files found matching '*.txt' 06:55:14 INFO - no previously-included directories found matching 'build' 06:55:14 INFO - no previously-included directories found matching 'dist' 06:55:14 INFO - no previously-included directories found matching '.git*' 06:55:14 INFO - Installing collected packages: jsonschema, functools32 06:55:14 INFO - Running setup.py install for functools32 06:55:14 INFO - warning: no files found matching '*.txt' 06:55:14 INFO - no previously-included directories found matching 'build' 06:55:14 INFO - no previously-included directories found matching 'dist' 06:55:14 INFO - no previously-included directories found matching '.git*' 06:55:14 INFO - Successfully installed jsonschema functools32 06:55:14 INFO - Cleaning up... 06:55:14 INFO - Return code: 0 06:55:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:55:14 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')]} 06:55:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:14 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')]} 06:55:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:14 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 0x10e40ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e414570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d78ce5ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2b2d30>, '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 0x10e0d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2a9b20>, '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.kzeXQmkHmQ/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.n4APxajmty/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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 06:55:14 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 06:55:14 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 06:55:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kzeXQmkHmQ/Render', 06:55:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:14 INFO - 'HOME': '/Users/cltbld', 06:55:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:14 INFO - 'LOGNAME': 'cltbld', 06:55:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:14 INFO - 'MOZ_NO_REMOTE': '1', 06:55:14 INFO - 'NO_EM_RESTART': '1', 06:55:14 INFO - 'PAGER': '/bin/cat', 06:55:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:14 INFO - 'PWD': '/builds/slave/test', 06:55:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:14 INFO - 'SHELL': '/bin/bash', 06:55:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n4APxajmty/Listeners', 06:55:14 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 06:55:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:14 INFO - 'USER': 'cltbld', 06:55:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:14 INFO - 'XPC_FLAGS': '0x0', 06:55:14 INFO - 'XPC_SERVICE_NAME': '0', 06:55:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:14 INFO - Downloading/unpacking flake8 06:55:14 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 06:55:14 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 06:55:14 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 06:55:14 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 06:55:14 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 06:55:14 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 06:55:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:55:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:55:17 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 06:55:17 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 06:55:17 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 06:55:17 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 06:55:17 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 06:55:17 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 06:55:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:55:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:55:17 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 06:55:17 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 06:55:17 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 06:55:17 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 06:55:17 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 06:55:17 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 06:55:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:55:17 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 06:55:17 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 06:55:17 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 06:55:17 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 06:55:17 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 06:55:17 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 06:55:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:55:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:55:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:55:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:55:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:55:18 INFO - no previously-included directories found matching 'docs/_build' 06:55:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:55:18 INFO - Running setup.py install for pep8 06:55:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:55:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:55:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:55:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:55:18 INFO - no previously-included directories found matching 'docs/_build' 06:55:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:55:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:55:18 INFO - Cleaning up... 06:55:18 INFO - Return code: 0 06:55:18 INFO - Running post-action listener: _resource_record_post_action 06:55:18 INFO - Running post-action listener: _start_resource_monitoring 06:55:18 INFO - Starting resource monitoring. 06:55:18 INFO - ##### 06:55:18 INFO - ##### Finished create-virtualenv step (success) 06:55:18 INFO - ##### 06:55:18 INFO - ##### 06:55:18 INFO - ##### Running install step. 06:55:18 INFO - ##### 06:55:18 INFO - Running pre-action listener: _resource_record_pre_action 06:55:18 INFO - Running main action method: install 06:55:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:55:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:55:19 INFO - Reading from file tmpfile_stdout 06:55:19 INFO - Detecting whether we're running mozinstall >=1.0... 06:55:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:55:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:55:19 INFO - Reading from file tmpfile_stdout 06:55:19 INFO - Output received: 06:55:19 INFO - Usage: mozinstall [options] installer 06:55:19 INFO - Options: 06:55:19 INFO - -h, --help show this help message and exit 06:55:19 INFO - -d DEST, --destination=DEST 06:55:19 INFO - Directory to install application into. [default: 06:55:19 INFO - "/builds/slave/test"] 06:55:19 INFO - --app=APP Application being installed. [default: firefox] 06:55:19 INFO - mkdir: /builds/slave/test/build/application 06:55:19 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'] 06:55:19 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 06:55:53 INFO - Reading from file tmpfile_stdout 06:55:53 INFO - Output received: 06:55:53 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:55:53 INFO - Running post-action listener: _resource_record_post_action 06:55:53 INFO - ##### 06:55:53 INFO - ##### Finished install step (success) 06:55:53 INFO - ##### 06:55:53 INFO - ##### 06:55:53 INFO - ##### Running run-tests step. 06:55:53 INFO - ##### 06:55:53 INFO - Running pre-action listener: _resource_record_pre_action 06:55:53 INFO - Running main action method: run_tests 06:55:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:55:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:55:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:55:53 INFO - 2016-05-27 06:55:53.436 screenresolution[2277:25659] starting screenresolution argv=screenresolution get 06:55:53 INFO - 2016-05-27 06:55:53.438 screenresolution[2277:25659] Display 0: 1600x1200x32@60 06:55:53 INFO - 2016-05-27 06:55:53.444 screenresolution[2278:25661] starting screenresolution argv=screenresolution list 06:55:53 INFO - Available Modes on Display 0 06:55:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:55:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:55:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:55:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:55:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:55:53 INFO - Intel Iris: 06:55:53 INFO - Chipset Model: Intel Iris 06:55:53 INFO - Type: GPU 06:55:53 INFO - Bus: Built-In 06:55:53 INFO - VRAM (Dynamic, Max): 1536 MB 06:55:53 INFO - Vendor: Intel (0x8086) 06:55:53 INFO - Device ID: 0x0a2e 06:55:53 INFO - Revision ID: 0x0009 06:55:53 INFO - Displays: 06:55:53 INFO - Display: 06:55:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:55:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:55:53 INFO - Display Serial Number: 1600x1200 60 06:55:53 INFO - Main Display: Yes 06:55:53 INFO - Mirror: Off 06:55:53 INFO - Online: Yes 06:55:53 INFO - Rotation: Supported 06:55:53 INFO - Return code: 0 06:55:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:55:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:55:53 INFO - Python 2.7.3 06:55:53 INFO - Return code: 0 06:55:53 INFO - grabbing minidump binary from tooltool 06:55: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')]} 06:55:53 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 0x10e2b2d30>, '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 0x10e0d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2a9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:55:53 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 06:55:53 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 06:55:53 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 06:55:53 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:55:53 INFO - Return code: 0 06:55:53 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:55:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:55:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:55:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:55:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:55:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:55:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:55:54 INFO - Return code: 0 06:55:54 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/MjZG5n8jTRylns8g3OlsCw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0284', '--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 06:55:54 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/MjZG5n8jTRylns8g3OlsCw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0284 --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 06:55:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kzeXQmkHmQ/Render', 06:55:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:54 INFO - 'HOME': '/Users/cltbld', 06:55:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:54 INFO - 'LOGNAME': 'cltbld', 06:55:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:55:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:55:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:54 INFO - 'MOZ_NO_REMOTE': '1', 06:55:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:55:54 INFO - 'NO_EM_RESTART': '1', 06:55:54 INFO - 'PAGER': '/bin/cat', 06:55:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:54 INFO - 'PWD': '/builds/slave/test', 06:55:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:55:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:54 INFO - 'SHELL': '/bin/bash', 06:55:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n4APxajmty/Listeners', 06:55:54 INFO - 'TMPDIR': '/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/', 06:55:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:54 INFO - 'USER': 'cltbld', 06:55:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:54 INFO - 'XPC_FLAGS': '0x0', 06:55:54 INFO - 'XPC_SERVICE_NAME': '0', 06:55:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:54 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/MjZG5n8jTRylns8g3OlsCw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0284', '--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 06:55:55 INFO - mozversion application_buildid: 20160527044247 06:55:55 INFO - mozversion application_changeset: 08053d1e2cc1f3b6e6901e4aedaf122c4e1de27b 06:55:55 INFO - mozversion application_display_name: Nightly 06:55:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:55:55 INFO - mozversion application_name: Firefox 06:55:55 INFO - mozversion application_remotingname: firefox 06:55:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:55:55 INFO - mozversion application_vendor: Mozilla 06:55:55 INFO - mozversion application_version: 49.0a1 06:55:55 INFO - mozversion platform_buildid: 20160527044247 06:55:55 INFO - mozversion platform_changeset: 08053d1e2cc1f3b6e6901e4aedaf122c4e1de27b 06:55:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:55:55 INFO - mozversion platform_version: 49.0a1 06:55:55 INFO - using testdate: 1464357355 06:55:55 INFO - actual date: 1464357355 06:55:55 INFO - starting webserver on 'localhost:59212' 06:55:55 INFO - SUITE-START | Running 2 tests 06:55:55 INFO - TEST-START | dromaeo_css 06:55:55 INFO - operating with platform_type : mac_ 06:55:55 INFO - Initialising browser for dromaeo_css test... 06:55:55 INFO - TEST-INFO | started process 2296 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/tmpxASvGa/profile http://localhost:59212/getInfo.html) 06:55:58 INFO - PROCESS | 2296 | __metrics Screen width/height:1600/1200 06:55:58 INFO - PROCESS | 2296 | colorDepth:24 06:55:58 INFO - PROCESS | 2296 | Browser inner width/height: 1024/689 06:55:58 INFO - PROCESS | 2296 | __metrics 06:55:58 ERROR - PROCESS | 2296 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 06:55:58 INFO - TEST-INFO | 2296: exit 0 06:55:58 INFO - Browser initialized. 06:55:58 INFO - Running cycle 1/1 for dromaeo_css test... 06:55:58 INFO - TEST-INFO | started process 2299 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/tmpxASvGa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:56:10 INFO - PROCESS | 2299 | RSS: Main: 252387328 06:56:10 INFO - PROCESS | 2299 | 06:57:00 INFO - PROCESS | 2299 | 1464357420637 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] 06:59:11 INFO - PROCESS | 2299 | Cycle 1(1): loaded http://localhost:59212/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59212/tests/dromaeo/cssquery-ext.html) 06:59:13 INFO - PROCESS | 2299 | RSS: Main: 265019392 06:59:13 INFO - PROCESS | 2299 | 07:02:15 INFO - PROCESS | 2299 | Cycle 1(1): loaded http://localhost:59212/tests/dromaeo/cssquery-ext.html (next: http://localhost:59212/tests/dromaeo/cssquery-jquery.html) 07:02:16 INFO - PROCESS | 2299 | RSS: Main: 276021248 07:02:16 INFO - PROCESS | 2299 | 07:05:17 INFO - PROCESS | 2299 | Cycle 1(1): loaded http://localhost:59212/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59212/tests/dromaeo/cssquery-mootools.html) 07:05:18 INFO - PROCESS | 2299 | RSS: Main: 278081536 07:05:18 INFO - PROCESS | 2299 | 07:08:20 INFO - PROCESS | 2299 | Cycle 1(1): loaded http://localhost:59212/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59212/tests/dromaeo/cssquery-prototype.html) 07:08:20 INFO - PROCESS | 2299 | RSS: Main: 279678976 07:08:20 INFO - PROCESS | 2299 | 07:11:23 INFO - PROCESS | 2299 | Cycle 1(1): loaded http://localhost:59212/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59212/tests/dromaeo/cssquery-yui.html) 07:11:24 INFO - PROCESS | 2299 | RSS: Main: 283205632 07:11:24 INFO - PROCESS | 2299 | 07:14:27 INFO - PROCESS | 2299 | Cycle 1(1): loaded http://localhost:59212/tests/dromaeo/cssquery-yui.html (next: http://localhost:59212/tests/dromaeo/cssquery-dojo.html) 07:14:27 INFO - PROCESS | 2299 | RSS: Main: 283168768 07:14:27 INFO - PROCESS | 2299 | 07:14:27 INFO - PROCESS | 2299 | __start_tp_report 07:14:27 INFO - PROCESS | 2299 | _x_x_mozilla_page_load 07:14:27 INFO - PROCESS | 2299 | _x_x_mozilla_page_load_details 07:14:27 INFO - PROCESS | 2299 | |i|pagename|runs| 07:14:27 INFO - PROCESS | 2299 | |0;dojo.html;2887.3792134691043;3014.2012366722824;3462.948055779164;3464.2551851351955;3475.939838349304;5761.711914404279;5839.35767065623;5851.356350801414;5904.3800400957925;5919.556033297498;4744.549267819561;5663.093904975205;5857.6485410875375;5885.264341957255;5965.910511342333;5241.135212689911;5248.107821670306;5260.263563101169;5315.760790764405;5417.079096553575;5427.782888684448;5455.263539422167;5483.835484935458;5485.807996720116;5508.256385387981;5218.765155568009;5252.422233554306;5320.600954928396;5345.01117293302;5365.812196573121;5269.314989051399;5270.578353731692;5270.973645131749;5271.947280527184;5313.7608807603365;4281.464816897887;5228.346456692913;5261.1319132343115;5273.630845840793;5330.840074797762;5601.467860553282;5707.200991861143;5732.971335143339;5760.279965004374;5794.797182098607;5721.084626459747;5735.537437953295;6256;6256.15541901842;6272.247330320391;6283.088952101965;6286.245650521921;6286.497080233616;6297.968510157466;6300.464460520861;5820.30156381237;5908.231929849135;5914.408559144094;5937.198478205473;6038.365971573009;6326.778562750282;6331.746730130835;6336;6348.619082855043;6463.967680161569;6268.968655156787;6275.309715931244;6295.716692748837;6302.401271879165;6315.463185629181;6177.042558403455;6227.1282020517165;6240.438360547572;6268.62388256697;6271.96864015677;6152.415520525543;6191.226096737908;6210.192674952227;6218.626882387071;6272.6236425814595;5468.535174510132;6255.812325630147;6258.15514905491;6264.718087686065;6275.592086514362;4283.657307415399;4909.140900342426;4984.651074424755;5033.471485494044;5059.772310246048;3626.7642603230706;4437.933430998538;4516.277395616686;4525.615322697542;4548.431446069241;5163.251328557338;5986.132010858401;6061.212042434456;6061.333253342129;6085.96957015221;6175.44421002112;6197.907031394533;6221.3778622138325;6238.719257633417;6284.12022316876;5899.882002360015;6015.157877897098;6020.413760090922;6070.150178974947;6082.57421980466;5388.568914486832;5517;5555.833325000256;5569.693666848362;5571.582131340166;6351.110844481776;6386.457151142112;6420.550561460653;6479.6760161991715;6513;6265.8120256392385;6270.028145637433;6281.7173227203975;6282.2147231596055;6291.685415729286;6217.440430361289;6281.089242059785;6460;6470.902936456051;6482.254540727877;6104.236970378703;6113.694315284129;6160;6180.969095154495;6190.226221722285;6214.751409943732;6242.906356404748;6249.6562689052535;6249.937500624936;6263.718132683949;6115.453310713017;6118.663473509;6124.289394097845;6178.907316390348;6186.257649082139;6098.159935307505;6107.358727333743;6149.292831324455;6161.661108639068;6197.473214776614;5960.1357803117435;6071.038793531139;6118.558266176285;6134.803982731443;6135.84660383494;6119.380693981324;6170.259568851587;6212.534059945432;6220.222472190976;6247.656378899204;6041.093835924471;6151.138840562415;6178.227721534809;6195.2875419325555;6215.285242197025 07:14:27 INFO - PROCESS | 2299 | |1;ext.html;497.56463094792036;513.3121617033177;526.3736153976769;547.2857920413863;564.6414526775498;30753.846230768842;41567.376489352646;41649.16701665969;41870.581294187046;42000.57999420005;42824.57175428252;43206.35190472138;43543.56456435435;43545.34681979765;43554.12891742171;9397.248220142372;9646.083622055894;9646.469444180568;9659.903400966006;9687.51562421876;9487.193588544947;9535.237181025535;9597.952010239938;9601.327907046509;9611.615535378576;9512.524373781318;9563.665271715492;9596.088371604721;9612.711618651452;9614.56734446948;9541.2367010639;9557.713268601952;9564.90435095647;9570.52147392631;9593.328467007243;9458.810823783555;9476.099770521789;9502.572384242725;9525.666601668909;9550.188234000118;39894.601053989376;40201;40261.19477610431;40327;40330.19339613221;3630.6732394084397;3671.8714844980295;4179.707420480568;4218.114196018809;4378.8905277368;28305.72624231894;30907;32208.516872246935;32553.83723081393;32576.6742332576;3241.1897025743565;3382.780119292238;3388.2376465295356;3403.4384326586082;3408.659134086596;498627;508741.4562927199;508997;509222;511307;52646.47353526492;58028;63374;63493;63826.361736382045;55473;64305.67847160828;65753;66582.66708666425;66674;16524.917375413046;16712.83287167113;16781.748273775902;16784.825062245527;16791.2443940023;12902.354882256037;12958.28729419872;12995.025373097056;13006.609801705965;13029.218246905217;14432.061915975428;15149.62125946838;16928.83071169297;17288.308467661154;17414.65170696579;2844.2320573445054;7388.889166662504;7625.618719064136;7656.655450504741;7728.806779830436;930.3859452761145;1048.3238311289176;1106.7399161197113;1163.574621089176;1232.5254776910954;28802.279943001173;29281.56077658837;30443.69556304453;31021.68978310188;31227.68772312248;1048.9091345001266;1111.1777284809184;1148.6381789736206;1180.6753142885775;1238.6808049427332;15200.695986080216;16246.431374901822;17049.7442538362;17080.48758537246;17169.91415042917;575573;627987;631613;659034;661114.6944265248;58460.70769646124;58578.707106465044;60427.69786151129;60531.78936421247;60680.393196067474;1312.8293321868096;1364.8089267502558;1426.3082405033551;1428.792825040384;1450.7678771396527;30636.234094146934;31600.525992109677;31682.57428415773;31702;32302.030939071865;53047.20429193488;53449.73275133599;54056;54056.72971635117;54143.72928135334;514159;514674;514787.98242061347;515152;516143;26630.20109396721;27128.914843406044;27432.58851117195;27471.587926180724;27493;47185;48100.27849582329;48731.75634121807;48843.778905527644;49045.264321035924;39168.6083139165;39821.40267895926;40076.799616001736;40583;40646.79676601598;38300.23399531938;38526.6147338523;38878.22243555057;39213.41179882361;39253.80373098116;38339.42490862695;38605;39055.41416878692;39648.40527392034;39727.404088938114;28641;29035;30278.84860575771;35841.82079089588;36016;24435.75564244335;24542.509149817262;25177.87411062933;25882.61176082398;26172.8691356542 07:14:27 INFO - PROCESS | 2299 | |2;jquery.html;369.549150036955;382.3520626101502;384.15294276121153;398.5735263268304;408.85076946914387;18812.247510099598;20152.69770953437;20568.07443665035;20654.380368588947;20722.378328650146;11892.524299028028;12278.508859645603;12340.691482712937;12340.691482712937;20169;5368.865778355553;5549.916751248715;5563.248961390222;5570.192322113311;5578.135389014709;3850.249201405727;5798.652080875161;6042.879142417149;6138;6188.319284878659;6029.969850150765;6065.727042283108;6133;6168.321484636686;6170.969145154268;6143.047827586731;6145.170401995718;6145.508359331265;6157.96921015392;6163.753449862;5776.537876969875;5823.184754134425;5926.466618004357;6010.218671572711;6032.065029920369;12977.610671679864;13382.531611393555;13502.864971350258;13532.864671353358;13783.448662053506;2243.8317126215434;2251.898664560099;2429.7934675552424;2438.4635380216323;2572.597934125906;10144.594216231342;10367;12450.750984980341;15029.849701502955;15613.907026508148;1858.2659849359427;1896.781870084944;1920.9231630734753;1926.181372916519;1957.6084783043448;111161.44419277932;120150.39924800408;121035;126429.36785316106;128551.42897142099;9719.90280097204;11605.071594272438;11968.102392320438;12011;12162.027037836951;12437.502499900083;13631.454741810416;14827.555173344817;14880.479183228535;14904.850951490564;8635.740927772176;8695.260902823331;8747.956260218658;8753.431026983226;8795.780105497286;7239.20368759436;8563.400561960603;8626.353023523261;8781.560921953876;8782.253508451853;4503.639708823286;4547.977260113678;4623.127633308515;4626.126418800392;4710.3405523226775;1739.330357812226;3538.4515400113023;3620.9275814483562;3673.94489082664;3859.5947425520476;821.7124006597643;947.6020071569957;979.2068424576116;1031.5203430404897;1060.687097306281;20897.268595599082;21417.678734818677;21739.13043478243;21923.67114493284;22005;1055.767731099157;1058.899404556566;1061.7823346214007;1063.239783554762;1066.653337665262;9860.506974651382;11258.268212566158;11510.769784604428;11516.366599837089;11519.214521749142;505923;516706;516928;613511;616157;130664;133635;135835.32082339525;140210;142795;1022.7903279827617;1042.6976176908763;1058.957641694339;1101.0090918173548;1102.32207192576;19298.8070119297;19465;19556.21775128979;19615;19629.901850491227;54276.45723542714;54347;54697.90604187974;55135.44864551303;55419.722901385234;56783;76257;77480.61259693891;79454;80612;7905.881411778943;8044.718434854752;8100.432969692065;8135.983002124734;8306.377021723516;12123.571004425912;12692.873071269538;12750.936245318713;12914.096013279355;13101.213927164401;10634.946825265824;10905.781884362426;11091.500882460146;11142.665720028412;11283.435828208721;10835.512401941774;11116.666500005012;11171.888281117084;11217.831732524182;11285.830712539482;11277.041451476716;11292.943535282271;11349.602763903224;11594.88405115938;11619.941900290445;7268.781936541912;7957.806329050457;8154.796130096558;8160.224778646019;8222.424430290062;9328.615550691164;9644.614215431584;9747.3664211826;11297.039751621205;11317.830232546354 07:14:27 INFO - PROCESS | 2299 | |3;mootools.html;1416.270620630375;1526.9083854968699;1742.6166243426449;1896.165687097677;1913.1773337464901;8050.033995920498;8645.52449615271;8700.564971751412;9134.543272836356;9155.954220228898;8797.516136612483;8848.628462588293;8961.193492585682;9018.05310442404;9021.052789457095;2027.3816485971772;2083.427057559176;2362.5983582790923;2397.25685037638;2401.4716762312264;2352.752960939094;2366.396568874943;2396.2930935374106;2403.3751224681623;2403.411164264749;2372.359462945004;2375.0737212487143;2383.5709572276983;2395.532871090138;2396.0056576520724;2357.3399448154546;2358.6226203807396;2363.4327761337327;2377.6552399901916;2379.310000099969;2275.7838005389463;2293.289080385069;2293.736220334666;2295.5638428698494;2358.386819426961;8841.911580884173;8910.599023043913;8917.598708058153;8923.687670931551;8934.374593778439;5287.180487024479;5295.708736019517;5423.755930983115;5455.645383050129;5459.781608735646;3403.9829800851085;3449.223924616966;3636.654517820803;3697.4453831925157;3707.5550933888107;1034.270839058462;1064.8189807732704;1087.276960821053;1109.4508218431847;1110.9777804443866;11436.256643318158;11605.245659032136;11700.531978720841;11724.58963936258;11847.881521184763;4161.708680392343;4772.141014617402;4776.805798550363;4879.975600121977;4924.8276310328965;9886.950565247127;9955.153811925922;9976.05227503386;9980.952000040037;10006.299559030798;5203;5232.764525596357;5269.394019687708;5307.336582927134;5406.0809662356705;4456.242438785414;4745.5966242869745;4750.976245118822;4844.781984810692;4894.2169252920075;4035.878923632296;4042.221422574058;4061.2080644274674;4119.752814831119;4207.915841683149;1220.8046712525954;1300.8048792681172;1302.9674258143623;1314.5004898138645;1328.2561765411401;833.9791505212297;926.346925417579;926.5737760630186;943.5092553765035;947.5925352098526;5981.700914954235;6085.756569737249;6087.817365479043;6108;6115;425.28976609062937;434.48730498012014;438.94732632084356;448.15075432056074;448.1865414273149;3552.5736911570775;3816.9503386568363;3952.9209415812097;4018.557958624549;4045.3122969095325;10479.790404191874;10701.518431670593;10834.837477437844;10842.674719758419;10853.131749460183;8818.955905220433;9292.7676808079;10387;10621.681349559525;10690.572377104983;6904.551204171713;7841.568713720686;8092.9479167709;8206.343492520584;8321.334293256647;5110.259012443249;5844.240248767633;5865.4134586541;5914.792982245601;5923.259592550931;9689.467079310705;10016.549255283675;10073.143782778547;10087.344322619007;10281.485925703835;10049.397036177852;10086.092251697382;10217.438040907822;10230.795384092127;10337.121344685786;6596.70314835824;6996.965015174892;7377.77866664001;7640.083190017233;7674.2325767425045;7200.459965502503;8358.373122015752;8453.36599755033;8490.15098490146;8585.18440748128;7587.279208475186;7695.615219238904;7726.575038372718;7828.725994590162;7851.1363749988595;7519.774406767806;7551.169371369035;7580;7679.116901556393;7715.382769378324;7061.929380706127;7106.786796396116;7185.209626941137;7206.7117315306805;7219.855602887807;4861.538153875376;5055.064813009605;5077.822276220315;5117.923231151462;5126.666766660155;4904.485029071896;5082.796688132581;5104.563306154178;5119.590432765295;5208.791648334024 07:14:27 INFO - PROCESS | 2299 | |4;prototype.html;299.656892857678;309.14983794564944;313.68944744702736;317.9809211447315;321.686355803092;4687.273472611746;4706.011737535117;5107.846764597059;5274.92087618685;5374.91937620936;4913.3612630358;5579.163125531172;5620.634658747179;5631.198940715011;5646.322441307038;3958.5447673517624;4254.978725106385;4274.97862510687;4284.892877678052;4288.463942007249;3749.737518373715;4023.9597604024025;4143.990164770084;4196.817654819492;4288.228118938589;3520.926117534151;4156.812943417538;4172.97913510432;4195.8741237762915;4221.493420789509;3393.4231180699217;3909.1236206620697;4251.489821221442;4258.87223383299;4274.862568715642;3122.4223518649123;3454.29187016661;3528.6471352864764;3697.334479793636;3717.702583793317;4585.15716294639;4686.617447852857;5253.50091741284;5345.4387289334445;5380.784768609251;4862.635302352338;4882.7558622068755;4886.193778026657;4919.926201106986;4931.90136197274;4985.853253751658;5907.616004959664;5929.471964181305;5938.020226662638;5963.970180149072;3261.4618587932964;3481.1471189558465;3685.870994515179;3972.543157536891;4022.4971878515184;4935.827246046371;6226.221722284715;6231.3145553989025;6237.845998490248;6275.403836635513;4008.178323443687;4017.8392864285684;4025.4364388985564;4069.4709687740406;4089.2230476209425;3808.771473711586;4071.959280407217;4083.387491876242;4085.8774236772942;4099.549049604541;4407.272799987966;4476.597106260452;4634.165850146938;4739.838739508842;4779.784909679072;4824.396950381202;5525.309336332958;5630.521405680481;5743.966086104541;5759.222504961776;1264.7091169030991;1309.299524754252;1350.6083235861686;1374.202962281874;1387.1746310944973;685.9279775623488;751.0911796726023;794.4915254237293;797.8563858505408;818.9385796065319;3982.561918188997;4253.659707223476;4341.044970106572;4663.976680116645;4729;4409.735415875058;4665.673402861835;4737.9052418952115;5189.55888749453;5231.494898418069;4132.152908653718;4203.078860192137;4277.379779931893;4502.617277531381;4687.859364219079;2594.3773494361594;2658.9335266618104;2763.709810469912;2766.944661106807;2777.6944536101014;4647.6281897448125;4819.060373172362;4859.781309841065;5389.086874159695;5402.730358365781;4578.793954272066;4683.5082316356975;4914.582260507826;5099.337086178847;5341.706206158621;4911.484294149206;5051.686561493964;5163.225516172529;5330.786768529216;5385.515303622615;4246.957530424656;5158.690478571148;5171.63798534099;5176.611754118381;5202.947970520398;4136.669066474735;4448.5773851484055;4879.2190850340085;5099.495648783692;5491.945080549143;5008.874778130576;6207.410296021871;6247.437730604267;6395.360463953567;6437.034444833313;3530.2762933599065;4013.7958612415573;4056.4320995061307;4072.898177545585;4090.304648209871;5376.489233522809;5895.263092113486;5970.5223582114195;6166.907496387647;6231;5103.504099691723;5107.157319042316;5469.9915046723345;5491.643043202179;5721.370649228498;5730.971345143247;5971.790987315423;5991.490723288569;5996.4603185713495;6008.0687493436835;5599.468050535193;5637;5793.102069179284;5841.561882858888;5843.883122337615;5100.27135482515;5551.944480555304;5683.687397193029;5775.653460792198;6003.969980150246;5188.273641690242;5462.180672899097;5558.221848941233;5811.970940145272;5896.587238893237 07:14:27 INFO - PROCESS | 2299 | |5;yui.html;724.6992498113283;770.0451440214133;797.8125140591964;853.8804567360567;886.2466903132337;14362.497312594061;14973.02675326103;15160.090394576333;15174.848251517482;15214.391424343026;12598.559050433236;12877.935610321958;13948.605139486071;13970.37133329;13986.720265594682;710.0804458226609;872.0538216035609;884.8584226523758;904.6110172625769;911.9088091190861;870.6865528409768;882.8852249207627;896.1083721696921;906.1074841281333;908.4413085952158;956.6460409648405;962.7352478068552;962.956666949989;964.4840010594334;966.0580933589729;918.8713580098791;919.4621146629163;919.5126582911067;934.6635211323952;962.340796554359;685.3694600967123;687.9415249703782;709.4643544124153;713.6467448612918;715.2525610736792;14089;14178.574642760734;14239.715205695931;14291.499797507038;14316.713665726627;13828.792568111487;13883.930580347134;13904.165750055028;13948.721025579533;13963.65090872726;9832.262580306435;11576.594819181288;11677.591284305094;11684.649460516199;11872.990795782369;3787.621237876218;3802.790846503441;3821.980890095532;3836.2327534492933;3870.6709929656013;79191.20808791896;79283.41433171362;79397.01507462302;80897.59551202266;81402.59298703528;9772.755681107887;10886.40124793144;11020.953009464089;11021.669349919515;11105.888941110647;18551.72172417415;19409.90295048544;20043.699344509845;21152.153913843274;21187.258445954318;7741.961290193513;7879;8040.71857484997;8148.837023259502;8206;3574.873914716856;3688.7971161585833;3809.191332319289;4062.923325318793;4469.508354081048;3186.490161574137;3535.2045789697113;3537.699295559906;3540.433530635086;3541.256336169382;564.2241917363625;671.7917445591883;676.1683129750336;685.533836990841;689.9068625735462;664.7374287156546;673.182083768224;709.1808960650457;709.4111887133666;712.7647876200945;9239;9249.90750092504;9315.005681705035;9452.57463414148;9564;619.804761500126;657.1752450674469;683.8563901580724;698.6681326369934;719.9640017999079;4242.278812601865;4402.515723270438;4439.9778001110435;4442.911141777146;4487.955120448819;63068.68465657642;79697.60151199206;80494.19505804867;83626;83803;59697.70151149217;65538.67230663817;78577.21422785813;80165.59917200377;82639.5868020656;58818;64142.717145656825;64852.35147648557;65137;65391.34608653947;8622.396432249683;8645.438046526955;8663.91336086631;8748.65005399777;8876.801631779626;43654.126917462105;44856.551434486544;45162.548374515834;45416.54583454255;45581.77209113933;59095.40904590899;62897;62924;62955.055674165844;62961;11600.94199528997;11720.824187637363;11891.227070240408;11911.40442977865;12084.033277337616;11690.824637630272;12017.459214335551;12223.93888030554;12358.62924112278;12506.124571279923;11824.76350473003;11837.408129593658;12044.457999389873;12133.514659413524;12136.939315303367;11732.12009099338;11984.28094314344;12032;12094.153409261267;12101.576444824388;11371.772564548828;11490.023348015513;11724.413779311171;11923.880761192277;12017.879821201675;8605.698800541952;9786.314957952874;9824.890587806933;9855.704328870146;10101.595936162765;9841.034051313623;10060.69817905464;10107.545160467944;10127.949360253151;10128.189744820544 07:14:27 INFO - PROCESS | 2299 | __end_tp_report 07:14:27 INFO - PROCESS | 2299 | __start_cc_report 07:14:27 INFO - PROCESS | 2299 | _x_x_mozilla_cycle_collect,417 07:14:27 INFO - PROCESS | 2299 | __end_cc_report 07:14:27 INFO - PROCESS | 2299 | __startTimestamp1464358467407__endTimestamp 07:14:27 INFO - PROCESS | 2299 | 07:14:27 INFO - PROCESS | 2299 | ------- Summary: start ------- 07:14:27 INFO - PROCESS | 2299 | Number of tests: 6 07:14:27 INFO - PROCESS | 2299 | 07:14:27 INFO - PROCESS | 2299 | [#0] dojo.html Cycles:165 Average:5799.21 Median:6104.24 stddev:686.68 (11.2%) stddev-sans-first:649.68 07:14:27 INFO - PROCESS | 2299 | Values: 2887.4 3014.2 3462.9 3464.3 3475.9 5761.7 5839.4 5851.4 5904.4 5919.6 4744.5 5663.1 5857.6 5885.3 5965.9 5241.1 5248.1 5260.3 5315.8 5417.1 5427.8 5455.3 5483.8 5485.8 5508.3 5218.8 5252.4 5320.6 5345.0 5365.8 5269.3 5270.6 5271.0 5271.9 5313.8 4281.5 5228.3 5261.1 5273.6 5330.8 5601.5 5707.2 5733.0 5760.3 5794.8 5721.1 5735.5 6256.0 6256.2 6272.2 6283.1 6286.2 6286.5 6298.0 6300.5 5820.3 5908.2 5914.4 5937.2 6038.4 6326.8 6331.7 6336.0 6348.6 6464.0 6269.0 6275.3 6295.7 6302.4 6315.5 6177.0 6227.1 6240.4 6268.6 6272.0 6152.4 6191.2 6210.2 6218.6 6272.6 5468.5 6255.8 6258.2 6264.7 6275.6 4283.7 4909.1 4984.7 5033.5 5059.8 3626.8 4437.9 4516.3 4525.6 4548.4 5163.3 5986.1 6061.2 6061.3 6086.0 6175.4 6197.9 6221.4 6238.7 6284.1 5899.9 6015.2 6020.4 6070.2 6082.6 5388.6 5517.0 5555.8 5569.7 5571.6 6351.1 6386.5 6420.6 6479.7 6513.0 6265.8 6270.0 6281.7 6282.2 6291.7 6217.4 6281.1 6460.0 6470.9 6482.3 6104.2 6113.7 6160.0 6181.0 6190.2 6214.8 6242.9 6249.7 6249.9 6263.7 6115.5 6118.7 6124.3 6178.9 6186.3 6098.2 6107.4 6149.3 6161.7 6197.5 5960.1 6071.0 6118.6 6134.8 6135.8 6119.4 6170.3 6212.5 6220.2 6247.7 6041.1 6151.1 6178.2 6195.3 6215.3 07:14:27 INFO - PROCESS | 2299 | 07:14:27 INFO - PROCESS | 2299 | [#1] ext.html Cycles:180 Average:69066.57 Median:40456.60 stddev:147910.44 (365.6%) stddev-sans-first:148235.77 07:14:27 INFO - PROCESS | 2299 | Values: 497.6 513.3 526.4 547.3 564.6 30753.8 41567.4 41649.2 41870.6 42000.6 42824.6 43206.4 43543.6 43545.3 43554.1 9397.2 9646.1 9646.5 9659.9 9687.5 9487.2 9535.2 9598.0 9601.3 9611.6 9512.5 9563.7 9596.1 9612.7 9614.6 9541.2 9557.7 9564.9 9570.5 9593.3 9458.8 9476.1 9502.6 9525.7 9550.2 39894.6 40201.0 40261.2 40327.0 40330.2 3630.7 3671.9 4179.7 4218.1 4378.9 28305.7 30907.0 32208.5 32553.8 32576.7 3241.2 3382.8 3388.2 3403.4 3408.7 498627.0 508741.5 508997.0 509222.0 511307.0 52646.5 58028.0 63374.0 63493.0 63826.4 55473.0 64305.7 65753.0 66582.7 66674.0 16524.9 16712.8 16781.7 16784.8 16791.2 12902.4 12958.3 12995.0 13006.6 13029.2 14432.1 15149.6 16928.8 17288.3 17414.7 2844.2 7388.9 7625.6 7656.7 7728.8 930.4 1048.3 1106.7 1163.6 1232.5 28802.3 29281.6 30443.7 31021.7 31227.7 1048.9 1111.2 1148.6 1180.7 1238.7 15200.7 16246.4 17049.7 17080.5 17169.9 575573.0 627987.0 631613.0 659034.0 661114.7 58460.7 58578.7 60427.7 60531.8 60680.4 1312.8 1364.8 1426.3 1428.8 1450.8 30636.2 31600.5 31682.6 31702.0 32302.0 53047.2 53449.7 54056.0 54056.7 54143.7 514159.0 514674.0 514788.0 515152.0 516143.0 26630.2 27128.9 27432.6 27471.6 27493.0 47185.0 48100.3 48731.8 48843.8 49045.3 39168.6 39821.4 40076.8 40583.0 40646.8 38300.2 38526.6 38878.2 39213.4 39253.8 38339.4 38605.0 39055.4 39648.4 39727.4 28641.0 29035.0 30278.8 35841.8 36016.0 24435.8 24542.5 25177.9 25882.6 26172.9 07:14:27 INFO - PROCESS | 2299 | 07:14:27 INFO - PROCESS | 2299 | [#2] jquery.html Cycles:180 Average:33709.71 Median:21831.40 stddev:93620.51 (428.8%) stddev-sans-first:93849.67 07:14:27 INFO - PROCESS | 2299 | Values: 369.5 382.4 384.2 398.6 408.9 18812.2 20152.7 20568.1 20654.4 20722.4 11892.5 12278.5 12340.7 12340.7 20169.0 5368.9 5549.9 5563.2 5570.2 5578.1 3850.2 5798.7 6042.9 6138.0 6188.3 6030.0 6065.7 6133.0 6168.3 6171.0 6143.0 6145.2 6145.5 6158.0 6163.8 5776.5 5823.2 5926.5 6010.2 6032.1 12977.6 13382.5 13502.9 13532.9 13783.4 2243.8 2251.9 2429.8 2438.5 2572.6 10144.6 10367.0 12450.8 15029.8 15613.9 1858.3 1896.8 1920.9 1926.2 1957.6 111161.4 120150.4 121035.0 126429.4 128551.4 9719.9 11605.1 11968.1 12011.0 12162.0 12437.5 13631.5 14827.6 14880.5 14904.9 8635.7 8695.3 8748.0 8753.4 8795.8 7239.2 8563.4 8626.4 8781.6 8782.3 4503.6 4548.0 4623.1 4626.1 4710.3 1739.3 3538.5 3620.9 3673.9 3859.6 821.7 947.6 979.2 1031.5 1060.7 20897.3 21417.7 21739.1 21923.7 22005.0 1055.8 1058.9 1061.8 1063.2 1066.7 9860.5 11258.3 11510.8 11516.4 11519.2 505923.0 516706.0 516928.0 613511.0 616157.0 130664.0 133635.0 135835.3 140210.0 142795.0 1022.8 1042.7 1059.0 1101.0 1102.3 19298.8 19465.0 19556.2 19615.0 19629.9 54276.5 54347.0 54697.9 55135.4 55419.7 56783.0 76257.0 77480.6 79454.0 80612.0 7905.9 8044.7 8100.4 8136.0 8306.4 12123.6 12692.9 12750.9 12914.1 13101.2 10634.9 10905.8 11091.5 11142.7 11283.4 10835.5 11116.7 11171.9 11217.8 11285.8 11277.0 11292.9 11349.6 11594.9 11619.9 7268.8 7957.8 8154.8 8160.2 8222.4 9328.6 9644.6 9747.4 11297.0 11317.8 07:14:27 INFO - PROCESS | 2299 | 07:14:27 INFO - PROCESS | 2299 | [#3] mootools.html Cycles:180 Average:5713.51 Median:4870.76 stddev:3209.44 (65.9%) stddev-sans-first:3202.20 07:14:27 INFO - PROCESS | 2299 | Values: 1416.3 1526.9 1742.6 1896.2 1913.2 8050.0 8645.5 8700.6 9134.5 9156.0 8797.5 8848.6 8961.2 9018.1 9021.1 2027.4 2083.4 2362.6 2397.3 2401.5 2352.8 2366.4 2396.3 2403.4 2403.4 2372.4 2375.1 2383.6 2395.5 2396.0 2357.3 2358.6 2363.4 2377.7 2379.3 2275.8 2293.3 2293.7 2295.6 2358.4 8841.9 8910.6 8917.6 8923.7 8934.4 5287.2 5295.7 5423.8 5455.6 5459.8 3404.0 3449.2 3636.7 3697.4 3707.6 1034.3 1064.8 1087.3 1109.5 1111.0 11436.3 11605.2 11700.5 11724.6 11847.9 4161.7 4772.1 4776.8 4880.0 4924.8 9887.0 9955.2 9976.1 9981.0 10006.3 5203.0 5232.8 5269.4 5307.3 5406.1 4456.2 4745.6 4751.0 4844.8 4894.2 4035.9 4042.2 4061.2 4119.8 4207.9 1220.8 1300.8 1303.0 1314.5 1328.3 834.0 926.3 926.6 943.5 947.6 5981.7 6085.8 6087.8 6108.0 6115.0 425.3 434.5 438.9 448.2 448.2 3552.6 3817.0 3952.9 4018.6 4045.3 10479.8 10701.5 10834.8 10842.7 10853.1 8819.0 9292.8 10387.0 10621.7 10690.6 6904.6 7841.6 8092.9 8206.3 8321.3 5110.3 5844.2 5865.4 5914.8 5923.3 9689.5 10016.5 10073.1 10087.3 10281.5 10049.4 10086.1 10217.4 10230.8 10337.1 6596.7 6997.0 7377.8 7640.1 7674.2 7200.5 8358.4 8453.4 8490.2 8585.2 7587.3 7695.6 7726.6 7828.7 7851.1 7519.8 7551.2 7580.0 7679.1 7715.4 7061.9 7106.8 7185.2 7206.7 7219.9 4861.5 5055.1 5077.8 5117.9 5126.7 4904.5 5082.8 5104.6 5119.6 5208.8 07:14:27 INFO - PROCESS | 2299 | 07:14:27 INFO - PROCESS | 2299 | [#4] prototype.html Cycles:180 Average:4493.62 Median:4861.21 stddev:1393.64 (28.7%) stddev-sans-first:1361.53 07:14:27 INFO - PROCESS | 2299 | Values: 299.7 309.1 313.7 318.0 321.7 4687.3 4706.0 5107.8 5274.9 5374.9 4913.4 5579.2 5620.6 5631.2 5646.3 3958.5 4255.0 4275.0 4284.9 4288.5 3749.7 4024.0 4144.0 4196.8 4288.2 3520.9 4156.8 4173.0 4195.9 4221.5 3393.4 3909.1 4251.5 4258.9 4274.9 3122.4 3454.3 3528.6 3697.3 3717.7 4585.2 4686.6 5253.5 5345.4 5380.8 4862.6 4882.8 4886.2 4919.9 4931.9 4985.9 5907.6 5929.5 5938.0 5964.0 3261.5 3481.1 3685.9 3972.5 4022.5 4935.8 6226.2 6231.3 6237.8 6275.4 4008.2 4017.8 4025.4 4069.5 4089.2 3808.8 4072.0 4083.4 4085.9 4099.5 4407.3 4476.6 4634.2 4739.8 4779.8 4824.4 5525.3 5630.5 5744.0 5759.2 1264.7 1309.3 1350.6 1374.2 1387.2 685.9 751.1 794.5 797.9 818.9 3982.6 4253.7 4341.0 4664.0 4729.0 4409.7 4665.7 4737.9 5189.6 5231.5 4132.2 4203.1 4277.4 4502.6 4687.9 2594.4 2658.9 2763.7 2766.9 2777.7 4647.6 4819.1 4859.8 5389.1 5402.7 4578.8 4683.5 4914.6 5099.3 5341.7 4911.5 5051.7 5163.2 5330.8 5385.5 4247.0 5158.7 5171.6 5176.6 5202.9 4136.7 4448.6 4879.2 5099.5 5491.9 5008.9 6207.4 6247.4 6395.4 6437.0 3530.3 4013.8 4056.4 4072.9 4090.3 5376.5 5895.3 5970.5 6166.9 6231.0 5103.5 5107.2 5470.0 5491.6 5721.4 5731.0 5971.8 5991.5 5996.5 6008.1 5599.5 5637.0 5793.1 5841.6 5843.9 5100.3 5551.9 5683.7 5775.7 6004.0 5188.3 5462.2 5558.2 5812.0 5896.6 07:14:27 INFO - PROCESS | 2299 | 07:14:27 INFO - PROCESS | 2299 | [#5] yui.html Cycles:180 Average:17479.44 Median:59396.56 stddev:23415.98 (39.4%) stddev-sans-first:23447.87 07:14:27 INFO - PROCESS | 2299 | Values: 724.7 770.0 797.8 853.9 886.2 14362.5 14973.0 15160.1 15174.8 15214.4 12598.6 12877.9 13948.6 13970.4 13986.7 710.1 872.1 884.9 904.6 911.9 870.7 882.9 896.1 906.1 908.4 956.6 962.7 963.0 964.5 966.1 918.9 919.5 919.5 934.7 962.3 685.4 687.9 709.5 713.6 715.3 14089.0 14178.6 14239.7 14291.5 14316.7 13828.8 13883.9 13904.2 13948.7 13963.7 9832.3 11576.6 11677.6 11684.6 11873.0 3787.6 3802.8 3822.0 3836.2 3870.7 79191.2 79283.4 79397.0 80897.6 81402.6 9772.8 10886.4 11021.0 11021.7 11105.9 18551.7 19409.9 20043.7 21152.2 21187.3 7742.0 7879.0 8040.7 8148.8 8206.0 3574.9 3688.8 3809.2 4062.9 4469.5 3186.5 3535.2 3537.7 3540.4 3541.3 564.2 671.8 676.2 685.5 689.9 664.7 673.2 709.2 709.4 712.8 9239.0 9249.9 9315.0 9452.6 9564.0 619.8 657.2 683.9 698.7 720.0 4242.3 4402.5 4440.0 4442.9 4488.0 63068.7 79697.6 80494.2 83626.0 83803.0 59697.7 65538.7 78577.2 80165.6 82639.6 58818.0 64142.7 64852.4 65137.0 65391.3 8622.4 8645.4 8663.9 8748.7 8876.8 43654.1 44856.6 45162.5 45416.5 45581.8 59095.4 62897.0 62924.0 62955.1 62961.0 11600.9 11720.8 11891.2 11911.4 12084.0 11690.8 12017.5 12223.9 12358.6 12506.1 11824.8 11837.4 12044.5 12133.5 12136.9 11732.1 11984.3 12032.0 12094.2 12101.6 11371.8 11490.0 11724.4 11923.9 12017.9 8605.7 9786.3 9824.9 9855.7 10101.6 9841.0 10060.7 10107.5 10127.9 10128.2 07:14:27 INFO - PROCESS | 2299 | -------- Summary: end -------- 07:14:27 INFO - PROCESS | 2299 | 07:14:27 INFO - TEST-INFO | 2299: exit 0 07:14:27 INFO - TEST-OK | dromaeo_css | took 1112873ms 07:14:27 INFO - TEST-START | kraken 07:14:27 INFO - operating with platform_type : mac_ 07:14:27 INFO - Initialising browser for kraken test... 07:14:28 INFO - TEST-INFO | started process 2303 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/tmpXpdmIk/profile http://localhost:59212/getInfo.html) 07:14:30 INFO - PROCESS | 2303 | __metrics Screen width/height:1600/1200 07:14:30 INFO - PROCESS | 2303 | colorDepth:24 07:14:30 INFO - PROCESS | 2303 | Browser inner width/height: 1024/689 07:14:30 INFO - PROCESS | 2303 | __metrics 07:14:31 ERROR - PROCESS | 2303 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 07:14:31 INFO - TEST-INFO | 2303: exit 0 07:14:31 INFO - Browser initialized. 07:14:31 INFO - Running cycle 1/1 for kraken test... 07:14:31 INFO - TEST-INFO | started process 2305 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/T/tmpXpdmIk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:14:43 INFO - PROCESS | 2305 | RSS: Main: 252833792 07:14:43 INFO - PROCESS | 2305 | 07:14:46 INFO - PROCESS | 2305 | Cycle 1(1): loaded http://localhost:59212/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59212/tests/kraken/driver.html?testName=audio-beat-detection) 07:14:47 INFO - PROCESS | 2305 | RSS: Main: 265302016 07:14:47 INFO - PROCESS | 2305 | 07:14:50 INFO - PROCESS | 2305 | Cycle 1(1): loaded http://localhost:59212/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59212/tests/kraken/driver.html?testName=audio-dft) 07:14:50 INFO - PROCESS | 2305 | RSS: Main: 270213120 07:14:50 INFO - PROCESS | 2305 | 07:14:54 INFO - PROCESS | 2305 | Cycle 1(1): loaded http://localhost:59212/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59212/tests/kraken/driver.html?testName=audio-fft) 07:14:54 INFO - PROCESS | 2305 | RSS: Main: 270364672 07:14:54 INFO - PROCESS | 2305 | 07:14:56 INFO - PROCESS | 2305 | Cycle 1(1): loaded http://localhost:59212/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59212/tests/kraken/driver.html?testName=audio-oscillator) 07:14:57 INFO - PROCESS | 2305 | RSS: Main: 271224832 07:14:57 INFO - PROCESS | 2305 | 07:14:59 INFO - PROCESS | 2305 | Cycle 1(1): loaded http://localhost:59212/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59212/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:15:00 INFO - PROCESS | 2305 | RSS: Main: 271818752 07:15:00 INFO - PROCESS | 2305 | 07:15:03 INFO - PROCESS | 2305 | Cycle 1(1): loaded http://localhost:59212/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59212/tests/kraken/driver.html?testName=imaging-darkroom) 07:15:03 INFO - PROCESS | 2305 | RSS: Main: 271851520 07:15:03 INFO - PROCESS | 2305 | 07:15:06 INFO - PROCESS | 2305 | Cycle 1(1): loaded http://localhost:59212/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59212/tests/kraken/driver.html?testName=imaging-desaturate) 07:15:07 INFO - PROCESS | 2305 | RSS: Main: 272076800 07:15:07 INFO - PROCESS | 2305 | 07:15:10 INFO - PROCESS | 2305 | Cycle 1(1): loaded http://localhost:59212/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59212/tests/kraken/driver.html?testName=json-parse-financial) 07:15:11 INFO - PROCESS | 2305 | RSS: Main: 272363520 07:15:11 INFO - PROCESS | 2305 | 07:15:12 INFO - PROCESS | 2305 | Cycle 1(1): loaded http://localhost:59212/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59212/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:15:13 INFO - PROCESS | 2305 | RSS: Main: 271568896 07:15:13 INFO - PROCESS | 2305 | 07:15:15 INFO - PROCESS | 2305 | Cycle 1(1): loaded http://localhost:59212/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59212/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:15:15 INFO - PROCESS | 2305 | RSS: Main: 271749120 07:15:15 INFO - PROCESS | 2305 | 07:15:18 INFO - PROCESS | 2305 | Cycle 1(1): loaded http://localhost:59212/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59212/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:15:18 INFO - PROCESS | 2305 | RSS: Main: 272138240 07:15:18 INFO - PROCESS | 2305 | 07:15:21 INFO - PROCESS | 2305 | Cycle 1(1): loaded http://localhost:59212/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59212/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:15:22 INFO - PROCESS | 2305 | RSS: Main: 272371712 07:15:22 INFO - PROCESS | 2305 | 07:15:25 INFO - PROCESS | 2305 | Cycle 1(1): loaded http://localhost:59212/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59212/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:15:25 INFO - PROCESS | 2305 | RSS: Main: 272011264 07:15:25 INFO - PROCESS | 2305 | 07:15:27 INFO - PROCESS | 2305 | Cycle 1(1): loaded http://localhost:59212/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59212/tests/kraken/driver.html?testName=ai-astar) 07:15:27 INFO - PROCESS | 2305 | RSS: Main: 273084416 07:15:27 INFO - PROCESS | 2305 | 07:15:27 INFO - PROCESS | 2305 | __start_tp_report 07:15:27 INFO - PROCESS | 2305 | _x_x_mozilla_page_load 07:15:27 INFO - PROCESS | 2305 | _x_x_mozilla_page_load_details 07:15:27 INFO - PROCESS | 2305 | |i|pagename|runs| 07:15:27 INFO - PROCESS | 2305 | |0;ai-astar;121;109;116;115;117;117;117;117;121;162 07:15:27 INFO - PROCESS | 2305 | |1;audio-beat-detection;159;148;173;155;139;173;167;109;159;114 07:15:27 INFO - PROCESS | 2305 | |2;audio-dft;193;204;248;273;197;204;200;194;198;197 07:15:27 INFO - PROCESS | 2305 | |3;audio-fft;72;82;85;141;69;79;82;77;136;67 07:15:27 INFO - PROCESS | 2305 | |4;audio-oscillator;69;71;123;79;103;110;152;82;73;116 07:15:27 INFO - PROCESS | 2305 | |5;imaging-gaussian-blur;92;88;91;89;91;123;78;132;125;88 07:15:27 INFO - PROCESS | 2305 | |6;imaging-darkroom;100;97;96;135;135;98;116;152;112;96 07:15:27 INFO - PROCESS | 2305 | |7;imaging-desaturate;98;90;90;91;92;124;148;115;91;93 07:15:27 INFO - PROCESS | 2305 | |8;json-parse-financial;57;58;70;62;52;55;56;57;55;57 07:15:27 INFO - PROCESS | 2305 | |9;json-stringify-tinderbox;67;70;71;72;80;79;70;74;70;69 07:15:27 INFO - PROCESS | 2305 | |10;stanford-crypto-aes;88;87;86;78;109;105;107;106;116;107 07:15:27 INFO - PROCESS | 2305 | |11;stanford-crypto-ccm;154;123;169;149;168;132;144;131;159;156 07:15:27 INFO - PROCESS | 2305 | |12;stanford-crypto-pbkdf2;181;225;222;175;162;167;163;170;165;163 07:15:27 INFO - PROCESS | 2305 | |13;stanford-crypto-sha256-iterative;66;66;65;64;65;67;66;65;66;67 07:15:27 INFO - PROCESS | 2305 | __end_tp_report 07:15:27 INFO - PROCESS | 2305 | __start_cc_report 07:15:27 INFO - PROCESS | 2305 | _x_x_mozilla_cycle_collect,1068 07:15:27 INFO - PROCESS | 2305 | __end_cc_report 07:15:27 INFO - PROCESS | 2305 | __startTimestamp1464358527803__endTimestamp 07:15:27 INFO - PROCESS | 2305 | 07:15:27 INFO - PROCESS | 2305 | ------- Summary: start ------- 07:15:27 INFO - PROCESS | 2305 | Number of tests: 14 07:15:27 INFO - PROCESS | 2305 | 07:15:27 INFO - PROCESS | 2305 | [#0] ai-astar Cycles:10 Average:121.20 Median:117.00 stddev:14.72 (12.6%) stddev-sans-first:15.61 07:15:27 INFO - PROCESS | 2305 | Values: 121.0 109.0 116.0 115.0 117.0 117.0 117.0 117.0 121.0 162.0 07:15:27 INFO - PROCESS | 2305 | 07:15:27 INFO - PROCESS | 2305 | [#1] audio-beat-detection Cycles:10 Average:149.60 Median:159.00 stddev:22.69 (14.3%) stddev-sans-first:23.81 07:15:27 INFO - PROCESS | 2305 | Values: 159.0 148.0 173.0 155.0 139.0 173.0 167.0 109.0 159.0 114.0 07:15:27 INFO - PROCESS | 2305 | 07:15:27 INFO - PROCESS | 2305 | [#2] audio-dft Cycles:10 Average:210.80 Median:202.00 stddev:27.09 (13.4%) stddev-sans-first:27.96 07:15:27 INFO - PROCESS | 2305 | Values: 193.0 204.0 248.0 273.0 197.0 204.0 200.0 194.0 198.0 197.0 07:15:27 INFO - PROCESS | 2305 | 07:15:27 INFO - PROCESS | 2305 | [#3] audio-fft Cycles:10 Average:89.00 Median:78.00 stddev:26.76 (34.3%) stddev-sans-first:27.67 07:15:27 INFO - PROCESS | 2305 | Values: 72.0 82.0 85.0 141.0 69.0 79.0 82.0 77.0 136.0 67.0 07:15:27 INFO - PROCESS | 2305 | 07:15:27 INFO - PROCESS | 2305 | [#4] audio-oscillator Cycles:10 Average:97.80 Median:70.00 stddev:27.58 (39.4%) stddev-sans-first:27.21 07:15:27 INFO - PROCESS | 2305 | Values: 69.0 71.0 123.0 79.0 103.0 110.0 152.0 82.0 73.0 116.0 07:15:27 INFO - PROCESS | 2305 | 07:15:27 INFO - PROCESS | 2305 | [#5] imaging-gaussian-blur Cycles:10 Average:99.70 Median:88.50 stddev:19.14 (21.6%) stddev-sans-first:20.09 07:15:27 INFO - PROCESS | 2305 | Values: 92.0 88.0 91.0 89.0 91.0 123.0 78.0 132.0 125.0 88.0 07:15:27 INFO - PROCESS | 2305 | 07:15:27 INFO - PROCESS | 2305 | [#6] imaging-darkroom Cycles:10 Average:113.70 Median:124.00 stddev:20.34 (16.4%) stddev-sans-first:20.96 07:15:27 INFO - PROCESS | 2305 | Values: 100.0 97.0 96.0 135.0 135.0 98.0 116.0 152.0 112.0 96.0 07:15:27 INFO - PROCESS | 2305 | 07:15:27 INFO - PROCESS | 2305 | [#7] imaging-desaturate Cycles:10 Average:103.20 Median:91.00 stddev:19.67 (21.6%) stddev-sans-first:20.77 07:15:27 INFO - PROCESS | 2305 | Values: 98.0 90.0 90.0 91.0 92.0 124.0 148.0 115.0 91.0 93.0 07:15:27 INFO - PROCESS | 2305 | 07:15:27 INFO - PROCESS | 2305 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:57.00 stddev:4.95 (8.7%) stddev-sans-first:5.24 07:15:27 INFO - PROCESS | 2305 | Values: 57.0 58.0 70.0 62.0 52.0 55.0 56.0 57.0 55.0 57.0 07:15:27 INFO - PROCESS | 2305 | 07:15:27 INFO - PROCESS | 2305 | [#9] json-stringify-tinderbox Cycles:10 Average:72.20 Median:71.50 stddev:4.26 (6.0%) stddev-sans-first:4.09 07:15:27 INFO - PROCESS | 2305 | Values: 67.0 70.0 71.0 72.0 80.0 79.0 70.0 74.0 70.0 69.0 07:15:27 INFO - PROCESS | 2305 | 07:15:27 INFO - PROCESS | 2305 | [#10] stanford-crypto-aes Cycles:10 Average:98.90 Median:97.00 stddev:12.81 (13.2%) stddev-sans-first:12.97 07:15:27 INFO - PROCESS | 2305 | Values: 88.0 87.0 86.0 78.0 109.0 105.0 107.0 106.0 116.0 107.0 07:15:27 INFO - PROCESS | 2305 | 07:15:27 INFO - PROCESS | 2305 | [#11] stanford-crypto-ccm Cycles:10 Average:148.50 Median:155.00 stddev:15.80 (10.2%) stddev-sans-first:16.63 07:15:27 INFO - PROCESS | 2305 | Values: 154.0 123.0 169.0 149.0 168.0 132.0 144.0 131.0 159.0 156.0 07:15:27 INFO - PROCESS | 2305 | 07:15:27 INFO - PROCESS | 2305 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.30 Median:172.50 stddev:24.05 (13.9%) stddev-sans-first:25.50 07:15:27 INFO - PROCESS | 2305 | Values: 181.0 225.0 222.0 175.0 162.0 167.0 163.0 170.0 165.0 163.0 07:15:27 INFO - PROCESS | 2305 | 07:15:27 INFO - PROCESS | 2305 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:66.00 stddev:0.95 (1.4%) stddev-sans-first:1.00 07:15:27 INFO - PROCESS | 2305 | Values: 66.0 66.0 65.0 64.0 65.0 67.0 66.0 65.0 66.0 67.0 07:15:27 INFO - PROCESS | 2305 | -------- Summary: end -------- 07:15:27 INFO - PROCESS | 2305 | 07:15:28 INFO - TEST-INFO | 2305: exit 0 07:15:28 INFO - TEST-OK | kraken | took 60573ms 07:15:28 INFO - SUITE-END | took 1173s 07:15:28 INFO - Completed test suite (00:19:33) 07:15:28 INFO - javascript benchmark 07:15:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7240.923662146495, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2887.3792134691043, 3014.2012366722824, 3462.948055779164, 3464.2551851351955, 3475.939838349304, 5761.711914404279, 5839.35767065623, 5851.356350801414, 5904.3800400957925, 5919.556033297498, 4744.549267819561, 5663.093904975205, 5857.6485410875375, 5885.264341957255, 5965.910511342333, 5241.135212689911, 5248.107821670306, 5260.263563101169, 5315.760790764405, 5417.079096553575, 5427.782888684448, 5455.263539422167, 5483.835484935458, 5485.807996720116, 5508.256385387981, 5218.765155568009, 5252.422233554306, 5320.600954928396, 5345.01117293302, 5365.812196573121, 5269.314989051399, 5270.578353731692, 5270.973645131749, 5271.947280527184, 5313.7608807603365, 4281.464816897887, 5228.346456692913, 5261.1319132343115, 5273.630845840793, 5330.840074797762, 5601.467860553282, 5707.200991861143, 5732.971335143339, 5760.279965004374, 5794.797182098607, 5721.084626459747, 5735.537437953295, 6256.0, 6256.15541901842, 6272.247330320391, 6283.088952101965, 6286.245650521921, 6286.497080233616, 6297.968510157466, 6300.464460520861, 5820.30156381237, 5908.231929849135, 5914.408559144094, 5937.198478205473, 6038.365971573009, 6326.778562750282, 6331.746730130835, 6336.0, 6348.619082855043, 6463.967680161569, 6268.968655156787, 6275.309715931244, 6295.716692748837, 6302.401271879165, 6315.463185629181, 6177.042558403455, 6227.1282020517165, 6240.438360547572, 6268.62388256697, 6271.96864015677, 6152.415520525543, 6191.226096737908, 6210.192674952227, 6218.626882387071, 6272.6236425814595, 5468.535174510132, 6255.812325630147, 6258.15514905491, 6264.718087686065, 6275.592086514362, 4283.657307415399, 4909.140900342426, 4984.651074424755, 5033.471485494044, 5059.772310246048, 3626.7642603230706, 4437.933430998538, 4516.277395616686, 4525.615322697542, 4548.431446069241, 5163.251328557338, 5986.132010858401, 6061.212042434456, 6061.333253342129, 6085.96957015221, 6175.44421002112, 6197.907031394533, 6221.3778622138325, 6238.719257633417, 6284.12022316876, 5899.882002360015, 6015.157877897098, 6020.413760090922, 6070.150178974947, 6082.57421980466, 5388.568914486832, 5517.0, 5555.833325000256, 5569.693666848362, 5571.582131340166, 6351.110844481776, 6386.457151142112, 6420.550561460653, 6479.6760161991715, 6513.0, 6265.8120256392385, 6270.028145637433, 6281.7173227203975, 6282.2147231596055, 6291.685415729286, 6217.440430361289, 6281.089242059785, 6460.0, 6470.902936456051, 6482.254540727877, 6104.236970378703, 6113.694315284129, 6160.0, 6180.969095154495, 6190.226221722285, 6214.751409943732, 6242.906356404748, 6249.6562689052535, 6249.937500624936, 6263.718132683949, 6115.453310713017, 6118.663473509, 6124.289394097845, 6178.907316390348, 6186.257649082139, 6098.159935307505, 6107.358727333743, 6149.292831324455, 6161.661108639068, 6197.473214776614, 5960.1357803117435, 6071.038793531139, 6118.558266176285, 6134.803982731443, 6135.84660383494, 6119.380693981324, 6170.259568851587, 6212.534059945432, 6220.222472190976, 6247.656378899204, 6041.093835924471, 6151.138840562415, 6178.227721534809, 6195.2875419325555, 6215.285242197025], "value": 5752.900289441181, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [497.56463094792036, 513.3121617033177, 526.3736153976769, 547.2857920413863, 564.6414526775498, 30753.846230768842, 41567.376489352646, 41649.16701665969, 41870.581294187046, 42000.57999420005, 42824.57175428252, 43206.35190472138, 43543.56456435435, 43545.34681979765, 43554.12891742171, 9397.248220142372, 9646.083622055894, 9646.469444180568, 9659.903400966006, 9687.51562421876, 9487.193588544947, 9535.237181025535, 9597.952010239938, 9601.327907046509, 9611.615535378576, 9512.524373781318, 9563.665271715492, 9596.088371604721, 9612.711618651452, 9614.56734446948, 9541.2367010639, 9557.713268601952, 9564.90435095647, 9570.52147392631, 9593.328467007243, 9458.810823783555, 9476.099770521789, 9502.572384242725, 9525.666601668909, 9550.188234000118, 39894.601053989376, 40201.0, 40261.19477610431, 40327.0, 40330.19339613221, 3630.6732394084397, 3671.8714844980295, 4179.707420480568, 4218.114196018809, 4378.8905277368, 28305.72624231894, 30907.0, 32208.516872246935, 32553.83723081393, 32576.6742332576, 3241.1897025743565, 3382.780119292238, 3388.2376465295356, 3403.4384326586082, 3408.659134086596, 498627.0, 508741.4562927199, 508997.0, 509222.0, 511307.0, 52646.47353526492, 58028.0, 63374.0, 63493.0, 63826.361736382045, 55473.0, 64305.67847160828, 65753.0, 66582.66708666425, 66674.0, 16524.917375413046, 16712.83287167113, 16781.748273775902, 16784.825062245527, 16791.2443940023, 12902.354882256037, 12958.28729419872, 12995.025373097056, 13006.609801705965, 13029.218246905217, 14432.061915975428, 15149.62125946838, 16928.83071169297, 17288.308467661154, 17414.65170696579, 2844.2320573445054, 7388.889166662504, 7625.618719064136, 7656.655450504741, 7728.806779830436, 930.3859452761145, 1048.3238311289176, 1106.7399161197113, 1163.574621089176, 1232.5254776910954, 28802.279943001173, 29281.56077658837, 30443.69556304453, 31021.68978310188, 31227.68772312248, 1048.9091345001266, 1111.1777284809184, 1148.6381789736206, 1180.6753142885775, 1238.6808049427332, 15200.695986080216, 16246.431374901822, 17049.7442538362, 17080.48758537246, 17169.91415042917, 575573.0, 627987.0, 631613.0, 659034.0, 661114.6944265248, 58460.70769646124, 58578.707106465044, 60427.69786151129, 60531.78936421247, 60680.393196067474, 1312.8293321868096, 1364.8089267502558, 1426.3082405033551, 1428.792825040384, 1450.7678771396527, 30636.234094146934, 31600.525992109677, 31682.57428415773, 31702.0, 32302.030939071865, 53047.20429193488, 53449.73275133599, 54056.0, 54056.72971635117, 54143.72928135334, 514159.0, 514674.0, 514787.98242061347, 515152.0, 516143.0, 26630.20109396721, 27128.914843406044, 27432.58851117195, 27471.587926180724, 27493.0, 47185.0, 48100.27849582329, 48731.75634121807, 48843.778905527644, 49045.264321035924, 39168.6083139165, 39821.40267895926, 40076.799616001736, 40583.0, 40646.79676601598, 38300.23399531938, 38526.6147338523, 38878.22243555057, 39213.41179882361, 39253.80373098116, 38339.42490862695, 38605.0, 39055.41416878692, 39648.40527392034, 39727.404088938114, 28641.0, 29035.0, 30278.84860575771, 35841.82079089588, 36016.0, 24435.75564244335, 24542.509149817262, 25177.87411062933, 25882.61176082398, 26172.8691356542], "value": 20241.345619681524, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.549150036955, 382.3520626101502, 384.15294276121153, 398.5735263268304, 408.85076946914387, 18812.247510099598, 20152.69770953437, 20568.07443665035, 20654.380368588947, 20722.378328650146, 11892.524299028028, 12278.508859645603, 12340.691482712937, 12340.691482712937, 20169.0, 5368.865778355553, 5549.916751248715, 5563.248961390222, 5570.192322113311, 5578.135389014709, 3850.249201405727, 5798.652080875161, 6042.879142417149, 6138.0, 6188.319284878659, 6029.969850150765, 6065.727042283108, 6133.0, 6168.321484636686, 6170.969145154268, 6143.047827586731, 6145.170401995718, 6145.508359331265, 6157.96921015392, 6163.753449862, 5776.537876969875, 5823.184754134425, 5926.466618004357, 6010.218671572711, 6032.065029920369, 12977.610671679864, 13382.531611393555, 13502.864971350258, 13532.864671353358, 13783.448662053506, 2243.8317126215434, 2251.898664560099, 2429.7934675552424, 2438.4635380216323, 2572.597934125906, 10144.594216231342, 10367.0, 12450.750984980341, 15029.849701502955, 15613.907026508148, 1858.2659849359427, 1896.781870084944, 1920.9231630734753, 1926.181372916519, 1957.6084783043448, 111161.44419277932, 120150.39924800408, 121035.0, 126429.36785316106, 128551.42897142099, 9719.90280097204, 11605.071594272438, 11968.102392320438, 12011.0, 12162.027037836951, 12437.502499900083, 13631.454741810416, 14827.555173344817, 14880.479183228535, 14904.850951490564, 8635.740927772176, 8695.260902823331, 8747.956260218658, 8753.431026983226, 8795.780105497286, 7239.20368759436, 8563.400561960603, 8626.353023523261, 8781.560921953876, 8782.253508451853, 4503.639708823286, 4547.977260113678, 4623.127633308515, 4626.126418800392, 4710.3405523226775, 1739.330357812226, 3538.4515400113023, 3620.9275814483562, 3673.94489082664, 3859.5947425520476, 821.7124006597643, 947.6020071569957, 979.2068424576116, 1031.5203430404897, 1060.687097306281, 20897.268595599082, 21417.678734818677, 21739.13043478243, 21923.67114493284, 22005.0, 1055.767731099157, 1058.899404556566, 1061.7823346214007, 1063.239783554762, 1066.653337665262, 9860.506974651382, 11258.268212566158, 11510.769784604428, 11516.366599837089, 11519.214521749142, 505923.0, 516706.0, 516928.0, 613511.0, 616157.0, 130664.0, 133635.0, 135835.32082339525, 140210.0, 142795.0, 1022.7903279827617, 1042.6976176908763, 1058.957641694339, 1101.0090918173548, 1102.32207192576, 19298.8070119297, 19465.0, 19556.21775128979, 19615.0, 19629.901850491227, 54276.45723542714, 54347.0, 54697.90604187974, 55135.44864551303, 55419.722901385234, 56783.0, 76257.0, 77480.61259693891, 79454.0, 80612.0, 7905.881411778943, 8044.718434854752, 8100.432969692065, 8135.983002124734, 8306.377021723516, 12123.571004425912, 12692.873071269538, 12750.936245318713, 12914.096013279355, 13101.213927164401, 10634.946825265824, 10905.781884362426, 11091.500882460146, 11142.665720028412, 11283.435828208721, 10835.512401941774, 11116.666500005012, 11171.888281117084, 11217.831732524182, 11285.830712539482, 11277.041451476716, 11292.943535282271, 11349.602763903224, 11594.88405115938, 11619.941900290445, 7268.781936541912, 7957.806329050457, 8154.796130096558, 8160.224778646019, 8222.424430290062, 9328.615550691164, 9644.614215431584, 9747.3664211826, 11297.039751621205, 11317.830232546354], "value": 9608.802735989806, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1416.270620630375, 1526.9083854968699, 1742.6166243426449, 1896.165687097677, 1913.1773337464901, 8050.033995920498, 8645.52449615271, 8700.564971751412, 9134.543272836356, 9155.954220228898, 8797.516136612483, 8848.628462588293, 8961.193492585682, 9018.05310442404, 9021.052789457095, 2027.3816485971772, 2083.427057559176, 2362.5983582790923, 2397.25685037638, 2401.4716762312264, 2352.752960939094, 2366.396568874943, 2396.2930935374106, 2403.3751224681623, 2403.411164264749, 2372.359462945004, 2375.0737212487143, 2383.5709572276983, 2395.532871090138, 2396.0056576520724, 2357.3399448154546, 2358.6226203807396, 2363.4327761337327, 2377.6552399901916, 2379.310000099969, 2275.7838005389463, 2293.289080385069, 2293.736220334666, 2295.5638428698494, 2358.386819426961, 8841.911580884173, 8910.599023043913, 8917.598708058153, 8923.687670931551, 8934.374593778439, 5287.180487024479, 5295.708736019517, 5423.755930983115, 5455.645383050129, 5459.781608735646, 3403.9829800851085, 3449.223924616966, 3636.654517820803, 3697.4453831925157, 3707.5550933888107, 1034.270839058462, 1064.8189807732704, 1087.276960821053, 1109.4508218431847, 1110.9777804443866, 11436.256643318158, 11605.245659032136, 11700.531978720841, 11724.58963936258, 11847.881521184763, 4161.708680392343, 4772.141014617402, 4776.805798550363, 4879.975600121977, 4924.8276310328965, 9886.950565247127, 9955.153811925922, 9976.05227503386, 9980.952000040037, 10006.299559030798, 5203.0, 5232.764525596357, 5269.394019687708, 5307.336582927134, 5406.0809662356705, 4456.242438785414, 4745.5966242869745, 4750.976245118822, 4844.781984810692, 4894.2169252920075, 4035.878923632296, 4042.221422574058, 4061.2080644274674, 4119.752814831119, 4207.915841683149, 1220.8046712525954, 1300.8048792681172, 1302.9674258143623, 1314.5004898138645, 1328.2561765411401, 833.9791505212297, 926.346925417579, 926.5737760630186, 943.5092553765035, 947.5925352098526, 5981.700914954235, 6085.756569737249, 6087.817365479043, 6108.0, 6115.0, 425.28976609062937, 434.48730498012014, 438.94732632084356, 448.15075432056074, 448.1865414273149, 3552.5736911570775, 3816.9503386568363, 3952.9209415812097, 4018.557958624549, 4045.3122969095325, 10479.790404191874, 10701.518431670593, 10834.837477437844, 10842.674719758419, 10853.131749460183, 8818.955905220433, 9292.7676808079, 10387.0, 10621.681349559525, 10690.572377104983, 6904.551204171713, 7841.568713720686, 8092.9479167709, 8206.343492520584, 8321.334293256647, 5110.259012443249, 5844.240248767633, 5865.4134586541, 5914.792982245601, 5923.259592550931, 9689.467079310705, 10016.549255283675, 10073.143782778547, 10087.344322619007, 10281.485925703835, 10049.397036177852, 10086.092251697382, 10217.438040907822, 10230.795384092127, 10337.121344685786, 6596.70314835824, 6996.965015174892, 7377.77866664001, 7640.083190017233, 7674.2325767425045, 7200.459965502503, 8358.373122015752, 8453.36599755033, 8490.15098490146, 8585.18440748128, 7587.279208475186, 7695.615219238904, 7726.575038372718, 7828.725994590162, 7851.1363749988595, 7519.774406767806, 7551.169371369035, 7580.0, 7679.116901556393, 7715.382769378324, 7061.929380706127, 7106.786796396116, 7185.209626941137, 7206.7117315306805, 7219.855602887807, 4861.538153875376, 5055.064813009605, 5077.822276220315, 5117.923231151462, 5126.666766660155, 4904.485029071896, 5082.796688132581, 5104.563306154178, 5119.590432765295, 5208.791648334024], "value": 4517.339519411442, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.656892857678, 309.14983794564944, 313.68944744702736, 317.9809211447315, 321.686355803092, 4687.273472611746, 4706.011737535117, 5107.846764597059, 5274.92087618685, 5374.91937620936, 4913.3612630358, 5579.163125531172, 5620.634658747179, 5631.198940715011, 5646.322441307038, 3958.5447673517624, 4254.978725106385, 4274.97862510687, 4284.892877678052, 4288.463942007249, 3749.737518373715, 4023.9597604024025, 4143.990164770084, 4196.817654819492, 4288.228118938589, 3520.926117534151, 4156.812943417538, 4172.97913510432, 4195.8741237762915, 4221.493420789509, 3393.4231180699217, 3909.1236206620697, 4251.489821221442, 4258.87223383299, 4274.862568715642, 3122.4223518649123, 3454.29187016661, 3528.6471352864764, 3697.334479793636, 3717.702583793317, 4585.15716294639, 4686.617447852857, 5253.50091741284, 5345.4387289334445, 5380.784768609251, 4862.635302352338, 4882.7558622068755, 4886.193778026657, 4919.926201106986, 4931.90136197274, 4985.853253751658, 5907.616004959664, 5929.471964181305, 5938.020226662638, 5963.970180149072, 3261.4618587932964, 3481.1471189558465, 3685.870994515179, 3972.543157536891, 4022.4971878515184, 4935.827246046371, 6226.221722284715, 6231.3145553989025, 6237.845998490248, 6275.403836635513, 4008.178323443687, 4017.8392864285684, 4025.4364388985564, 4069.4709687740406, 4089.2230476209425, 3808.771473711586, 4071.959280407217, 4083.387491876242, 4085.8774236772942, 4099.549049604541, 4407.272799987966, 4476.597106260452, 4634.165850146938, 4739.838739508842, 4779.784909679072, 4824.396950381202, 5525.309336332958, 5630.521405680481, 5743.966086104541, 5759.222504961776, 1264.7091169030991, 1309.299524754252, 1350.6083235861686, 1374.202962281874, 1387.1746310944973, 685.9279775623488, 751.0911796726023, 794.4915254237293, 797.8563858505408, 818.9385796065319, 3982.561918188997, 4253.659707223476, 4341.044970106572, 4663.976680116645, 4729.0, 4409.735415875058, 4665.673402861835, 4737.9052418952115, 5189.55888749453, 5231.494898418069, 4132.152908653718, 4203.078860192137, 4277.379779931893, 4502.617277531381, 4687.859364219079, 2594.3773494361594, 2658.9335266618104, 2763.709810469912, 2766.944661106807, 2777.6944536101014, 4647.6281897448125, 4819.060373172362, 4859.781309841065, 5389.086874159695, 5402.730358365781, 4578.793954272066, 4683.5082316356975, 4914.582260507826, 5099.337086178847, 5341.706206158621, 4911.484294149206, 5051.686561493964, 5163.225516172529, 5330.786768529216, 5385.515303622615, 4246.957530424656, 5158.690478571148, 5171.63798534099, 5176.611754118381, 5202.947970520398, 4136.669066474735, 4448.5773851484055, 4879.2190850340085, 5099.495648783692, 5491.945080549143, 5008.874778130576, 6207.410296021871, 6247.437730604267, 6395.360463953567, 6437.034444833313, 3530.2762933599065, 4013.7958612415573, 4056.4320995061307, 4072.898177545585, 4090.304648209871, 5376.489233522809, 5895.263092113486, 5970.5223582114195, 6166.907496387647, 6231.0, 5103.504099691723, 5107.157319042316, 5469.9915046723345, 5491.643043202179, 5721.370649228498, 5730.971345143247, 5971.790987315423, 5991.490723288569, 5996.4603185713495, 6008.0687493436835, 5599.468050535193, 5637.0, 5793.102069179284, 5841.561882858888, 5843.883122337615, 5100.27135482515, 5551.944480555304, 5683.687397193029, 5775.653460792198, 6003.969980150246, 5188.273641690242, 5462.180672899097, 5558.221848941233, 5811.970940145272, 5896.587238893237], "value": 4045.9645969334315, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [724.6992498113283, 770.0451440214133, 797.8125140591964, 853.8804567360567, 886.2466903132337, 14362.497312594061, 14973.02675326103, 15160.090394576333, 15174.848251517482, 15214.391424343026, 12598.559050433236, 12877.935610321958, 13948.605139486071, 13970.37133329, 13986.720265594682, 710.0804458226609, 872.0538216035609, 884.8584226523758, 904.6110172625769, 911.9088091190861, 870.6865528409768, 882.8852249207627, 896.1083721696921, 906.1074841281333, 908.4413085952158, 956.6460409648405, 962.7352478068552, 962.956666949989, 964.4840010594334, 966.0580933589729, 918.8713580098791, 919.4621146629163, 919.5126582911067, 934.6635211323952, 962.340796554359, 685.3694600967123, 687.9415249703782, 709.4643544124153, 713.6467448612918, 715.2525610736792, 14089.0, 14178.574642760734, 14239.715205695931, 14291.499797507038, 14316.713665726627, 13828.792568111487, 13883.930580347134, 13904.165750055028, 13948.721025579533, 13963.65090872726, 9832.262580306435, 11576.594819181288, 11677.591284305094, 11684.649460516199, 11872.990795782369, 3787.621237876218, 3802.790846503441, 3821.980890095532, 3836.2327534492933, 3870.6709929656013, 79191.20808791896, 79283.41433171362, 79397.01507462302, 80897.59551202266, 81402.59298703528, 9772.755681107887, 10886.40124793144, 11020.953009464089, 11021.669349919515, 11105.888941110647, 18551.72172417415, 19409.90295048544, 20043.699344509845, 21152.153913843274, 21187.258445954318, 7741.961290193513, 7879.0, 8040.71857484997, 8148.837023259502, 8206.0, 3574.873914716856, 3688.7971161585833, 3809.191332319289, 4062.923325318793, 4469.508354081048, 3186.490161574137, 3535.2045789697113, 3537.699295559906, 3540.433530635086, 3541.256336169382, 564.2241917363625, 671.7917445591883, 676.1683129750336, 685.533836990841, 689.9068625735462, 664.7374287156546, 673.182083768224, 709.1808960650457, 709.4111887133666, 712.7647876200945, 9239.0, 9249.90750092504, 9315.005681705035, 9452.57463414148, 9564.0, 619.804761500126, 657.1752450674469, 683.8563901580724, 698.6681326369934, 719.9640017999079, 4242.278812601865, 4402.515723270438, 4439.9778001110435, 4442.911141777146, 4487.955120448819, 63068.68465657642, 79697.60151199206, 80494.19505804867, 83626.0, 83803.0, 59697.70151149217, 65538.67230663817, 78577.21422785813, 80165.59917200377, 82639.5868020656, 58818.0, 64142.717145656825, 64852.35147648557, 65137.0, 65391.34608653947, 8622.396432249683, 8645.438046526955, 8663.91336086631, 8748.65005399777, 8876.801631779626, 43654.126917462105, 44856.551434486544, 45162.548374515834, 45416.54583454255, 45581.77209113933, 59095.40904590899, 62897.0, 62924.0, 62955.055674165844, 62961.0, 11600.94199528997, 11720.824187637363, 11891.227070240408, 11911.40442977865, 12084.033277337616, 11690.824637630272, 12017.459214335551, 12223.93888030554, 12358.62924112278, 12506.124571279923, 11824.76350473003, 11837.408129593658, 12044.457999389873, 12133.514659413524, 12136.939315303367, 11732.12009099338, 11984.28094314344, 12032.0, 12094.153409261267, 12101.576444824388, 11371.772564548828, 11490.023348015513, 11724.413779311171, 11923.880761192277, 12017.879821201675, 8605.698800541952, 9786.314957952874, 9824.890587806933, 9855.704328870146, 10101.595936162765, 9841.034051313623, 10060.69817905464, 10107.545160467944, 10127.949360253151, 10128.189744820544], "value": 7047.192356592992, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1607.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 109.0, 116.0, 115.0, 117.0, 117.0, 117.0, 117.0, 121.0, 162.0], "value": 121.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 148.0, 173.0, 155.0, 139.0, 173.0, 167.0, 109.0, 159.0, 114.0], "value": 149.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 204.0, 248.0, 273.0, 197.0, 204.0, 200.0, 194.0, 198.0, 197.0], "value": 210.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 82.0, 85.0, 141.0, 69.0, 79.0, 82.0, 77.0, 136.0, 67.0], "value": 89.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 123.0, 79.0, 103.0, 110.0, 152.0, 82.0, 73.0, 116.0], "value": 97.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 88.0, 91.0, 89.0, 91.0, 123.0, 78.0, 132.0, 125.0, 88.0], "value": 99.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 97.0, 96.0, 135.0, 135.0, 98.0, 116.0, 152.0, 112.0, 96.0], "value": 113.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 90.0, 90.0, 91.0, 92.0, 124.0, 148.0, 115.0, 91.0, 93.0], "value": 103.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 70.0, 62.0, 52.0, 55.0, 56.0, 57.0, 55.0, 57.0], "value": 57.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 71.0, 72.0, 80.0, 79.0, 70.0, 74.0, 70.0, 69.0], "value": 72.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 86.0, 78.0, 109.0, 105.0, 107.0, 106.0, 116.0, 107.0], "value": 98.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 123.0, 169.0, 149.0, 168.0, 132.0, 144.0, 131.0, 159.0, 156.0], "value": 148.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 225.0, 222.0, 175.0, 162.0, 167.0, 163.0, 170.0, 165.0, 163.0], "value": 179.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 64.0, 65.0, 67.0, 66.0, 65.0, 66.0, 67.0], "value": 65.7, "unit": "score"}]}]} 07:15:29 INFO - Return code: 0 07:15:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:15:29 ERROR - # TBPL SUCCESS # 07:15:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:15:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:15:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:15:29 INFO - 2016-05-27 07:15:29.114 screenresolution[2310:28383] starting screenresolution argv=screenresolution get 07:15:29 INFO - 2016-05-27 07:15:29.117 screenresolution[2310:28383] Display 0: 1600x1200x32@60 07:15:29 INFO - 2016-05-27 07:15:29.123 screenresolution[2311:28386] starting screenresolution argv=screenresolution list 07:15:29 INFO - Available Modes on Display 0 07:15:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:15:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:15:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:15:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:15:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:15:29 INFO - Intel Iris: 07:15:29 INFO - Chipset Model: Intel Iris 07:15:29 INFO - Type: GPU 07:15:29 INFO - Bus: Built-In 07:15:29 INFO - VRAM (Dynamic, Max): 1536 MB 07:15:29 INFO - Vendor: Intel (0x8086) 07:15:29 INFO - Device ID: 0x0a2e 07:15:29 INFO - Revision ID: 0x0009 07:15:29 INFO - Displays: 07:15:29 INFO - Display: 07:15:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:15:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:15:29 INFO - Display Serial Number: 1600x1200 60 07:15:29 INFO - Main Display: Yes 07:15:29 INFO - Mirror: Off 07:15:29 INFO - Online: Yes 07:15:29 INFO - Rotation: Supported 07:15:29 INFO - Return code: 0 07:15:29 INFO - Running post-action listener: _resource_record_post_action 07:15:29 INFO - ##### 07:15:29 INFO - ##### Finished run-tests step (success) 07:15:29 INFO - ##### 07:15:29 INFO - Running post-run listener: _resource_record_post_run 07:15:29 INFO - Total resource usage - Wall time: 1210s; CPU: 55.0%; Read bytes: 0; Write bytes: 698049024; Read time: 0; Write time: 1933 07:15:29 INFO - TinderboxPrint: CPU usage
54.7% 07:15:29 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 07:15:29 INFO - TinderboxPrint: I/O write bytes / time
698,049,024 / 1,933 07:15:29 INFO - TinderboxPrint: CPU idle
2,195.4 (45.3%) 07:15:29 INFO - TinderboxPrint: CPU system
980.2 (20.2%) 07:15:29 INFO - TinderboxPrint: CPU user
1,666.0 (34.4%) 07:15:29 INFO - TinderboxPrint: Swap in / out
397,094,912 / 0 07:15:29 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 389423616; Write bytes: 384703488; Read time: 29450; Write time: 775 07:15:29 INFO - run-tests - Wall time: 1176s; CPU: 55.0%; Read bytes: 0; Write bytes: 295941632; Read time: 0; Write time: 1113 07:15:29 INFO - Running post-run listener: _upload_blobber_files 07:15:29 INFO - Blob upload gear active. 07:15:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:15:29 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 07:15:29 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'] 07:15:29 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 07:15:30 INFO - (blobuploader) - INFO - Open directory for files ... 07:15:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:15:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:15:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:15:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:15:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:15:30 INFO - (blobuploader) - INFO - Done attempting. 07:15:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:15:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:15:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:15:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:15:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:15:31 INFO - (blobuploader) - INFO - Done attempting. 07:15:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:15:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:15:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:15:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:15:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:15:34 INFO - (blobuploader) - INFO - Done attempting. 07:15:34 INFO - (blobuploader) - INFO - Iteration through files over. 07:15:34 INFO - Return code: 0 07:15:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:15:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:15:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9507444b5d5b92fe9e46ed36cfec7f706faa0337c17310596277229d68598e5b5906b0726b7f1bfbc8eda2b28bdac8c26e2e38f5e22265c4d59346a80030af1a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/57cf488a618cc8dbae62a8e1d44c3870aded8a8e16f9dc1981a4345e385445f694ae8d0c93c999e65d0c5b91e5a3480bf7074a2c192df169faf26fdfdc0d0b5f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8affc7dc26c6fc7ecdb226f1f9df3cd4407458a4ab344dedee8a95e21202336e70245c0687b4d76421fe881d2e782e007fd8351ff102df5e06fd74e0bf5919d4"} 07:15:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:15:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:15:34 INFO - Contents: 07:15:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9507444b5d5b92fe9e46ed36cfec7f706faa0337c17310596277229d68598e5b5906b0726b7f1bfbc8eda2b28bdac8c26e2e38f5e22265c4d59346a80030af1a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/57cf488a618cc8dbae62a8e1d44c3870aded8a8e16f9dc1981a4345e385445f694ae8d0c93c999e65d0c5b91e5a3480bf7074a2c192df169faf26fdfdc0d0b5f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8affc7dc26c6fc7ecdb226f1f9df3cd4407458a4ab344dedee8a95e21202336e70245c0687b4d76421fe881d2e782e007fd8351ff102df5e06fd74e0bf5919d4"} 07:15:34 INFO - Running post-run listener: copy_logs_to_upload_dir 07:15:34 INFO - Copying logs to upload dir... 07:15:34 INFO - mkdir: /builds/slave/test/build/upload/logs 07:15:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1304.728048 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 44 secs) (at 2016-05-27 07:15:34.429886) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 07:15:34.433912) ========= 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.kzeXQmkHmQ/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.n4APxajmty/Listeners TMPDIR=/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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/9507444b5d5b92fe9e46ed36cfec7f706faa0337c17310596277229d68598e5b5906b0726b7f1bfbc8eda2b28bdac8c26e2e38f5e22265c4d59346a80030af1a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/57cf488a618cc8dbae62a8e1d44c3870aded8a8e16f9dc1981a4345e385445f694ae8d0c93c999e65d0c5b91e5a3480bf7074a2c192df169faf26fdfdc0d0b5f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8affc7dc26c6fc7ecdb226f1f9df3cd4407458a4ab344dedee8a95e21202336e70245c0687b4d76421fe881d2e782e007fd8351ff102df5e06fd74e0bf5919d4"} build_url:https://queue.taskcluster.net/v1/task/MjZG5n8jTRylns8g3OlsCw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011044 build_url: 'https://queue.taskcluster.net/v1/task/MjZG5n8jTRylns8g3OlsCw/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/9507444b5d5b92fe9e46ed36cfec7f706faa0337c17310596277229d68598e5b5906b0726b7f1bfbc8eda2b28bdac8c26e2e38f5e22265c4d59346a80030af1a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/57cf488a618cc8dbae62a8e1d44c3870aded8a8e16f9dc1981a4345e385445f694ae8d0c93c999e65d0c5b91e5a3480bf7074a2c192df169faf26fdfdc0d0b5f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8affc7dc26c6fc7ecdb226f1f9df3cd4407458a4ab344dedee8a95e21202336e70245c0687b4d76421fe881d2e782e007fd8351ff102df5e06fd74e0bf5919d4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 07:15:34.464833) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 07:15:34.465190) ========= 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.kzeXQmkHmQ/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.n4APxajmty/Listeners TMPDIR=/var/folders/t9/3mb18jg53rv4js3q7pg726c000000w/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.005266 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 07:15:34.514813) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 07:15:34.515201) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 07:15:34.515637) ========= ========= Total master_lag: 0.18 =========