builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0295 starttime: 1464080488.91 results: success (0) buildid: 20160524000618 builduid: ed1d46c3532145ebbf1522783cdba228 revision: 00f9eb3e72e805caebd204b780dc904877cab590 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 02:01:28.908002) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 02:01:28.908415) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 02:01:28.908721) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 02:01:28.933827) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 02:01:28.934185) ========= 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.e2wh4c73nC/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.3EEyC2V988/Listeners TMPDIR=/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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-24 02:01:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 150M=0s 2016-05-24 02:01:29 (150 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105621 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 02:01:29.061379) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 02:01:29.062133) ========= 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.e2wh4c73nC/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.3EEyC2V988/Listeners TMPDIR=/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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.020600 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 02:01:29.114019) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 02:01:29.114790) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 00f9eb3e72e805caebd204b780dc904877cab590 --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 00f9eb3e72e805caebd204b780dc904877cab590 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.e2wh4c73nC/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.3EEyC2V988/Listeners TMPDIR=/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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-24 02:01:29,154 truncating revision to first 12 chars 2016-05-24 02:01:29,154 Setting DEBUG logging. 2016-05-24 02:01:29,154 attempt 1/10 2016-05-24 02:01:29,155 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/00f9eb3e72e8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-24 02:01:29,779 unpacking tar archive at: fx-team-00f9eb3e72e8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.873201 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 02:01:30.011856) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 02:01:30.012640) ========= script_repo_revision: 00f9eb3e72e805caebd204b780dc904877cab590 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 02:01:30.013401) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 02:01:30.013712) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 02:01:30.028906) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-05-24 02:01:30.029518) ========= /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.e2wh4c73nC/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.3EEyC2V988/Listeners TMPDIR=/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 02:01:30 INFO - MultiFileLogger online at 20160524 02:01:30 in /builds/slave/test 02:01:30 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 02:01:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:01:30 INFO - {'append_to_log': False, 02:01:30 INFO - 'base_work_dir': '/builds/slave/test', 02:01:30 INFO - 'blob_upload_branch': 'Fx-Team', 02:01:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:01:30 INFO - 'branch': 'Fx-Team', 02:01:30 INFO - 'buildbot_json_path': 'buildprops.json', 02:01:30 INFO - 'config_files': ('talos/mac_config.py',), 02:01:30 INFO - 'default_actions': ('clobber', 02:01:30 INFO - 'read-buildbot-config', 02:01:30 INFO - 'download-and-extract', 02:01:30 INFO - 'populate-webroot', 02:01:30 INFO - 'create-virtualenv', 02:01:30 INFO - 'install', 02:01:30 INFO - 'run-tests'), 02:01:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:01:30 INFO - 'download_minidump_stackwalk': True, 02:01:30 INFO - 'download_symbols': 'ondemand', 02:01:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:01:30 INFO - 'tooltool.py': '/tools/tooltool.py', 02:01:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:01:30 INFO - '/tools/misc-python/virtualenv.py')}, 02:01:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:01:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:01:30 INFO - 'installer_path': 'installer.exe', 02:01:30 INFO - 'log_level': 'info', 02:01:30 INFO - 'log_name': 'talos', 02:01:30 INFO - 'log_to_console': True, 02:01:30 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:01:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:01:30 INFO - 'opt_config_files': (), 02:01:30 INFO - 'pip_index': False, 02:01:30 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:01:30 INFO - 'cmd': ('bash', 02:01:30 INFO - '-c', 02:01:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:01:30 INFO - 'enabled': True, 02:01:30 INFO - 'halt_on_failure': False, 02:01:30 INFO - 'name': 'check_screen_resolution'},), 02:01:30 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:01:30 INFO - 'cmd': ('bash', 02:01:30 INFO - '-c', 02:01:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:01:30 INFO - 'enabled': True, 02:01:30 INFO - 'halt_on_failure': False, 02:01:30 INFO - 'name': 'check_screen_resolution'},), 02:01:30 INFO - 'run_cmd_checks_enabled': True, 02:01:30 INFO - 'sps_profile': False, 02:01:30 INFO - 'sps_profile_interval': 0, 02:01:30 INFO - 'suite': 'dromaeojs-e10s', 02:01:30 INFO - 'system_bits': '32', 02:01:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:01:30 INFO - 'title': 't-yosemite-r7-0295', 02:01:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:01:30 INFO - 'use_talos_json': True, 02:01:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:01:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:01:30 INFO - 'work_dir': 'build'} 02:01:30 INFO - ##### 02:01:30 INFO - ##### Running clobber step. 02:01:30 INFO - ##### 02:01:30 INFO - Running pre-action listener: _resource_record_pre_action 02:01:30 INFO - Running main action method: clobber 02:01:30 INFO - rmtree: /builds/slave/test/build 02:01:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:01:32 INFO - Running post-action listener: _resource_record_post_action 02:01:32 INFO - ##### 02:01:32 INFO - ##### Finished clobber step (success) 02:01:32 INFO - ##### 02:01:32 INFO - ##### 02:01:32 INFO - ##### Running read-buildbot-config step. 02:01:32 INFO - ##### 02:01:32 INFO - Running pre-action listener: _resource_record_pre_action 02:01:32 INFO - Running main action method: read_buildbot_config 02:01:32 INFO - Using buildbot properties: 02:01:32 INFO - { 02:01:32 INFO - "project": "", 02:01:32 INFO - "product": "firefox", 02:01:32 INFO - "script_repo_revision": "production", 02:01:32 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 02:01:32 INFO - "repository": "", 02:01:32 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 02:01:32 INFO - "buildid": "20160524000618", 02:01:32 INFO - "pgo_build": "False", 02:01:32 INFO - "basedir": "/builds/slave/test", 02:01:32 INFO - "buildnumber": 14, 02:01:32 INFO - "slavename": "t-yosemite-r7-0295", 02:01:32 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 02:01:32 INFO - "platform": "yosemite_r7", 02:01:32 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 02:01:32 INFO - "branch": "fx-team", 02:01:32 INFO - "repo_path": "integration/fx-team", 02:01:32 INFO - "revision": "00f9eb3e72e805caebd204b780dc904877cab590", 02:01:32 INFO - "stage_platform": "macosx64", 02:01:32 INFO - "builduid": "ed1d46c3532145ebbf1522783cdba228", 02:01:32 INFO - "slavebuilddir": "test" 02:01:32 INFO - } 02:01:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/aIJ4r_sbT1q3WFnjBl9moA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 02:01:32 INFO - Running post-action listener: _resource_record_post_action 02:01:32 INFO - ##### 02:01:32 INFO - ##### Finished read-buildbot-config step (success) 02:01:32 INFO - ##### 02:01:32 INFO - ##### 02:01:32 INFO - ##### Running download-and-extract step. 02:01:32 INFO - ##### 02:01:32 INFO - Running pre-action listener: _resource_record_pre_action 02:01:32 INFO - Running main action method: download_and_extract 02:01:32 INFO - mkdir: /builds/slave/test/build/tests 02:01:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:32 INFO - https://queue.taskcluster.net/v1/task/aIJ4r_sbT1q3WFnjBl9moA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 02:01:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aIJ4r_sbT1q3WFnjBl9moA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 02:01:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aIJ4r_sbT1q3WFnjBl9moA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 02:01:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aIJ4r_sbT1q3WFnjBl9moA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 02:01:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aIJ4r_sbT1q3WFnjBl9moA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 02:01:33 INFO - Downloaded 1199 bytes. 02:01:33 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 02:01:33 INFO - Using the following test package requirements: 02:01:33 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 02:01:33 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 02:01:33 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 02:01:33 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 02:01:33 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 02:01:33 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 02:01:33 INFO - u'jsshell-mac.zip'], 02:01:33 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 02:01:33 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 02:01:33 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 02:01:33 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 02:01:33 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 02:01:33 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 02:01:33 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 02:01:33 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 02:01:33 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 02:01:33 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 02:01:33 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 02:01:33 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:01: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')]} 02:01:33 INFO - https://queue.taskcluster.net/v1/task/aIJ4r_sbT1q3WFnjBl9moA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:01:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aIJ4r_sbT1q3WFnjBl9moA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 02:01:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aIJ4r_sbT1q3WFnjBl9moA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 02:01:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aIJ4r_sbT1q3WFnjBl9moA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 02:01:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aIJ4r_sbT1q3WFnjBl9moA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:01:34 INFO - Downloaded 18630470 bytes. 02:01:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:01:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 02:01:37 INFO - Return code: 0 02:01:37 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 02:01:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:37 INFO - https://queue.taskcluster.net/v1/task/aIJ4r_sbT1q3WFnjBl9moA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:01:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aIJ4r_sbT1q3WFnjBl9moA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 02:01:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aIJ4r_sbT1q3WFnjBl9moA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 02:01:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aIJ4r_sbT1q3WFnjBl9moA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 02:01:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aIJ4r_sbT1q3WFnjBl9moA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:01:39 INFO - Downloaded 18630470 bytes. 02:01:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:01:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 02:01:42 INFO - Return code: 0 02:01:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:42 INFO - https://queue.taskcluster.net/v1/task/aIJ4r_sbT1q3WFnjBl9moA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:01:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aIJ4r_sbT1q3WFnjBl9moA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 02:01:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aIJ4r_sbT1q3WFnjBl9moA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 02:01:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aIJ4r_sbT1q3WFnjBl9moA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 02:01:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aIJ4r_sbT1q3WFnjBl9moA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 02:01:43 INFO - Downloaded 10840359 bytes. 02:01:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:01:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 02:01:43 INFO - Return code: 0 02:01:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:43 INFO - https://queue.taskcluster.net/v1/task/aIJ4r_sbT1q3WFnjBl9moA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 02:01:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aIJ4r_sbT1q3WFnjBl9moA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 02:01:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aIJ4r_sbT1q3WFnjBl9moA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 02:01:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aIJ4r_sbT1q3WFnjBl9moA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 02:01:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aIJ4r_sbT1q3WFnjBl9moA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 02:01:46 INFO - Downloaded 110166037 bytes. 02:01:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aIJ4r_sbT1q3WFnjBl9moA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 02:01:46 INFO - mkdir: /builds/slave/test/properties 02:01:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:01:46 INFO - Writing to file /builds/slave/test/properties/build_url 02:01:46 INFO - Contents: 02:01:46 INFO - build_url:https://queue.taskcluster.net/v1/task/aIJ4r_sbT1q3WFnjBl9moA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 02:01:48 INFO - Running post-action listener: _resource_record_post_action 02:01:48 INFO - Running post-action listener: set_extra_try_arguments 02:01:48 INFO - ##### 02:01:48 INFO - ##### Finished download-and-extract step (success) 02:01:48 INFO - ##### 02:01:48 INFO - ##### 02:01:48 INFO - ##### Running populate-webroot step. 02:01:48 INFO - ##### 02:01:48 INFO - Running pre-action listener: _resource_record_pre_action 02:01:48 INFO - Running main action method: populate_webroot 02:01:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:01:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:01:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:01:48 INFO - '--tppagecycles', 02:01:48 INFO - '7'], 02:01:48 INFO - 'tests': ['tsvgm']}}, 02:01:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:01:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:01:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:01:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:01:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:01:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:01:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:01:48 INFO - 'talos_options': ['--disable-e10s'], 02:01:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:01:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:01:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:01:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:01:48 INFO - 'talos_options': ['--disable-e10s'], 02:01:48 INFO - 'tests': ['damp', 'tps']}, 02:01:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:01:48 INFO - 'tests': ['damp', 'tps']}, 02:01:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:01:48 INFO - 'tests': ['dromaeo_dom']}, 02:01:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:01:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:01:48 INFO - 'tests': ['a11yr', 02:01:48 INFO - 'ts_paint', 02:01:48 INFO - 'tpaint', 02:01:48 INFO - 'sessionrestore', 02:01:48 INFO - 'sessionrestore_no_auto_restore', 02:01:48 INFO - 'tabpaint']}, 02:01:48 INFO - 'other-e10s': {'tests': ['a11yr', 02:01:48 INFO - 'ts_paint', 02:01:48 INFO - 'tpaint', 02:01:48 INFO - 'sessionrestore', 02:01:48 INFO - 'sessionrestore_no_auto_restore', 02:01:48 INFO - 'tabpaint']}, 02:01:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:01:48 INFO - 'ts_paint', 02:01:48 INFO - 'tpaint', 02:01:48 INFO - 'sessionrestore', 02:01:48 INFO - 'sessionrestore_no_auto_restore', 02:01:48 INFO - 'tabpaint']}, 02:01:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:01:48 INFO - 'ts_paint', 02:01:48 INFO - 'tpaint', 02:01:48 INFO - 'sessionrestore', 02:01:48 INFO - 'sessionrestore_no_auto_restore', 02:01:48 INFO - 'tabpaint']}, 02:01:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:01:48 INFO - 'tests': ['a11yr', 02:01:48 INFO - 'ts_paint', 02:01:48 INFO - 'tpaint', 02:01:48 INFO - 'sessionrestore', 02:01:48 INFO - 'sessionrestore_no_auto_restore', 02:01:48 INFO - 'tabpaint']}, 02:01:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:01:48 INFO - 'tests': ['a11yr', 02:01:48 INFO - 'ts_paint', 02:01:48 INFO - 'tpaint', 02:01:48 INFO - 'sessionrestore', 02:01:48 INFO - 'sessionrestore_no_auto_restore', 02:01:48 INFO - 'tabpaint']}, 02:01:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:01:48 INFO - 'tests': ['tsvgx', 02:01:48 INFO - 'tsvgr_opacity', 02:01:48 INFO - 'tart', 02:01:48 INFO - 'tscrollx', 02:01:48 INFO - 'cart']}, 02:01:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:01:48 INFO - 'tsvgr_opacity', 02:01:48 INFO - 'tart', 02:01:48 INFO - 'tscrollx', 02:01:48 INFO - 'cart']}, 02:01:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:01:48 INFO - 'talos_options': ['--disable-e10s'], 02:01:48 INFO - 'tests': ['tp5o']}, 02:01:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:01:48 INFO - 'tests': ['tp5o']}, 02:01:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:01:48 INFO - 'talos_options': ['--disable-e10s', 02:01:48 INFO - '--xperf_path', 02:01:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:01:48 INFO - 'tests': ['tp5n']}, 02:01:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:01:48 INFO - 'talos_options': ['--xperf_path', 02:01:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:01:48 INFO - 'tests': ['tp5n']}}, 02:01:48 INFO - 'talos.zip': {'path': '', 02:01:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:01:48 INFO - Running post-action listener: _resource_record_post_action 02:01:48 INFO - ##### 02:01:48 INFO - ##### Finished populate-webroot step (success) 02:01:48 INFO - ##### 02:01:48 INFO - ##### 02:01:48 INFO - ##### Running create-virtualenv step. 02:01:48 INFO - ##### 02:01:48 INFO - Running pre-action listener: _resource_record_pre_action 02:01:48 INFO - Running main action method: create_virtualenv 02:01:48 INFO - Creating virtualenv /builds/slave/test/build/venv 02:01:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:01:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:01:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:01:48 INFO - Using real prefix '/tools/python27' 02:01:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:01:48 INFO - Installing distribute.............................................................................................................................................................................................done. 02:01:51 INFO - Installing pip.................done. 02:01:51 INFO - Return code: 0 02:01:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:01:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:51 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 0x10ca6fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca75570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f918a553830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c913d30>, '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 0x10c737db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c90ab20>, '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.e2wh4c73nC/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.3EEyC2V988/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:01:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:01:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:01:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e2wh4c73nC/Render', 02:01:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:01:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:01:51 INFO - 'HOME': '/Users/cltbld', 02:01:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:01:51 INFO - 'LOGNAME': 'cltbld', 02:01:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:51 INFO - 'MOZ_NO_REMOTE': '1', 02:01:51 INFO - 'NO_EM_RESTART': '1', 02:01:51 INFO - 'PAGER': '/bin/cat', 02:01:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:01:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:51 INFO - 'PWD': '/builds/slave/test', 02:01:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:01:51 INFO - 'SHELL': '/bin/bash', 02:01:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3EEyC2V988/Listeners', 02:01:51 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 02:01:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:01:51 INFO - 'USER': 'cltbld', 02:01:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:01:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:01:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:51 INFO - 'XPC_FLAGS': '0x0', 02:01:51 INFO - 'XPC_SERVICE_NAME': '0', 02:01:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:01:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:52 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:01:52 INFO - Cleaning up... 02:01:52 INFO - Return code: 0 02:01:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:01:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ca6fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca75570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f918a553830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c913d30>, '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 0x10c737db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c90ab20>, '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.e2wh4c73nC/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.3EEyC2V988/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:01:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:01:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:01:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e2wh4c73nC/Render', 02:01:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:01:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:01:52 INFO - 'HOME': '/Users/cltbld', 02:01:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:01:52 INFO - 'LOGNAME': 'cltbld', 02:01:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:52 INFO - 'MOZ_NO_REMOTE': '1', 02:01:52 INFO - 'NO_EM_RESTART': '1', 02:01:52 INFO - 'PAGER': '/bin/cat', 02:01:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:01:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:52 INFO - 'PWD': '/builds/slave/test', 02:01:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:01:52 INFO - 'SHELL': '/bin/bash', 02:01:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3EEyC2V988/Listeners', 02:01:52 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 02:01:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:01:52 INFO - 'USER': 'cltbld', 02:01:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:01:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:01:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:52 INFO - 'XPC_FLAGS': '0x0', 02:01:52 INFO - 'XPC_SERVICE_NAME': '0', 02:01:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:01:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:52 INFO - Downloading/unpacking psutil>=3.1.1 02:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:01:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:01:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:01:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:01:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:01:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:01:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:01:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:01:55 INFO - Installing collected packages: psutil 02:01:55 INFO - Running setup.py install for psutil 02:01:55 INFO - building 'psutil._psutil_osx' extension 02:01:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 02:01:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 02:01:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 02:01:55 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 02:01:55 INFO - building 'psutil._psutil_posix' extension 02:01:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 02:01:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:01:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:01:55 INFO - ^ 02:01:56 INFO - 1 warning generated. 02:01:56 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 02:01:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:01:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:01:56 INFO - Successfully installed psutil 02:01:56 INFO - Cleaning up... 02:01:56 INFO - Return code: 0 02:01:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:01: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')]} 02:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01: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')]} 02:01:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ca6fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca75570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f918a553830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c913d30>, '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 0x10c737db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c90ab20>, '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.e2wh4c73nC/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.3EEyC2V988/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:01: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:01: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 mozsystemmonitor==0.3 02:01:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e2wh4c73nC/Render', 02:01:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:01:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:01:56 INFO - 'HOME': '/Users/cltbld', 02:01:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:01:56 INFO - 'LOGNAME': 'cltbld', 02:01:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:56 INFO - 'MOZ_NO_REMOTE': '1', 02:01:56 INFO - 'NO_EM_RESTART': '1', 02:01:56 INFO - 'PAGER': '/bin/cat', 02:01:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:01:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:56 INFO - 'PWD': '/builds/slave/test', 02:01:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:01:56 INFO - 'SHELL': '/bin/bash', 02:01:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3EEyC2V988/Listeners', 02:01:56 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 02:01:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:01:56 INFO - 'USER': 'cltbld', 02:01:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:01:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:01:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:56 INFO - 'XPC_FLAGS': '0x0', 02:01:56 INFO - 'XPC_SERVICE_NAME': '0', 02:01:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:01:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:01:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:01:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:01:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:01:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:01:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:01:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:01:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:01:59 INFO - Installing collected packages: mozsystemmonitor 02:01:59 INFO - Running setup.py install for mozsystemmonitor 02:01:59 INFO - Successfully installed mozsystemmonitor 02:01:59 INFO - Cleaning up... 02:01:59 INFO - Return code: 0 02:01:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:01:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:59 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 0x10ca6fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca75570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f918a553830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c913d30>, '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 0x10c737db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c90ab20>, '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.e2wh4c73nC/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.3EEyC2V988/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:01:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:01:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:01:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e2wh4c73nC/Render', 02:01:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:01:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:01:59 INFO - 'HOME': '/Users/cltbld', 02:01:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:01:59 INFO - 'LOGNAME': 'cltbld', 02:01:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:59 INFO - 'MOZ_NO_REMOTE': '1', 02:01:59 INFO - 'NO_EM_RESTART': '1', 02:01:59 INFO - 'PAGER': '/bin/cat', 02:01:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:01:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:59 INFO - 'PWD': '/builds/slave/test', 02:01:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:01:59 INFO - 'SHELL': '/bin/bash', 02:01:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3EEyC2V988/Listeners', 02:01:59 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 02:01:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:01:59 INFO - 'USER': 'cltbld', 02:01:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:01:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:01:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:59 INFO - 'XPC_FLAGS': '0x0', 02:01:59 INFO - 'XPC_SERVICE_NAME': '0', 02:01:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:01:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:59 INFO - Downloading/unpacking blobuploader==1.2.4 02:01: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 02:01: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 02:01: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 02:01: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 02:01: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 02:01: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 02:02:02 INFO - Downloading blobuploader-1.2.4.tar.gz 02:02:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:02:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:02:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:03 INFO - Downloading docopt-0.6.1.tar.gz 02:02:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:02:03 INFO - Installing collected packages: blobuploader, requests, docopt 02:02:03 INFO - Running setup.py install for blobuploader 02:02:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:02:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:02:03 INFO - Running setup.py install for requests 02:02:03 INFO - Running setup.py install for docopt 02:02:04 INFO - Successfully installed blobuploader requests docopt 02:02:04 INFO - Cleaning up... 02:02:04 INFO - Return code: 0 02:02:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:02:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:04 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 0x10ca6fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca75570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f918a553830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c913d30>, '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 0x10c737db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c90ab20>, '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.e2wh4c73nC/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.3EEyC2V988/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:02:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:02:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:02:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e2wh4c73nC/Render', 02:02:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:02:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:02:04 INFO - 'HOME': '/Users/cltbld', 02:02:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:02:04 INFO - 'LOGNAME': 'cltbld', 02:02:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:04 INFO - 'MOZ_NO_REMOTE': '1', 02:02:04 INFO - 'NO_EM_RESTART': '1', 02:02:04 INFO - 'PAGER': '/bin/cat', 02:02:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:02:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:04 INFO - 'PWD': '/builds/slave/test', 02:02:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:02:04 INFO - 'SHELL': '/bin/bash', 02:02:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3EEyC2V988/Listeners', 02:02:04 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 02:02:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:02:04 INFO - 'USER': 'cltbld', 02:02:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:02:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:02:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:04 INFO - 'XPC_FLAGS': '0x0', 02:02:04 INFO - 'XPC_SERVICE_NAME': '0', 02:02:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:02:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:02:04 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-DsOKg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:02:04 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-evqK8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:02:04 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-SUQHx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:02:04 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-F7JElF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:02:04 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-uIQ7Jm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:02:04 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-WYDHYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:02:05 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-ctUE4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:02:05 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-pfL_7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:02:05 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-t1wwB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:02:05 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-2EXr4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:02:05 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-RAvkY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:02:05 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-CmOqTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:02:05 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-XBmESY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:02:05 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-l7HxKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:02:05 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-OGjDxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:02:05 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-qmij9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:02:06 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-ya8C4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:02:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:02:06 INFO - Running setup.py install for manifestparser 02:02:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:02:06 INFO - Running setup.py install for mozcrash 02:02:06 INFO - Running setup.py install for mozdebug 02:02:06 INFO - Running setup.py install for mozdevice 02:02:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:02:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:02:06 INFO - Running setup.py install for mozfile 02:02:06 INFO - Running setup.py install for mozhttpd 02:02:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:02:07 INFO - Running setup.py install for mozinfo 02:02:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:02:07 INFO - Running setup.py install for mozInstall 02:02:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:02:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:02:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:02:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:02:07 INFO - Running setup.py install for mozleak 02:02:07 INFO - Running setup.py install for mozlog 02:02:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:02:07 INFO - Running setup.py install for moznetwork 02:02:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:02:07 INFO - Running setup.py install for mozprocess 02:02:07 INFO - Running setup.py install for mozprofile 02:02:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:02:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:02:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:02:08 INFO - Running setup.py install for mozrunner 02:02:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:02:08 INFO - Running setup.py install for mozscreenshot 02:02:08 INFO - Running setup.py install for moztest 02:02:08 INFO - Running setup.py install for mozversion 02:02:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:02:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:02:08 INFO - Cleaning up... 02:02:08 INFO - Return code: 0 02:02:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:02:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:08 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 0x10ca6fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca75570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f918a553830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c913d30>, '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 0x10c737db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c90ab20>, '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.e2wh4c73nC/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.3EEyC2V988/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:02:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:02:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:02:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e2wh4c73nC/Render', 02:02:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:02:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:02:08 INFO - 'HOME': '/Users/cltbld', 02:02:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:02:08 INFO - 'LOGNAME': 'cltbld', 02:02:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:08 INFO - 'MOZ_NO_REMOTE': '1', 02:02:08 INFO - 'NO_EM_RESTART': '1', 02:02:08 INFO - 'PAGER': '/bin/cat', 02:02:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:02:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:08 INFO - 'PWD': '/builds/slave/test', 02:02:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:02:08 INFO - 'SHELL': '/bin/bash', 02:02:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3EEyC2V988/Listeners', 02:02:08 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 02:02:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:02:08 INFO - 'USER': 'cltbld', 02:02:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:02:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:02:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:08 INFO - 'XPC_FLAGS': '0x0', 02:02:08 INFO - 'XPC_SERVICE_NAME': '0', 02:02:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:02:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:02:09 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-dUHjPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:02:09 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:02:09 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-cOvdBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:02:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:02:09 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-MmWvEM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:02:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:02:09 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-A_kCU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:02:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:02:09 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-0relJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:02:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:02:09 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-_BYOOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:02:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:02:09 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-b7TShA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:02:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:02:09 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-fvAgSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:02:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:02:09 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-8xRuoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:02:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:02:09 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-QSoGEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:02:10 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)) 02:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:02:10 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-JZnp_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:02:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:02:10 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-kPnoQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:02:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:02:10 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-vNcN4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:02:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:02:10 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-5hMYxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:02:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:02:10 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-kiM2sx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:02:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:02:10 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-OeUQIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:02:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:02:10 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-r_Mo3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:02:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:02:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:02:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:02:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:02:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:02:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:02:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:13 INFO - Downloading blessings-1.6.tar.gz 02:02:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:02:13 INFO - Installing collected packages: blessings 02:02:13 INFO - Running setup.py install for blessings 02:02:13 INFO - Successfully installed blessings 02:02:13 INFO - Cleaning up... 02:02:13 INFO - Return code: 0 02:02:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:02:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:02:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:02:14 INFO - Reading from file tmpfile_stdout 02:02:14 INFO - Current package versions: 02:02:14 INFO - blessings == 1.6 02:02:14 INFO - blobuploader == 1.2.4 02:02:14 INFO - docopt == 0.6.1 02:02:14 INFO - manifestparser == 1.1 02:02:14 INFO - mozInstall == 1.12 02:02:14 INFO - mozcrash == 0.17 02:02:14 INFO - mozdebug == 0.1 02:02:14 INFO - mozdevice == 0.48 02:02:14 INFO - mozfile == 1.2 02:02:14 INFO - mozhttpd == 0.7 02:02:14 INFO - mozinfo == 0.9 02:02:14 INFO - mozleak == 0.1 02:02:14 INFO - mozlog == 3.2 02:02:14 INFO - moznetwork == 0.27 02:02:14 INFO - mozprocess == 0.22 02:02:14 INFO - mozprofile == 0.28 02:02:14 INFO - mozrunner == 6.11 02:02:14 INFO - mozscreenshot == 0.1 02:02:14 INFO - mozsystemmonitor == 0.3 02:02:14 INFO - moztest == 0.7 02:02:14 INFO - mozversion == 1.4 02:02:14 INFO - psutil == 3.1.1 02:02:14 INFO - requests == 1.2.3 02:02:14 INFO - wsgiref == 0.1.2 02:02:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:02: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')]} 02:02:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02: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')]} 02:02:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:14 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 0x10ca6fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca75570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f918a553830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c913d30>, '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 0x10c737db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c90ab20>, '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.e2wh4c73nC/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.3EEyC2V988/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:02:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:02:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:02:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e2wh4c73nC/Render', 02:02:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:02:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:02:14 INFO - 'HOME': '/Users/cltbld', 02:02:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:02:14 INFO - 'LOGNAME': 'cltbld', 02:02:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:14 INFO - 'MOZ_NO_REMOTE': '1', 02:02:14 INFO - 'NO_EM_RESTART': '1', 02:02:14 INFO - 'PAGER': '/bin/cat', 02:02:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:02:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:14 INFO - 'PWD': '/builds/slave/test', 02:02:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:02:14 INFO - 'SHELL': '/bin/bash', 02:02:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3EEyC2V988/Listeners', 02:02:14 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 02:02:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:02:14 INFO - 'USER': 'cltbld', 02:02:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:02:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:02:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:14 INFO - 'XPC_FLAGS': '0x0', 02:02:14 INFO - 'XPC_SERVICE_NAME': '0', 02:02:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:02:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:02:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:02:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:02:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:02:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:02:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:02:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:02:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:02:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:02:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:02:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:02:14 INFO - Cleaning up... 02:02:14 INFO - Return code: 0 02:02:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:02: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')]} 02:02:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02: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')]} 02:02:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ca6fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca75570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f918a553830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c913d30>, '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 0x10c737db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c90ab20>, '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.e2wh4c73nC/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.3EEyC2V988/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:02: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', 'jsonschema'] in /builds/slave/test/build 02:02: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 jsonschema 02:02:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e2wh4c73nC/Render', 02:02:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:02:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:02:14 INFO - 'HOME': '/Users/cltbld', 02:02:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:02:14 INFO - 'LOGNAME': 'cltbld', 02:02:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:14 INFO - 'MOZ_NO_REMOTE': '1', 02:02:14 INFO - 'NO_EM_RESTART': '1', 02:02:14 INFO - 'PAGER': '/bin/cat', 02:02:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:02:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:14 INFO - 'PWD': '/builds/slave/test', 02:02:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:02:14 INFO - 'SHELL': '/bin/bash', 02:02:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3EEyC2V988/Listeners', 02:02:14 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 02:02:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:02:14 INFO - 'USER': 'cltbld', 02:02:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:02:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:02:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:14 INFO - 'XPC_FLAGS': '0x0', 02:02:14 INFO - 'XPC_SERVICE_NAME': '0', 02:02:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:02:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:14 INFO - Downloading/unpacking jsonschema 02:02: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 02:02: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 02:02: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 02:02: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 02:02: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 02:02: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 02:02:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:02:17 INFO - Downloading/unpacking functools32 (from jsonschema) 02:02: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 02:02: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 02:02: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 02:02: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 02:02: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 02:02: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 02:02:17 INFO - Downloading functools32-3.2.3-2.tar.gz 02:02:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:02:17 INFO - warning: no files found matching '*.txt' 02:02:17 INFO - no previously-included directories found matching 'build' 02:02:17 INFO - no previously-included directories found matching 'dist' 02:02:17 INFO - no previously-included directories found matching '.git*' 02:02:17 INFO - Installing collected packages: jsonschema, functools32 02:02:17 INFO - Running setup.py install for functools32 02:02:17 INFO - warning: no files found matching '*.txt' 02:02:17 INFO - no previously-included directories found matching 'build' 02:02:17 INFO - no previously-included directories found matching 'dist' 02:02:17 INFO - no previously-included directories found matching '.git*' 02:02:17 INFO - Successfully installed jsonschema functools32 02:02:17 INFO - Cleaning up... 02:02:17 INFO - Return code: 0 02:02:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:02:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:17 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 0x10ca6fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca75570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f918a553830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c913d30>, '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 0x10c737db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c90ab20>, '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.e2wh4c73nC/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.3EEyC2V988/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:02:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:02:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:02:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e2wh4c73nC/Render', 02:02:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:02:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:02:17 INFO - 'HOME': '/Users/cltbld', 02:02:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:02:17 INFO - 'LOGNAME': 'cltbld', 02:02:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:17 INFO - 'MOZ_NO_REMOTE': '1', 02:02:17 INFO - 'NO_EM_RESTART': '1', 02:02:17 INFO - 'PAGER': '/bin/cat', 02:02:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:02:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:17 INFO - 'PWD': '/builds/slave/test', 02:02:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:02:17 INFO - 'SHELL': '/bin/bash', 02:02:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3EEyC2V988/Listeners', 02:02:17 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 02:02:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:02:17 INFO - 'USER': 'cltbld', 02:02:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:02:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:02:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:17 INFO - 'XPC_FLAGS': '0x0', 02:02:17 INFO - 'XPC_SERVICE_NAME': '0', 02:02:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:02:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:18 INFO - Downloading/unpacking flake8 02:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:02:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:02:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:02:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:02:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:02:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:02:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:02:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:02:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:02:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:02:21 INFO - no previously-included directories found matching 'docs/_build' 02:02:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:02:22 INFO - Running setup.py install for pep8 02:02:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:02:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:02:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:02:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:02:22 INFO - no previously-included directories found matching 'docs/_build' 02:02:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:02:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:02:22 INFO - Cleaning up... 02:02:22 INFO - Return code: 0 02:02:22 INFO - Running post-action listener: _resource_record_post_action 02:02:22 INFO - Running post-action listener: _start_resource_monitoring 02:02:22 INFO - Starting resource monitoring. 02:02:22 INFO - ##### 02:02:22 INFO - ##### Finished create-virtualenv step (success) 02:02:22 INFO - ##### 02:02:22 INFO - ##### 02:02:22 INFO - ##### Running install step. 02:02:22 INFO - ##### 02:02:22 INFO - Running pre-action listener: _resource_record_pre_action 02:02:22 INFO - Running main action method: install 02:02:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:02:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:02:22 INFO - Reading from file tmpfile_stdout 02:02:22 INFO - Detecting whether we're running mozinstall >=1.0... 02:02:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:02:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:02:22 INFO - Reading from file tmpfile_stdout 02:02:22 INFO - Output received: 02:02:22 INFO - Usage: mozinstall [options] installer 02:02:22 INFO - Options: 02:02:22 INFO - -h, --help show this help message and exit 02:02:22 INFO - -d DEST, --destination=DEST 02:02:22 INFO - Directory to install application into. [default: 02:02:22 INFO - "/builds/slave/test"] 02:02:22 INFO - --app=APP Application being installed. [default: firefox] 02:02:22 INFO - mkdir: /builds/slave/test/build/application 02:02:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:02:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 02:02:56 INFO - Reading from file tmpfile_stdout 02:02:56 INFO - Output received: 02:02:56 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:02:56 INFO - Running post-action listener: _resource_record_post_action 02:02:56 INFO - ##### 02:02:56 INFO - ##### Finished install step (success) 02:02:56 INFO - ##### 02:02:56 INFO - ##### 02:02:56 INFO - ##### Running run-tests step. 02:02:56 INFO - ##### 02:02:56 INFO - Running pre-action listener: _resource_record_pre_action 02:02:56 INFO - Running main action method: run_tests 02:02:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:02:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:02:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:02:56 INFO - 2016-05-24 02:02:56.894 screenresolution[1945:20166] starting screenresolution argv=screenresolution get 02:02:56 INFO - 2016-05-24 02:02:56.897 screenresolution[1945:20166] Display 0: 1600x1200x32@60 02:02:56 INFO - 2016-05-24 02:02:56.903 screenresolution[1946:20168] starting screenresolution argv=screenresolution list 02:02:56 INFO - Available Modes on Display 0 02:02:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:02:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:02:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:02:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:02:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:02:57 INFO - Intel Iris: 02:02:57 INFO - Chipset Model: Intel Iris 02:02:57 INFO - Type: GPU 02:02:57 INFO - Bus: Built-In 02:02:57 INFO - VRAM (Dynamic, Max): 1536 MB 02:02:57 INFO - Vendor: Intel (0x8086) 02:02:57 INFO - Device ID: 0x0a2e 02:02:57 INFO - Revision ID: 0x0009 02:02:57 INFO - Displays: 02:02:57 INFO - Display: 02:02:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:02:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:02:57 INFO - Display Serial Number: 1600x1200 60 02:02:57 INFO - Main Display: Yes 02:02:57 INFO - Mirror: Off 02:02:57 INFO - Online: Yes 02:02:57 INFO - Rotation: Supported 02:02:57 INFO - Return code: 0 02:02:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:02:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:02:57 INFO - Python 2.7.3 02:02:57 INFO - Return code: 0 02:02:57 INFO - grabbing minidump binary from tooltool 02:02:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:57 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 0x10c913d30>, '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 0x10c737db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c90ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:02:57 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:02:57 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 02:02:57 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 02:02:57 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:02:57 INFO - Return code: 0 02:02:57 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:02:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:02:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:02:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:02:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:02:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:02:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:02:58 INFO - Return code: 0 02:02:58 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/aIJ4r_sbT1q3WFnjBl9moA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0295', '--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 02:02:58 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/aIJ4r_sbT1q3WFnjBl9moA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0295 --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 02:02:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e2wh4c73nC/Render', 02:02:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:02:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:02:58 INFO - 'HOME': '/Users/cltbld', 02:02:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:02:58 INFO - 'LOGNAME': 'cltbld', 02:02:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:02:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:02:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:58 INFO - 'MOZ_NO_REMOTE': '1', 02:02:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:02:58 INFO - 'NO_EM_RESTART': '1', 02:02:58 INFO - 'PAGER': '/bin/cat', 02:02:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:02:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:58 INFO - 'PWD': '/builds/slave/test', 02:02:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:02:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:02:58 INFO - 'SHELL': '/bin/bash', 02:02:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3EEyC2V988/Listeners', 02:02:58 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 02:02:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:02:58 INFO - 'USER': 'cltbld', 02:02:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:02:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:02:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:58 INFO - 'XPC_FLAGS': '0x0', 02:02:58 INFO - 'XPC_SERVICE_NAME': '0', 02:02:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:02:58 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/aIJ4r_sbT1q3WFnjBl9moA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0295', '--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 02:02:58 INFO - mozversion application_buildid: 20160524000618 02:02:58 INFO - mozversion application_changeset: 00f9eb3e72e805caebd204b780dc904877cab590 02:02:58 INFO - mozversion application_display_name: Nightly 02:02:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:02:58 INFO - mozversion application_name: Firefox 02:02:58 INFO - mozversion application_remotingname: firefox 02:02:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 02:02:58 INFO - mozversion application_vendor: Mozilla 02:02:58 INFO - mozversion application_version: 49.0a1 02:02:58 INFO - mozversion platform_buildid: 20160524000618 02:02:58 INFO - mozversion platform_changeset: 00f9eb3e72e805caebd204b780dc904877cab590 02:02:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 02:02:58 INFO - mozversion platform_version: 49.0a1 02:02:58 INFO - using testdate: 1464080578 02:02:58 INFO - actual date: 1464080578 02:02:58 INFO - starting webserver on 'localhost:57165' 02:02:58 INFO - SUITE-START | Running 2 tests 02:02:58 INFO - TEST-START | dromaeo_css 02:02:58 INFO - operating with platform_type : mac_ 02:02:58 INFO - Initialising browser for dromaeo_css test... 02:02:58 INFO - TEST-INFO | started process 1964 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/tmpoCl1Zq/profile http://localhost:57165/getInfo.html) 02:03:01 INFO - PROCESS | 1964 | __metrics Screen width/height:1600/1200 02:03:01 INFO - PROCESS | 1964 | colorDepth:24 02:03:01 INFO - PROCESS | 1964 | Browser inner width/height: 1024/689 02:03:01 INFO - PROCESS | 1964 | __metrics 02:03:01 ERROR - PROCESS | 1964 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 02:03:02 INFO - TEST-INFO | 1964: exit 0 02:03:02 INFO - Browser initialized. 02:03:02 INFO - Running cycle 1/1 for dromaeo_css test... 02:03:02 INFO - TEST-INFO | started process 1967 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/tmpoCl1Zq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:03:14 INFO - PROCESS | 1967 | RSS: Main: 249974784 02:03:14 INFO - PROCESS | 1967 | 02:04:03 INFO - PROCESS | 1967 | 1464080643782 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:06:13 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:57165/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57165/tests/dromaeo/cssquery-ext.html) 02:06:14 INFO - PROCESS | 1967 | RSS: Main: 261685248 02:06:14 INFO - PROCESS | 1967 | 02:09:17 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:57165/tests/dromaeo/cssquery-ext.html (next: http://localhost:57165/tests/dromaeo/cssquery-jquery.html) 02:09:17 INFO - PROCESS | 1967 | RSS: Main: 273813504 02:09:17 INFO - PROCESS | 1967 | 02:12:19 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:57165/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57165/tests/dromaeo/cssquery-mootools.html) 02:12:20 INFO - PROCESS | 1967 | RSS: Main: 275550208 02:12:20 INFO - PROCESS | 1967 | 02:15:22 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:57165/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57165/tests/dromaeo/cssquery-prototype.html) 02:15:22 INFO - PROCESS | 1967 | RSS: Main: 277413888 02:15:22 INFO - PROCESS | 1967 | 02:18:25 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:57165/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57165/tests/dromaeo/cssquery-yui.html) 02:18:26 INFO - PROCESS | 1967 | RSS: Main: 280829952 02:18:26 INFO - PROCESS | 1967 | 02:21:28 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:57165/tests/dromaeo/cssquery-yui.html (next: http://localhost:57165/tests/dromaeo/cssquery-dojo.html) 02:21:29 INFO - PROCESS | 1967 | RSS: Main: 281550848 02:21:29 INFO - PROCESS | 1967 | 02:21:29 INFO - PROCESS | 1967 | __start_tp_report 02:21:29 INFO - PROCESS | 1967 | _x_x_mozilla_page_load 02:21:29 INFO - PROCESS | 1967 | _x_x_mozilla_page_load_details 02:21:29 INFO - PROCESS | 1967 | |i|pagename|runs| 02:21:29 INFO - PROCESS | 1967 | |0;dojo.html;3366.417783641689;3464.8614055437783;3502.947455788162;3533.9116522086947;3535.9922422109694;5725.685087320196;5749.741261643226;5762.971185144069;5862.267216597926;5939.2575928009;5668.433156684329;5765.855853603662;5801.390853960336;5830.44610761978;5844.795432159875;4241.278982572954;5238.188080847455;5356.250124982486;5363.275957745713;5425.891482170354;61.67951021900031;4155.750654960697;5187.766550505217;5318.813841515548;5339.70631615261;4635.910561018158;4982.975085124569;5261.842144735626;5291.1534154535475;5294.126469132608;5333.2000199969925;5349.759260833272;5376.354837419495;5378.354597448292;5381.327334083239;5233.450487698813;5274;5288.259643649853;5290.68255904647;5363.6245462817615;4750.809967601292;5607.719614019324;5644.85887852807;5666.206731057655;5771.018926782457;5397.946020539784;6125.540694081744;6321.810345689637;6323.6521991290465;6346.42882140605;6206.100115483275;6246.094316324153;6251.499880009588;6275.937240627627;6286.308506064375;5894;5921.851953701149;5928.170056192136;5941.0197317443;5956.344802071769;4926.8768280793265;6227.501799856001;6311.116443697886;6331.27190373113;6344.302126766052;6137.4995631051315;6253.624782513064;6270.655113968684;6273.560850740496;6273.62358258506;6254.343293954069;6266;6276.121343011982;6312.684365781693;6313.873722525524;6147.477464415575;6203.596766210182;6234.438900498977;6292.370762923762;6334.1765570475545;6172.598781079216;6180.258368995749;6259.1550140730415;6263.6241825490615;6279.806836701104;5019.67372120811;5021.372328458942;5024.371953505812;5040.36995375578;5041.319421878073;4388.648908087409;4393.978030109893;4476.753778542146;4519.932201016987;4529.954700452953;5859.677717725566;5863.736131874076;5922.437368449991;5941.881162376728;5970.492508136857;4768.928466073012;5386.515213630713;6283.497320214372;6285.8742825143245;6315.810525684236;5711.9714401428555;5768;5797.8550536236935;5830.038043722823;5911.40885911414;5396.109641909119;5464.863378415492;5466.535344495683;5470.152126420411;5477.561795056386;6349.079383489368;6364.809055728336;6367.872642547123;6380.3619638035825;6388.520860935449;6210.658413787104;6215.9378406215355;6258.749650013949;6298.118263443213;6303.338149494237;6364.872702546016;6387.648679322682;6412.038194270896;6427.421532062137;6432.742690292336;6102.549845102896;6265.373462653698;6297.685115744286;6318.715657795318;6327.873442531216;6206.193194884636;6236.875262494816;6278.623282602875;6287.96856015717;6300.464460520907;5379.327584051994;6036.607620504653;6089.873373425753;6187.84530386726;6222.28443728977;5643.266375371176;6040.516758659209;6071.150038994456;6201.10084037821;6203.100550420074;5898.764049437975;6011.6994150293185;6030.216071910623;6032.125341825323;6134.008014332059;4890.437599676083;6169.475594574512;6220.626762394271;6221.9377806221355;6258.155149055002;5931.703414829328;6054.757809687563;6082.148499210202;6116.113163591343;6118.694065296806 02:21:29 INFO - PROCESS | 1967 | |1;ext.html;471.63448327546166;491.4888515943419;525.9368875734913;530.8327876718834;570.885822835433;38571.421428678594;41517.3772393414;41573.58426415735;41613;41635.791821040926;41741.582584174146;42384.72845814623;42534.7873260634;42580.57419425805;42598.57401425985;9564.952175239132;9763.853542196874;9794.657186998456;9812;9830.311878168532;9665.081817227352;9704.757381065494;9717.125458708715;9748.805023899518;9782.97278785728;9788.36375635585;9816.3128580999;9826.606935722562;9842.311038227326;9856.211503079772;9729;9766.365186262905;9772.071653192936;9792.21662267017;9802.90197098027;9540.427574345562;9648.855267170999;9657.613695452173;9658.647789309502;9662.855057174149;39273;39649.008774780574;39729.20541589181;39747.80126099351;39825;2763.875625596853;3055.2467181524994;3056.66376698563;3207.7273431758326;3314.370269648759;27498.312542186406;27824.721752782414;27842.443151136864;27986.72013279882;28156.577651335247;2588.899717620004;2631.9868400658065;2662.547366947604;2751.7523422892036;2851.800373973823;508908;514781;515192;519210;519857;54057.45942540524;64281.35718642754;64766.70466590736;64841;65013;35095.64904350975;35132.94601161969;36016.45975310372;37327.81336093302;37366;17147.74278385825;17150.142492875555;17340.566485837953;17350.39273625417;17350.65298694019;12724.045696572794;12734.172278801849;13049.412776425084;13061.95504359649;13195.538156164488;19804;19871.30450434228;19940.50148746293;19951.700724489143;19997.800021999592;6739.093532507207;6938.479614028867;8220.547869867214;8278;8674.6096425661;909.6997990663066;951.6193522591019;1014.8325526288228;1045;1081.7511972246427;29637.211531740573;29669.85165074161;30156.54765178524;30190.54714179289;30292.091237262477;1034.943078130695;1090.4220762995626;1094.5949998500605;1109.378747901178;1136.3068528197794;12662.366881656064;15241.695166096837;15452.304646290944;15485.791042689398;15673.68652626964;689911;690616;691166;691680;698549;58846;59254.11118833221;60086;60488.697556511936;61072.69463652742;1395.5045958684723;1452.8837692984537;1477.7857210704387;1482.9258537073104;1483.1620134624118;29221.791438507313;29236.415271694023;29729;30013.549796752628;30244;51250.487495126064;51502.48497514977;51598.74200628973;51812.74093629508;51863.74068129635;611599;614900;615870;616465;618771;23723;25027;26010.219693409228;27311;28326.575101373084;46089;46564.30153547767;46731.76634116808;46788.7660561695;47366.76316618533;37613.87158385253;38069.3696154126;38421.807890960365;38461;39048.609513905634;37427.81286093661;37642;37919.62080379161;38003.61996380112;38379;37374.81312593528;37567.248655027295;37611.81194094012;37994.620053800216;38286.42570361391;27311.59032614552;32390.83804580962;32999.835000824845;34055;34127.4880876792;24140.51718965576;24671.876640616683;24894;25142.49715005653;25305.74694253034 02:21:29 INFO - PROCESS | 1967 | |2;jquery.html;385.7068627842839;386.29308365690787;387.35118676217337;390.8820380864458;408.6097776623323;14827.03624264422;20746.89626551867;20969;21558.353249402524;21600.919954002275;20782.856942868137;21038.263660771878;21630.89184554079;21644.458888527795;21653.45866353342;5612.410696876841;6021.849453763647;6024.578279520435;6030.547708921827;6157.7536898524;5668.57485688573;5970.164177015221;5971.820845374646;5979.46184843364;6106.694665266741;5922.3485416604135;5991.910121348184;6059.575829691923;6065.181200537915;6073.696315184246;5791.362950075489;5941.851453713649;6013.128096426038;6039;6059.697015149225;5670.886582268373;5883.823485295448;6036.728347224385;6048.7882924097885;6059.606125601822;19389.418317450498;25149.37126571832;25426.618600721005;26175.869120654464;26228;2045.9693104603443;2107.3256557901323;2168.1977668262684;2231.107556977206;2313.7917587417046;9538.427694338361;10013.699589012342;10301.175905927508;13356.847032727586;14282.285885705673;1775.2189036823886;1854.054432239554;1860.83252507275;1862.2364830419463;1873.644007638558;125996.37001815024;131060.3446982759;133178.33410832883;133665;134179;11689.532418703157;11721.589744358907;11926.91279026167;11987.520499179935;12052.879471205351;14897.255137243095;15007.399704011936;15040.548783536511;15047.849521504864;15080.245987700571;8699.782505437415;8733.34499912509;8824.117588241124;8863.290936725047;8869.113088691209;8823.470591764515;8829.249513791272;8852.778680533038;8903.955480222558;8927.866082008775;4635.814567417333;4657.813687452532;4687.718736875799;4688.695234809727;4711.505291944365;1496.0051565708682;1676.614378692883;1887.1413506854349;1984.474114359696;1990.3829812758092;877.2850127146355;920.4569304110473;922.9446233225893;942.5522876633681;1062.2139616683598;14619.488317909036;18856.520609802195;20383.694244586342;20571.485712857;20776.68834967477;925.5279807298326;949.838527450335;968.7771812483169;1042.7080417483116;1070.946452677363;9016.684416045407;10732;11125.554977800797;11151.442427878574;11229.943850280697;525704;588479;611537;621989;625289;104692.47653761682;133872.33063834617;135939;136657;139978;963.9759006024906;1041.7916416716687;1044.5612842606124;1058.2539309786582;1085.934843909368;14839;18375.816241837947;19344.8065519343;19509.122089505723;19929.202831886563;47532.52467475419;51528;52615;53621.73189134186;53711;73303.63348183225;76430.23569764232;79008;81188;81847;7007.684654190675;7329.403536816907;7387.9261207387235;7501.062367204099;7567.886481702889;12017.038636909201;12597.181183223061;12886.935565322114;12965.15726477776;13116.868831311947;10815.945920270347;11147.665570032912;11179;11307.830382544103;11400.372979485875;10473.476326183509;10898.673039808818;10989.505472253608;11144;11230.101591872468;10926.890731092588;11103.72240693989;11279.09767218637;11304.321740695585;11857.34784586856;6852.246252912275;7384.889226661712;7473.17795042534;7492.400607951242;7581.862720591956;9332.440053596805;10296.948515257376;10892.237543371888;11011.889881101086;11109.50007249692 02:21:29 INFO - PROCESS | 1967 | |3;mootools.html;1563.9990406140073;1614.1041721844376;1626.447008017274;1850.7223916412536;1909.8949557774317;8063;8699.478031318125;8711.215990560848;9177.08229177082;9197.494137822425;8750.474971501715;8847.424917380366;9005.324600654943;9006.639734410632;9036.322275829307;2386.1648423051925;2400.567897778399;2407.121400688745;2410.674558934548;2419.201663451057;2350.6826578411865;2390.8445951013214;2393.56915755164;2393.940151496218;2396.065534441569;1994.7706013808452;2036.6334059869218;2039.7348344715167;2366.822488313375;2401.3756423329887;2349.612313968193;2361.138184562631;2370.0401337458356;2370.5614461324626;2389.092144984912;2339.391758142895;2351.376885125443;2357.8821058946983;2360.972976755117;2365.44412063165;8872;8877.289816814638;8893.28853691703;8947.955260223658;9001.909980900173;5260.368755749297;5276.182191760245;5440.891182176334;5451.236826844245;5462.426445223234;3447.6897079262735;3511.877084302063;3551.289742051574;3558.733095017884;3608.8195590220384;1022.7443139215196;1023.7594165371132;1034.4724190662741;1054.0250268501604;1060.1201003167353;11818.527258909633;11949.98425133856;11961.282323060645;11982.70043248917;12020.098492613002;4743.95256047442;4790.664653474223;4899.314096026559;4912.754362281871;4921.803127874917;10082.848757268646;10089.798204035878;10125.240606954509;10242.53908574116;10260.846087308697;5363.678179309176;5377.7580008899695;5391.35303763543;5418.322709661293;5472.835814925558;4440.111977604492;4907.607391408679;4918.385201849769;4928.408590969107;4994.950050499521;3977.6817854571564;4024.8390064397095;4071.7353372030725;4082.040720430696;4111.09555897708;1296.185340523275;1298.500232231755;1299.3762993763046;1305.7062161013696;1328.5350127455313;916.7433118726767;934.0799312677008;935.2331088507494;936.5223735894742;969.95150242489;5806.506446951972;5810.680412577264;5970.880582388415;5999;6023.668698221552;387.7654019318328;436.45225242320686;436.8798580390418;452.3486179900932;453.10511739315245;3823.770573765583;3843.8462461501226;3913.158670885716;3924.9803750981064;3933.3903244997073;10551.894481055244;10794.352338859693;10828.675139745821;11010.944945275383;11012.944935275273;10774.299670521392;10873.238873278795;10905.563777448971;10956.28784129029;10972.23194376386;7981.401394895406;8314.750557483285;8353.248207661218;8370.539620320818;8440.957795210985;5170.121079416433;5876.676782776988;5884.323302820059;5998.370171132143;6095.299040610386;9743.464109474047;9934.155596774355;10297.74255643615;10313.381197128196;10341.534630941474;10133.13868321201;10430.061294483532;10451.895481045396;10475.476226188812;10491.213159013258;6988.37104660583;7381.8523629526035;7430.182679905098;7668.80827979305;7766.378689704697;8348.791280218044;8423.663053477792;8459;8491.74524764258;8495.02307234676;7389.187189409268;7557.6221188939235;7632.923670763222;7632.961835190788;7666.540007599562;7298.890516642361;7333.193348731742;7409.888851667121;7459.962700186465;7519.924800752141;7001.649917504206;7065.8341373672765;7079.787606371817;7097.503174777716;7109.644517773987;4815.903681926412;4818;4945.307656928105;4963.975180124076;5125.077486052397;4864.3189953405845;4950.529699678525;4978.4025916890205;5005.074061298671;5145.485451454974 02:21:29 INFO - PROCESS | 1967 | |4;prototype.html;313.90739731779126;315.04227149465623;318.1378464361581;320.0861540302435;323.10338809802806;4539.750313732743;4543.500214976354;4589.426321709786;4594.793234304456;5421.512063914247;4334.653227741781;4688.460827004896;4911.2633105034265;5363.436839131893;5379.031774280628;3165.9525107123413;4005.479287692596;4100.897477563055;4104.6921480888905;4124.649404800595;3991.9201615967663;4036.919261614766;4091.89770255743;4094.89762755932;4141.358089496133;3784.337740895346;4092.138077174893;4094.263032654136;4111.609397107285;4118.19695159444;3405.8297085145646;3792.0709426190483;4114.80670605524;4115.999999999985;4116.608922152391;2957.6450825900815;3133.2636830345077;3405.1487128217946;3515.9803656939457;3552.7513074084823;5110.463401342842;5205.345273910333;5215.322008138955;5216.243644671501;5229.581633469314;4352.347147927804;4658.883527911796;4731.574158325767;4746.5490778376;4783.378160839069;5544.6118771686;5725.856853578653;5729.312482502085;5732.254806875121;5783.450572195635;3336.9332613347597;3358.4458564336855;3701.870434534805;3886.844526218976;3894.941575876364;5876.559258055663;5949.821505354803;5993.700314984277;6036.6679832609625;6075.665838378887;3765.755225910307;3913.3347330953807;3931.6461518463475;3941.7240793144206;3953.2093581283857;3539.2213712983616;3878.5539662939123;3998.6801055915457;4003.3594624859884;4011.538673052578;4133.21468920904;4620.353150558924;4663.836765713184;4676.789544470507;4691.413573303337;5314.73426328682;5431.348238211361;5644.125160600113;5771.278590176228;5830.82507524775;1346.9730605387838;1363.3047145955436;1365.8429280632656;1371.8628137186402;1377.6418131285939;707.9946476003984;727.1165533876366;844.345632135088;847.2205570874687;885.7785553611598;5289.175234544076;5311.229871668586;5317.627766056339;5332.3867755207875;5345.438728933406;4890.510948905081;5823.5923485355615;5843.766249350064;5861.912071318934;5879.412058794172;4779.689320194177;5005.849824505271;5255.76349064293;5257.579393648575;5278;2620.751028652275;2798.412333410007;2846.4876322261775;3070.309180434429;3091.8144911304944;5176.4047134580005;6027.57806953509;6140.495578583275;6168.797084568466;6172.629642221481;4447.265566429095;4976.715367857197;5203.063448579292;6094.9695251524345;6163.291221509584;5973.850653733604;6103.755849765959;6243.406876346739;6266.9005883028785;6285.622862628257;5239.135542635422;5423.041179938746;5898.873596993601;5949.553783466171;5988.640681559121;5224.4848993791375;5645.745941432563;5945.464908158287;5961.642301461926;5971.701414929323;5193.584513239008;5557.388687244319;5925.703714814328;6243;6299.330677370409;3541.274038822087;3653.7442379033214;3916.6670832978375;3951.5653278138807;3984.322665146874;5061.266116413173;5641.379448260606;5945.583809133319;5953;5982.307961417293;4806.423229212517;5418.748750749519;5753.827385178452;5754.827355179351;5788.102844059177;4837.661363704507;5259.42146363892;5324.520793128637;5452.563794896478;5734.684592347461;5054.646174767731;5374.435684253253;5394.622376433612;5559;5593.776248949996;5623.328918763555;5733.168690539932;5756.100486839249;5763.538916886723;5770.5095066919785;4827.637927155548;5633.8591535211945;5657.349404818498;5664.971675141763;5670 02:21:29 INFO - PROCESS | 1967 | |5;yui.html;644.4103645164674;667.2760055339955;728.1698863295841;735.0481126940612;759.6809340077167;15007.549773506798;15138.394464221432;15489.070655760663;15511;15660.765088523682;14270.785938210935;14290.857091429083;14303.78544321836;14352.712945741105;14362.569122926303;716.1513606376435;889.9065598112202;890.4657205676607;907.0430695616122;912.7991841794794;892.2950868813662;901.9368644194909;904.4754042655244;904.5251243097393;905.7916679163797;928.7956649537091;929.3169520402499;974.6783561424713;974.8147851908114;978.7406337320616;924.089771574998;925.2089463508704;964.113016025255;964.8890377606525;965.7923546437514;684.6097724297152;685.8353995041205;686.3959715450371;686.7253098760485;714.7141143542573;14743.705125897422;14824.555263342008;14853.851461485356;14930.62673433162;14936.029158104688;12497.75004499914;12590.24458532482;12706.618801435972;12920.353982300847;12954.287514186715;9886.604535818558;10144;10164.898351016469;10264.538095785707;10412.167026637851;3490.8170485007395;3498.3877821381157;3542.1498840278146;3587.802670853102;3598.442241452579;74385;76571.23428765697;77254;84401.31197376018;84654.73017904736;9459.959404465504;9537.666181683608;9659.565319560637;9661.178799801955;9816.361936474106;20691.172353105707;21029.579408412053;21115.049822758014;21137.365879023655;21779.891100544395;7606.087269527692;7728.304452599293;7732.342750866127;7832.530048197126;8115;3659.6340365963724;3690.2435000824767;3724.050367156358;3779.3575092234387;3982.183652351261;3522.1018640246575;3617.131888346778;3622.492851000862;3624.2751449710163;3626.546681664792;517.7411294352823;604.2597817673314;604.6848105370801;611.1077826373455;614.2751553167216;536.8979893820161;586.8591538030842;598.8981873081586;605.1497645807648;612.3539665652779;7851.568163751049;7942;8165.510069395856;8175.3459723222;8183.345332373396;564.7938502446577;589.3634874335708;593.4955288005161;598.1147901106386;606.2240332374568;3842.1739326045035;3889.7082718796205;3946.1515774108702;4055.41196526502;4169.437125988014;92803.535982321;93823.53088234515;94009;94073;95739.08521829525;81192.37615247662;81765.59117204495;82051.17948820435;86255.56872215724;87177.56411217904;21303;28356.738975017724;56364.43635563674;72912;75119.49761004749;5967.8209653710455;7622.428317876071;7742.225777422213;7775.57234352116;7846.960765196138;45578.54421455876;46168.07663846771;46620;47410;47828.04343913172;62072;65678.67160664166;66193.33806661871;66567.66716166388;67421.66289168522;10127.442990635585;10230.028147325993;10510.527026283988;10645.201609879445;10874.02133807961;11021;11233.438328083726;11272.7745445089;11276.492557835081;11726.530938762695;8771.736847894574;10118.696439106838;10291.63629828576;10395.480225988518;10647.94676026615;9974.950125249326;10182.134518566005;10358.896411035794;10595.788084238426;10655.786884262427;10178.338408003456;10502.579896804042;10545.841812372973;10578.047975682226;10584.153267738408;8531.872021919551;8638;8734.650613975624;8927.241184499131;8983.371164018456;8648.264897483785;8793.648254070022;8818.294536437197;8943.195112439911;9269.814603707753 02:21:29 INFO - PROCESS | 1967 | __end_tp_report 02:21:29 INFO - PROCESS | 1967 | __start_cc_report 02:21:29 INFO - PROCESS | 1967 | _x_x_mozilla_cycle_collect,418 02:21:29 INFO - PROCESS | 1967 | __end_cc_report 02:21:29 INFO - PROCESS | 1967 | __startTimestamp1464081689133__endTimestamp 02:21:29 INFO - PROCESS | 1967 | 02:21:29 INFO - PROCESS | 1967 | ------- Summary: start ------- 02:21:29 INFO - PROCESS | 1967 | Number of tests: 6 02:21:29 INFO - PROCESS | 1967 | 02:21:29 INFO - PROCESS | 1967 | [#0] dojo.html Cycles:165 Average:5722.20 Median:5970.49 stddev:798.87 (13.4%) stddev-sans-first:779.65 02:21:29 INFO - PROCESS | 1967 | Values: 3366.4 3464.9 3502.9 3533.9 3536.0 5725.7 5749.7 5763.0 5862.3 5939.3 5668.4 5765.9 5801.4 5830.4 5844.8 4241.3 5238.2 5356.3 5363.3 5425.9 61.7 4155.8 5187.8 5318.8 5339.7 4635.9 4983.0 5261.8 5291.2 5294.1 5333.2 5349.8 5376.4 5378.4 5381.3 5233.5 5274.0 5288.3 5290.7 5363.6 4750.8 5607.7 5644.9 5666.2 5771.0 5397.9 6125.5 6321.8 6323.7 6346.4 6206.1 6246.1 6251.5 6275.9 6286.3 5894.0 5921.9 5928.2 5941.0 5956.3 4926.9 6227.5 6311.1 6331.3 6344.3 6137.5 6253.6 6270.7 6273.6 6273.6 6254.3 6266.0 6276.1 6312.7 6313.9 6147.5 6203.6 6234.4 6292.4 6334.2 6172.6 6180.3 6259.2 6263.6 6279.8 5019.7 5021.4 5024.4 5040.4 5041.3 4388.6 4394.0 4476.8 4519.9 4530.0 5859.7 5863.7 5922.4 5941.9 5970.5 4768.9 5386.5 6283.5 6285.9 6315.8 5712.0 5768.0 5797.9 5830.0 5911.4 5396.1 5464.9 5466.5 5470.2 5477.6 6349.1 6364.8 6367.9 6380.4 6388.5 6210.7 6215.9 6258.7 6298.1 6303.3 6364.9 6387.6 6412.0 6427.4 6432.7 6102.5 6265.4 6297.7 6318.7 6327.9 6206.2 6236.9 6278.6 6288.0 6300.5 5379.3 6036.6 6089.9 6187.8 6222.3 5643.3 6040.5 6071.2 6201.1 6203.1 5898.8 6011.7 6030.2 6032.1 6134.0 4890.4 6169.5 6220.6 6221.9 6258.2 5931.7 6054.8 6082.1 6116.1 6118.7 02:21:29 INFO - PROCESS | 1967 | 02:21:29 INFO - PROCESS | 1967 | [#1] ext.html Cycles:180 Average:72763.57 Median:38441.40 stddev:164021.36 (426.7%) stddev-sans-first:164391.68 02:21:29 INFO - PROCESS | 1967 | Values: 471.6 491.5 525.9 530.8 570.9 38571.4 41517.4 41573.6 41613.0 41635.8 41741.6 42384.7 42534.8 42580.6 42598.6 9565.0 9763.9 9794.7 9812.0 9830.3 9665.1 9704.8 9717.1 9748.8 9783.0 9788.4 9816.3 9826.6 9842.3 9856.2 9729.0 9766.4 9772.1 9792.2 9802.9 9540.4 9648.9 9657.6 9658.6 9662.9 39273.0 39649.0 39729.2 39747.8 39825.0 2763.9 3055.2 3056.7 3207.7 3314.4 27498.3 27824.7 27842.4 27986.7 28156.6 2588.9 2632.0 2662.5 2751.8 2851.8 508908.0 514781.0 515192.0 519210.0 519857.0 54057.5 64281.4 64766.7 64841.0 65013.0 35095.6 35132.9 36016.5 37327.8 37366.0 17147.7 17150.1 17340.6 17350.4 17350.7 12724.0 12734.2 13049.4 13062.0 13195.5 19804.0 19871.3 19940.5 19951.7 19997.8 6739.1 6938.5 8220.5 8278.0 8674.6 909.7 951.6 1014.8 1045.0 1081.8 29637.2 29669.9 30156.5 30190.5 30292.1 1034.9 1090.4 1094.6 1109.4 1136.3 12662.4 15241.7 15452.3 15485.8 15673.7 689911.0 690616.0 691166.0 691680.0 698549.0 58846.0 59254.1 60086.0 60488.7 61072.7 1395.5 1452.9 1477.8 1482.9 1483.2 29221.8 29236.4 29729.0 30013.5 30244.0 51250.5 51502.5 51598.7 51812.7 51863.7 611599.0 614900.0 615870.0 616465.0 618771.0 23723.0 25027.0 26010.2 27311.0 28326.6 46089.0 46564.3 46731.8 46788.8 47366.8 37613.9 38069.4 38421.8 38461.0 39048.6 37427.8 37642.0 37919.6 38003.6 38379.0 37374.8 37567.2 37611.8 37994.6 38286.4 27311.6 32390.8 32999.8 34055.0 34127.5 24140.5 24671.9 24894.0 25142.5 25305.7 02:21:29 INFO - PROCESS | 1967 | 02:21:29 INFO - PROCESS | 1967 | [#2] jquery.html Cycles:180 Average:35322.02 Median:21648.96 stddev:99888.06 (461.4%) stddev-sans-first:100133.83 02:21:29 INFO - PROCESS | 1967 | Values: 385.7 386.3 387.4 390.9 408.6 14827.0 20746.9 20969.0 21558.4 21600.9 20782.9 21038.3 21630.9 21644.5 21653.5 5612.4 6021.8 6024.6 6030.5 6157.8 5668.6 5970.2 5971.8 5979.5 6106.7 5922.3 5991.9 6059.6 6065.2 6073.7 5791.4 5941.9 6013.1 6039.0 6059.7 5670.9 5883.8 6036.7 6048.8 6059.6 19389.4 25149.4 25426.6 26175.9 26228.0 2046.0 2107.3 2168.2 2231.1 2313.8 9538.4 10013.7 10301.2 13356.8 14282.3 1775.2 1854.1 1860.8 1862.2 1873.6 125996.4 131060.3 133178.3 133665.0 134179.0 11689.5 11721.6 11926.9 11987.5 12052.9 14897.3 15007.4 15040.5 15047.8 15080.2 8699.8 8733.3 8824.1 8863.3 8869.1 8823.5 8829.2 8852.8 8904.0 8927.9 4635.8 4657.8 4687.7 4688.7 4711.5 1496.0 1676.6 1887.1 1984.5 1990.4 877.3 920.5 922.9 942.6 1062.2 14619.5 18856.5 20383.7 20571.5 20776.7 925.5 949.8 968.8 1042.7 1070.9 9016.7 10732.0 11125.6 11151.4 11229.9 525704.0 588479.0 611537.0 621989.0 625289.0 104692.5 133872.3 135939.0 136657.0 139978.0 964.0 1041.8 1044.6 1058.3 1085.9 14839.0 18375.8 19344.8 19509.1 19929.2 47532.5 51528.0 52615.0 53621.7 53711.0 73303.6 76430.2 79008.0 81188.0 81847.0 7007.7 7329.4 7387.9 7501.1 7567.9 12017.0 12597.2 12886.9 12965.2 13116.9 10815.9 11147.7 11179.0 11307.8 11400.4 10473.5 10898.7 10989.5 11144.0 11230.1 10926.9 11103.7 11279.1 11304.3 11857.3 6852.2 7384.9 7473.2 7492.4 7581.9 9332.4 10296.9 10892.2 11011.9 11109.5 02:21:29 INFO - PROCESS | 1967 | 02:21:29 INFO - PROCESS | 1967 | [#3] mootools.html Cycles:180 Average:5775.78 Median:4803.28 stddev:3290.84 (68.5%) stddev-sans-first:3284.85 02:21:29 INFO - PROCESS | 1967 | Values: 1564.0 1614.1 1626.4 1850.7 1909.9 8063.0 8699.5 8711.2 9177.1 9197.5 8750.5 8847.4 9005.3 9006.6 9036.3 2386.2 2400.6 2407.1 2410.7 2419.2 2350.7 2390.8 2393.6 2393.9 2396.1 1994.8 2036.6 2039.7 2366.8 2401.4 2349.6 2361.1 2370.0 2370.6 2389.1 2339.4 2351.4 2357.9 2361.0 2365.4 8872.0 8877.3 8893.3 8948.0 9001.9 5260.4 5276.2 5440.9 5451.2 5462.4 3447.7 3511.9 3551.3 3558.7 3608.8 1022.7 1023.8 1034.5 1054.0 1060.1 11818.5 11950.0 11961.3 11982.7 12020.1 4744.0 4790.7 4899.3 4912.8 4921.8 10082.8 10089.8 10125.2 10242.5 10260.8 5363.7 5377.8 5391.4 5418.3 5472.8 4440.1 4907.6 4918.4 4928.4 4995.0 3977.7 4024.8 4071.7 4082.0 4111.1 1296.2 1298.5 1299.4 1305.7 1328.5 916.7 934.1 935.2 936.5 970.0 5806.5 5810.7 5970.9 5999.0 6023.7 387.8 436.5 436.9 452.3 453.1 3823.8 3843.8 3913.2 3925.0 3933.4 10551.9 10794.4 10828.7 11010.9 11012.9 10774.3 10873.2 10905.6 10956.3 10972.2 7981.4 8314.8 8353.2 8370.5 8441.0 5170.1 5876.7 5884.3 5998.4 6095.3 9743.5 9934.2 10297.7 10313.4 10341.5 10133.1 10430.1 10451.9 10475.5 10491.2 6988.4 7381.9 7430.2 7668.8 7766.4 8348.8 8423.7 8459.0 8491.7 8495.0 7389.2 7557.6 7632.9 7633.0 7666.5 7298.9 7333.2 7409.9 7460.0 7519.9 7001.6 7065.8 7079.8 7097.5 7109.6 4815.9 4818.0 4945.3 4964.0 5125.1 4864.3 4950.5 4978.4 5005.1 5145.5 02:21:29 INFO - PROCESS | 1967 | 02:21:29 INFO - PROCESS | 1967 | [#4] prototype.html Cycles:180 Average:4590.03 Median:5204.20 stddev:1449.21 (27.8%) stddev-sans-first:1417.28 02:21:29 INFO - PROCESS | 1967 | Values: 313.9 315.0 318.1 320.1 323.1 4539.8 4543.5 4589.4 4594.8 5421.5 4334.7 4688.5 4911.3 5363.4 5379.0 3166.0 4005.5 4100.9 4104.7 4124.6 3991.9 4036.9 4091.9 4094.9 4141.4 3784.3 4092.1 4094.3 4111.6 4118.2 3405.8 3792.1 4114.8 4116.0 4116.6 2957.6 3133.3 3405.1 3516.0 3552.8 5110.5 5205.3 5215.3 5216.2 5229.6 4352.3 4658.9 4731.6 4746.5 4783.4 5544.6 5725.9 5729.3 5732.3 5783.5 3336.9 3358.4 3701.9 3886.8 3894.9 5876.6 5949.8 5993.7 6036.7 6075.7 3765.8 3913.3 3931.6 3941.7 3953.2 3539.2 3878.6 3998.7 4003.4 4011.5 4133.2 4620.4 4663.8 4676.8 4691.4 5314.7 5431.3 5644.1 5771.3 5830.8 1347.0 1363.3 1365.8 1371.9 1377.6 708.0 727.1 844.3 847.2 885.8 5289.2 5311.2 5317.6 5332.4 5345.4 4890.5 5823.6 5843.8 5861.9 5879.4 4779.7 5005.8 5255.8 5257.6 5278.0 2620.8 2798.4 2846.5 3070.3 3091.8 5176.4 6027.6 6140.5 6168.8 6172.6 4447.3 4976.7 5203.1 6095.0 6163.3 5973.9 6103.8 6243.4 6266.9 6285.6 5239.1 5423.0 5898.9 5949.6 5988.6 5224.5 5645.7 5945.5 5961.6 5971.7 5193.6 5557.4 5925.7 6243.0 6299.3 3541.3 3653.7 3916.7 3951.6 3984.3 5061.3 5641.4 5945.6 5953.0 5982.3 4806.4 5418.7 5753.8 5754.8 5788.1 4837.7 5259.4 5324.5 5452.6 5734.7 5054.6 5374.4 5394.6 5559.0 5593.8 5623.3 5733.2 5756.1 5763.5 5770.5 4827.6 5633.9 5657.3 5665.0 5670.0 02:21:29 INFO - PROCESS | 1967 | 02:21:29 INFO - PROCESS | 1967 | [#5] yui.html Cycles:180 Average:17607.73 Median:604.92 stddev:25359.26 (4192.2%) stddev-sans-first:25398.41 02:21:29 INFO - PROCESS | 1967 | Values: 644.4 667.3 728.2 735.0 759.7 15007.5 15138.4 15489.1 15511.0 15660.8 14270.8 14290.9 14303.8 14352.7 14362.6 716.2 889.9 890.5 907.0 912.8 892.3 901.9 904.5 904.5 905.8 928.8 929.3 974.7 974.8 978.7 924.1 925.2 964.1 964.9 965.8 684.6 685.8 686.4 686.7 714.7 14743.7 14824.6 14853.9 14930.6 14936.0 12497.8 12590.2 12706.6 12920.4 12954.3 9886.6 10144.0 10164.9 10264.5 10412.2 3490.8 3498.4 3542.1 3587.8 3598.4 74385.0 76571.2 77254.0 84401.3 84654.7 9460.0 9537.7 9659.6 9661.2 9816.4 20691.2 21029.6 21115.0 21137.4 21779.9 7606.1 7728.3 7732.3 7832.5 8115.0 3659.6 3690.2 3724.1 3779.4 3982.2 3522.1 3617.1 3622.5 3624.3 3626.5 517.7 604.3 604.7 611.1 614.3 536.9 586.9 598.9 605.1 612.4 7851.6 7942.0 8165.5 8175.3 8183.3 564.8 589.4 593.5 598.1 606.2 3842.2 3889.7 3946.2 4055.4 4169.4 92803.5 93823.5 94009.0 94073.0 95739.1 81192.4 81765.6 82051.2 86255.6 87177.6 21303.0 28356.7 56364.4 72912.0 75119.5 5967.8 7622.4 7742.2 7775.6 7847.0 45578.5 46168.1 46620.0 47410.0 47828.0 62072.0 65678.7 66193.3 66567.7 67421.7 10127.4 10230.0 10510.5 10645.2 10874.0 11021.0 11233.4 11272.8 11276.5 11726.5 8771.7 10118.7 10291.6 10395.5 10647.9 9975.0 10182.1 10358.9 10595.8 10655.8 10178.3 10502.6 10545.8 10578.0 10584.2 8531.9 8638.0 8734.7 8927.2 8983.4 8648.3 8793.6 8818.3 8943.2 9269.8 02:21:29 INFO - PROCESS | 1967 | -------- Summary: end -------- 02:21:29 INFO - PROCESS | 1967 | 02:21:29 INFO - TEST-INFO | 1967: exit 0 02:21:29 INFO - TEST-OK | dromaeo_css | took 1111119ms 02:21:29 INFO - TEST-START | kraken 02:21:29 INFO - operating with platform_type : mac_ 02:21:29 INFO - Initialising browser for kraken test... 02:21:29 INFO - TEST-INFO | started process 1971 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/tmpTgrO2_/profile http://localhost:57165/getInfo.html) 02:21:32 INFO - PROCESS | 1971 | __metrics Screen width/height:1600/1200 02:21:32 INFO - PROCESS | 1971 | colorDepth:24 02:21:32 INFO - PROCESS | 1971 | Browser inner width/height: 1024/689 02:21:32 INFO - PROCESS | 1971 | __metrics 02:21:32 ERROR - PROCESS | 1971 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 02:21:33 INFO - TEST-INFO | 1971: exit 0 02:21:33 INFO - Browser initialized. 02:21:33 INFO - Running cycle 1/1 for kraken test... 02:21:33 INFO - TEST-INFO | started process 1974 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/tmpTgrO2_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:21:45 INFO - PROCESS | 1974 | RSS: Main: 249950208 02:21:45 INFO - PROCESS | 1974 | 02:21:47 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:57165/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57165/tests/kraken/driver.html?testName=audio-beat-detection) 02:21:48 INFO - PROCESS | 1974 | RSS: Main: 261775360 02:21:48 INFO - PROCESS | 1974 | 02:21:51 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:57165/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57165/tests/kraken/driver.html?testName=audio-dft) 02:21:52 INFO - PROCESS | 1974 | RSS: Main: 267108352 02:21:52 INFO - PROCESS | 1974 | 02:21:55 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:57165/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57165/tests/kraken/driver.html?testName=audio-fft) 02:21:56 INFO - PROCESS | 1974 | RSS: Main: 266702848 02:21:56 INFO - PROCESS | 1974 | 02:21:58 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:57165/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57165/tests/kraken/driver.html?testName=audio-oscillator) 02:21:58 INFO - PROCESS | 1974 | RSS: Main: 267788288 02:21:58 INFO - PROCESS | 1974 | 02:22:01 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:57165/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57165/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:22:01 INFO - PROCESS | 1974 | RSS: Main: 267894784 02:22:01 INFO - PROCESS | 1974 | 02:22:04 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:57165/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57165/tests/kraken/driver.html?testName=imaging-darkroom) 02:22:05 INFO - PROCESS | 1974 | RSS: Main: 269156352 02:22:05 INFO - PROCESS | 1974 | 02:22:08 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:57165/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57165/tests/kraken/driver.html?testName=imaging-desaturate) 02:22:09 INFO - PROCESS | 1974 | RSS: Main: 270004224 02:22:09 INFO - PROCESS | 1974 | 02:22:12 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:57165/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57165/tests/kraken/driver.html?testName=json-parse-financial) 02:22:13 INFO - PROCESS | 1974 | RSS: Main: 270286848 02:22:13 INFO - PROCESS | 1974 | 02:22:14 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:57165/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57165/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:22:15 INFO - PROCESS | 1974 | RSS: Main: 270381056 02:22:15 INFO - PROCESS | 1974 | 02:22:17 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:57165/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57165/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:22:18 INFO - PROCESS | 1974 | RSS: Main: 270532608 02:22:18 INFO - PROCESS | 1974 | 02:22:20 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:57165/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57165/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:22:21 INFO - PROCESS | 1974 | RSS: Main: 270618624 02:22:21 INFO - PROCESS | 1974 | 02:22:24 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:57165/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57165/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:22:25 INFO - PROCESS | 1974 | RSS: Main: 270245888 02:22:25 INFO - PROCESS | 1974 | 02:22:27 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:57165/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57165/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:22:28 INFO - PROCESS | 1974 | RSS: Main: 270213120 02:22:28 INFO - PROCESS | 1974 | 02:22:30 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:57165/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57165/tests/kraken/driver.html?testName=ai-astar) 02:22:30 INFO - PROCESS | 1974 | RSS: Main: 272228352 02:22:30 INFO - PROCESS | 1974 | 02:22:30 INFO - PROCESS | 1974 | __start_tp_report 02:22:30 INFO - PROCESS | 1974 | _x_x_mozilla_page_load 02:22:30 INFO - PROCESS | 1974 | _x_x_mozilla_page_load_details 02:22:30 INFO - PROCESS | 1974 | |i|pagename|runs| 02:22:30 INFO - PROCESS | 1974 | |0;ai-astar;117;109;116;116;116;112;120;120;118;116 02:22:30 INFO - PROCESS | 1974 | |1;audio-beat-detection;154;122;146;199;120;140;142;122;167;123 02:22:30 INFO - PROCESS | 1974 | |2;audio-dft;200;198;208;230;201;195;200;197;199;233 02:22:30 INFO - PROCESS | 1974 | |3;audio-fft;73;77;74;175;80;51;60;93;157;81 02:22:30 INFO - PROCESS | 1974 | |4;audio-oscillator;82;86;155;77;83;81;124;80;82;124 02:22:30 INFO - PROCESS | 1974 | |5;imaging-gaussian-blur;90;96;133;102;91;88;104;109;92;88 02:22:30 INFO - PROCESS | 1974 | |6;imaging-darkroom;98;97;120;148;97;96;97;96;96;97 02:22:30 INFO - PROCESS | 1974 | |7;imaging-desaturate;99;91;115;94;141;91;149;95;150;147 02:22:30 INFO - PROCESS | 1974 | |8;json-parse-financial;58;58;58;58;60;58;67;161;92;69 02:22:30 INFO - PROCESS | 1974 | |9;json-stringify-tinderbox;67;68;76;75;82;81;83;98;99;71 02:22:30 INFO - PROCESS | 1974 | |10;stanford-crypto-aes;87;88;99;109;70;94;107;107;92;87 02:22:30 INFO - PROCESS | 1974 | |11;stanford-crypto-ccm;149;129;152;150;142;136;137;144;250;143 02:22:30 INFO - PROCESS | 1974 | |12;stanford-crypto-pbkdf2;167;164;169;163;168;220;175;164;169;163 02:22:30 INFO - PROCESS | 1974 | |13;stanford-crypto-sha256-iterative;67;66;68;64;66;66;65;66;76;75 02:22:30 INFO - PROCESS | 1974 | __end_tp_report 02:22:30 INFO - PROCESS | 1974 | __start_cc_report 02:22:30 INFO - PROCESS | 1974 | _x_x_mozilla_cycle_collect,1073 02:22:30 INFO - PROCESS | 1974 | __end_cc_report 02:22:30 INFO - PROCESS | 1974 | __startTimestamp1464081750521__endTimestamp 02:22:30 INFO - PROCESS | 1974 | 02:22:30 INFO - PROCESS | 1974 | ------- Summary: start ------- 02:22:30 INFO - PROCESS | 1974 | Number of tests: 14 02:22:30 INFO - PROCESS | 1974 | 02:22:30 INFO - PROCESS | 1974 | [#0] ai-astar Cycles:10 Average:116.00 Median:116.50 stddev:3.37 (2.9%) stddev-sans-first:3.55 02:22:30 INFO - PROCESS | 1974 | Values: 117.0 109.0 116.0 116.0 116.0 112.0 120.0 120.0 118.0 116.0 02:22:30 INFO - PROCESS | 1974 | 02:22:30 INFO - PROCESS | 1974 | [#1] audio-beat-detection Cycles:10 Average:143.50 Median:144.00 stddev:25.08 (17.4%) stddev-sans-first:26.31 02:22:30 INFO - PROCESS | 1974 | Values: 154.0 122.0 146.0 199.0 120.0 140.0 142.0 122.0 167.0 123.0 02:22:30 INFO - PROCESS | 1974 | 02:22:30 INFO - PROCESS | 1974 | [#2] audio-dft Cycles:10 Average:206.10 Median:200.50 stddev:13.83 (6.9%) stddev-sans-first:14.49 02:22:30 INFO - PROCESS | 1974 | Values: 200.0 198.0 208.0 230.0 201.0 195.0 200.0 197.0 199.0 233.0 02:22:30 INFO - PROCESS | 1974 | 02:22:30 INFO - PROCESS | 1974 | [#3] audio-fft Cycles:10 Average:92.10 Median:75.50 stddev:40.82 (54.1%) stddev-sans-first:42.70 02:22:30 INFO - PROCESS | 1974 | Values: 73.0 77.0 74.0 175.0 80.0 51.0 60.0 93.0 157.0 81.0 02:22:30 INFO - PROCESS | 1974 | 02:22:30 INFO - PROCESS | 1974 | [#4] audio-oscillator Cycles:10 Average:97.40 Median:81.50 stddev:26.94 (33.1%) stddev-sans-first:27.99 02:22:30 INFO - PROCESS | 1974 | Values: 82.0 86.0 155.0 77.0 83.0 81.0 124.0 80.0 82.0 124.0 02:22:30 INFO - PROCESS | 1974 | 02:22:30 INFO - PROCESS | 1974 | [#5] imaging-gaussian-blur Cycles:10 Average:99.30 Median:89.00 stddev:13.88 (15.6%) stddev-sans-first:14.31 02:22:30 INFO - PROCESS | 1974 | Values: 90.0 96.0 133.0 102.0 91.0 88.0 104.0 109.0 92.0 88.0 02:22:30 INFO - PROCESS | 1974 | 02:22:30 INFO - PROCESS | 1974 | [#6] imaging-darkroom Cycles:10 Average:104.20 Median:97.00 stddev:17.05 (17.6%) stddev-sans-first:17.93 02:22:30 INFO - PROCESS | 1974 | Values: 98.0 97.0 120.0 148.0 97.0 96.0 97.0 96.0 96.0 97.0 02:22:30 INFO - PROCESS | 1974 | 02:22:30 INFO - PROCESS | 1974 | [#7] imaging-desaturate Cycles:10 Average:117.20 Median:91.00 stddev:26.42 (29.0%) stddev-sans-first:27.19 02:22:30 INFO - PROCESS | 1974 | Values: 99.0 91.0 115.0 94.0 141.0 91.0 149.0 95.0 150.0 147.0 02:22:30 INFO - PROCESS | 1974 | 02:22:30 INFO - PROCESS | 1974 | [#8] json-parse-financial Cycles:10 Average:73.90 Median:59.00 stddev:32.39 (54.9%) stddev-sans-first:33.84 02:22:30 INFO - PROCESS | 1974 | Values: 58.0 58.0 58.0 58.0 60.0 58.0 67.0 161.0 92.0 69.0 02:22:30 INFO - PROCESS | 1974 | 02:22:30 INFO - PROCESS | 1974 | [#9] json-stringify-tinderbox Cycles:10 Average:80.00 Median:81.50 stddev:11.22 (13.8%) stddev-sans-first:10.88 02:22:30 INFO - PROCESS | 1974 | Values: 67.0 68.0 76.0 75.0 82.0 81.0 83.0 98.0 99.0 71.0 02:22:30 INFO - PROCESS | 1974 | 02:22:30 INFO - PROCESS | 1974 | [#10] stanford-crypto-aes Cycles:10 Average:94.00 Median:87.50 stddev:12.03 (13.7%) stddev-sans-first:12.49 02:22:30 INFO - PROCESS | 1974 | Values: 87.0 88.0 99.0 109.0 70.0 94.0 107.0 107.0 92.0 87.0 02:22:30 INFO - PROCESS | 1974 | 02:22:30 INFO - PROCESS | 1974 | [#11] stanford-crypto-ccm Cycles:10 Average:153.20 Median:146.50 stddev:34.73 (23.7%) stddev-sans-first:36.81 02:22:30 INFO - PROCESS | 1974 | Values: 149.0 129.0 152.0 150.0 142.0 136.0 137.0 144.0 250.0 143.0 02:22:30 INFO - PROCESS | 1974 | 02:22:30 INFO - PROCESS | 1974 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.20 Median:168.50 stddev:17.20 (10.2%) stddev-sans-first:18.14 02:22:30 INFO - PROCESS | 1974 | Values: 167.0 164.0 169.0 163.0 168.0 220.0 175.0 164.0 169.0 163.0 02:22:30 INFO - PROCESS | 1974 | 02:22:30 INFO - PROCESS | 1974 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:66.50 stddev:4.15 (6.2%) stddev-sans-first:4.39 02:22:30 INFO - PROCESS | 1974 | Values: 67.0 66.0 68.0 64.0 66.0 66.0 65.0 66.0 76.0 75.0 02:22:30 INFO - PROCESS | 1974 | -------- Summary: end -------- 02:22:30 INFO - PROCESS | 1974 | 02:22:31 INFO - TEST-INFO | 1974: exit 0 02:22:31 INFO - TEST-OK | kraken | took 61695ms 02:22:31 INFO - SUITE-END | took 1172s 02:22:31 INFO - Completed test suite (00:19:33) 02:22:31 INFO - javascript benchmark 02:22:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7166.069480375744, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3366.417783641689, 3464.8614055437783, 3502.947455788162, 3533.9116522086947, 3535.9922422109694, 5725.685087320196, 5749.741261643226, 5762.971185144069, 5862.267216597926, 5939.2575928009, 5668.433156684329, 5765.855853603662, 5801.390853960336, 5830.44610761978, 5844.795432159875, 4241.278982572954, 5238.188080847455, 5356.250124982486, 5363.275957745713, 5425.891482170354, 61.67951021900031, 4155.750654960697, 5187.766550505217, 5318.813841515548, 5339.70631615261, 4635.910561018158, 4982.975085124569, 5261.842144735626, 5291.1534154535475, 5294.126469132608, 5333.2000199969925, 5349.759260833272, 5376.354837419495, 5378.354597448292, 5381.327334083239, 5233.450487698813, 5274.0, 5288.259643649853, 5290.68255904647, 5363.6245462817615, 4750.809967601292, 5607.719614019324, 5644.85887852807, 5666.206731057655, 5771.018926782457, 5397.946020539784, 6125.540694081744, 6321.810345689637, 6323.6521991290465, 6346.42882140605, 6206.100115483275, 6246.094316324153, 6251.499880009588, 6275.937240627627, 6286.308506064375, 5894.0, 5921.851953701149, 5928.170056192136, 5941.0197317443, 5956.344802071769, 4926.8768280793265, 6227.501799856001, 6311.116443697886, 6331.27190373113, 6344.302126766052, 6137.4995631051315, 6253.624782513064, 6270.655113968684, 6273.560850740496, 6273.62358258506, 6254.343293954069, 6266.0, 6276.121343011982, 6312.684365781693, 6313.873722525524, 6147.477464415575, 6203.596766210182, 6234.438900498977, 6292.370762923762, 6334.1765570475545, 6172.598781079216, 6180.258368995749, 6259.1550140730415, 6263.6241825490615, 6279.806836701104, 5019.67372120811, 5021.372328458942, 5024.371953505812, 5040.36995375578, 5041.319421878073, 4388.648908087409, 4393.978030109893, 4476.753778542146, 4519.932201016987, 4529.954700452953, 5859.677717725566, 5863.736131874076, 5922.437368449991, 5941.881162376728, 5970.492508136857, 4768.928466073012, 5386.515213630713, 6283.497320214372, 6285.8742825143245, 6315.810525684236, 5711.9714401428555, 5768.0, 5797.8550536236935, 5830.038043722823, 5911.40885911414, 5396.109641909119, 5464.863378415492, 5466.535344495683, 5470.152126420411, 5477.561795056386, 6349.079383489368, 6364.809055728336, 6367.872642547123, 6380.3619638035825, 6388.520860935449, 6210.658413787104, 6215.9378406215355, 6258.749650013949, 6298.118263443213, 6303.338149494237, 6364.872702546016, 6387.648679322682, 6412.038194270896, 6427.421532062137, 6432.742690292336, 6102.549845102896, 6265.373462653698, 6297.685115744286, 6318.715657795318, 6327.873442531216, 6206.193194884636, 6236.875262494816, 6278.623282602875, 6287.96856015717, 6300.464460520907, 5379.327584051994, 6036.607620504653, 6089.873373425753, 6187.84530386726, 6222.28443728977, 5643.266375371176, 6040.516758659209, 6071.150038994456, 6201.10084037821, 6203.100550420074, 5898.764049437975, 6011.6994150293185, 6030.216071910623, 6032.125341825323, 6134.008014332059, 4890.437599676083, 6169.475594574512, 6220.626762394271, 6221.9377806221355, 6258.155149055002, 5931.703414829328, 6054.757809687563, 6082.148499210202, 6116.113163591343, 6118.694065296806], "value": 5674.9107260671335, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [471.63448327546166, 491.4888515943419, 525.9368875734913, 530.8327876718834, 570.885822835433, 38571.421428678594, 41517.3772393414, 41573.58426415735, 41613.0, 41635.791821040926, 41741.582584174146, 42384.72845814623, 42534.7873260634, 42580.57419425805, 42598.57401425985, 9564.952175239132, 9763.853542196874, 9794.657186998456, 9812.0, 9830.311878168532, 9665.081817227352, 9704.757381065494, 9717.125458708715, 9748.805023899518, 9782.97278785728, 9788.36375635585, 9816.3128580999, 9826.606935722562, 9842.311038227326, 9856.211503079772, 9729.0, 9766.365186262905, 9772.071653192936, 9792.21662267017, 9802.90197098027, 9540.427574345562, 9648.855267170999, 9657.613695452173, 9658.647789309502, 9662.855057174149, 39273.0, 39649.008774780574, 39729.20541589181, 39747.80126099351, 39825.0, 2763.875625596853, 3055.2467181524994, 3056.66376698563, 3207.7273431758326, 3314.370269648759, 27498.312542186406, 27824.721752782414, 27842.443151136864, 27986.72013279882, 28156.577651335247, 2588.899717620004, 2631.9868400658065, 2662.547366947604, 2751.7523422892036, 2851.800373973823, 508908.0, 514781.0, 515192.0, 519210.0, 519857.0, 54057.45942540524, 64281.35718642754, 64766.70466590736, 64841.0, 65013.0, 35095.64904350975, 35132.94601161969, 36016.45975310372, 37327.81336093302, 37366.0, 17147.74278385825, 17150.142492875555, 17340.566485837953, 17350.39273625417, 17350.65298694019, 12724.045696572794, 12734.172278801849, 13049.412776425084, 13061.95504359649, 13195.538156164488, 19804.0, 19871.30450434228, 19940.50148746293, 19951.700724489143, 19997.800021999592, 6739.093532507207, 6938.479614028867, 8220.547869867214, 8278.0, 8674.6096425661, 909.6997990663066, 951.6193522591019, 1014.8325526288228, 1045.0, 1081.7511972246427, 29637.211531740573, 29669.85165074161, 30156.54765178524, 30190.54714179289, 30292.091237262477, 1034.943078130695, 1090.4220762995626, 1094.5949998500605, 1109.378747901178, 1136.3068528197794, 12662.366881656064, 15241.695166096837, 15452.304646290944, 15485.791042689398, 15673.68652626964, 689911.0, 690616.0, 691166.0, 691680.0, 698549.0, 58846.0, 59254.11118833221, 60086.0, 60488.697556511936, 61072.69463652742, 1395.5045958684723, 1452.8837692984537, 1477.7857210704387, 1482.9258537073104, 1483.1620134624118, 29221.791438507313, 29236.415271694023, 29729.0, 30013.549796752628, 30244.0, 51250.487495126064, 51502.48497514977, 51598.74200628973, 51812.74093629508, 51863.74068129635, 611599.0, 614900.0, 615870.0, 616465.0, 618771.0, 23723.0, 25027.0, 26010.219693409228, 27311.0, 28326.575101373084, 46089.0, 46564.30153547767, 46731.76634116808, 46788.7660561695, 47366.76316618533, 37613.87158385253, 38069.3696154126, 38421.807890960365, 38461.0, 39048.609513905634, 37427.81286093661, 37642.0, 37919.62080379161, 38003.61996380112, 38379.0, 37374.81312593528, 37567.248655027295, 37611.81194094012, 37994.620053800216, 38286.42570361391, 27311.59032614552, 32390.83804580962, 32999.835000824845, 34055.0, 34127.4880876792, 24140.51718965576, 24671.876640616683, 24894.0, 25142.49715005653, 25305.74694253034], "value": 19751.223266531964, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.7068627842839, 386.29308365690787, 387.35118676217337, 390.8820380864458, 408.6097776623323, 14827.03624264422, 20746.89626551867, 20969.0, 21558.353249402524, 21600.919954002275, 20782.856942868137, 21038.263660771878, 21630.89184554079, 21644.458888527795, 21653.45866353342, 5612.410696876841, 6021.849453763647, 6024.578279520435, 6030.547708921827, 6157.7536898524, 5668.57485688573, 5970.164177015221, 5971.820845374646, 5979.46184843364, 6106.694665266741, 5922.3485416604135, 5991.910121348184, 6059.575829691923, 6065.181200537915, 6073.696315184246, 5791.362950075489, 5941.851453713649, 6013.128096426038, 6039.0, 6059.697015149225, 5670.886582268373, 5883.823485295448, 6036.728347224385, 6048.7882924097885, 6059.606125601822, 19389.418317450498, 25149.37126571832, 25426.618600721005, 26175.869120654464, 26228.0, 2045.9693104603443, 2107.3256557901323, 2168.1977668262684, 2231.107556977206, 2313.7917587417046, 9538.427694338361, 10013.699589012342, 10301.175905927508, 13356.847032727586, 14282.285885705673, 1775.2189036823886, 1854.054432239554, 1860.83252507275, 1862.2364830419463, 1873.644007638558, 125996.37001815024, 131060.3446982759, 133178.33410832883, 133665.0, 134179.0, 11689.532418703157, 11721.589744358907, 11926.91279026167, 11987.520499179935, 12052.879471205351, 14897.255137243095, 15007.399704011936, 15040.548783536511, 15047.849521504864, 15080.245987700571, 8699.782505437415, 8733.34499912509, 8824.117588241124, 8863.290936725047, 8869.113088691209, 8823.470591764515, 8829.249513791272, 8852.778680533038, 8903.955480222558, 8927.866082008775, 4635.814567417333, 4657.813687452532, 4687.718736875799, 4688.695234809727, 4711.505291944365, 1496.0051565708682, 1676.614378692883, 1887.1413506854349, 1984.474114359696, 1990.3829812758092, 877.2850127146355, 920.4569304110473, 922.9446233225893, 942.5522876633681, 1062.2139616683598, 14619.488317909036, 18856.520609802195, 20383.694244586342, 20571.485712857, 20776.68834967477, 925.5279807298326, 949.838527450335, 968.7771812483169, 1042.7080417483116, 1070.946452677363, 9016.684416045407, 10732.0, 11125.554977800797, 11151.442427878574, 11229.943850280697, 525704.0, 588479.0, 611537.0, 621989.0, 625289.0, 104692.47653761682, 133872.33063834617, 135939.0, 136657.0, 139978.0, 963.9759006024906, 1041.7916416716687, 1044.5612842606124, 1058.2539309786582, 1085.934843909368, 14839.0, 18375.816241837947, 19344.8065519343, 19509.122089505723, 19929.202831886563, 47532.52467475419, 51528.0, 52615.0, 53621.73189134186, 53711.0, 73303.63348183225, 76430.23569764232, 79008.0, 81188.0, 81847.0, 7007.684654190675, 7329.403536816907, 7387.9261207387235, 7501.062367204099, 7567.886481702889, 12017.038636909201, 12597.181183223061, 12886.935565322114, 12965.15726477776, 13116.868831311947, 10815.945920270347, 11147.665570032912, 11179.0, 11307.830382544103, 11400.372979485875, 10473.476326183509, 10898.673039808818, 10989.505472253608, 11144.0, 11230.101591872468, 10926.890731092588, 11103.72240693989, 11279.09767218637, 11304.321740695585, 11857.34784586856, 6852.246252912275, 7384.889226661712, 7473.17795042534, 7492.400607951242, 7581.862720591956, 9332.440053596805, 10296.948515257376, 10892.237543371888, 11011.889881101086, 11109.50007249692], "value": 9625.96555582557, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1563.9990406140073, 1614.1041721844376, 1626.447008017274, 1850.7223916412536, 1909.8949557774317, 8063.0, 8699.478031318125, 8711.215990560848, 9177.08229177082, 9197.494137822425, 8750.474971501715, 8847.424917380366, 9005.324600654943, 9006.639734410632, 9036.322275829307, 2386.1648423051925, 2400.567897778399, 2407.121400688745, 2410.674558934548, 2419.201663451057, 2350.6826578411865, 2390.8445951013214, 2393.56915755164, 2393.940151496218, 2396.065534441569, 1994.7706013808452, 2036.6334059869218, 2039.7348344715167, 2366.822488313375, 2401.3756423329887, 2349.612313968193, 2361.138184562631, 2370.0401337458356, 2370.5614461324626, 2389.092144984912, 2339.391758142895, 2351.376885125443, 2357.8821058946983, 2360.972976755117, 2365.44412063165, 8872.0, 8877.289816814638, 8893.28853691703, 8947.955260223658, 9001.909980900173, 5260.368755749297, 5276.182191760245, 5440.891182176334, 5451.236826844245, 5462.426445223234, 3447.6897079262735, 3511.877084302063, 3551.289742051574, 3558.733095017884, 3608.8195590220384, 1022.7443139215196, 1023.7594165371132, 1034.4724190662741, 1054.0250268501604, 1060.1201003167353, 11818.527258909633, 11949.98425133856, 11961.282323060645, 11982.70043248917, 12020.098492613002, 4743.95256047442, 4790.664653474223, 4899.314096026559, 4912.754362281871, 4921.803127874917, 10082.848757268646, 10089.798204035878, 10125.240606954509, 10242.53908574116, 10260.846087308697, 5363.678179309176, 5377.7580008899695, 5391.35303763543, 5418.322709661293, 5472.835814925558, 4440.111977604492, 4907.607391408679, 4918.385201849769, 4928.408590969107, 4994.950050499521, 3977.6817854571564, 4024.8390064397095, 4071.7353372030725, 4082.040720430696, 4111.09555897708, 1296.185340523275, 1298.500232231755, 1299.3762993763046, 1305.7062161013696, 1328.5350127455313, 916.7433118726767, 934.0799312677008, 935.2331088507494, 936.5223735894742, 969.95150242489, 5806.506446951972, 5810.680412577264, 5970.880582388415, 5999.0, 6023.668698221552, 387.7654019318328, 436.45225242320686, 436.8798580390418, 452.3486179900932, 453.10511739315245, 3823.770573765583, 3843.8462461501226, 3913.158670885716, 3924.9803750981064, 3933.3903244997073, 10551.894481055244, 10794.352338859693, 10828.675139745821, 11010.944945275383, 11012.944935275273, 10774.299670521392, 10873.238873278795, 10905.563777448971, 10956.28784129029, 10972.23194376386, 7981.401394895406, 8314.750557483285, 8353.248207661218, 8370.539620320818, 8440.957795210985, 5170.121079416433, 5876.676782776988, 5884.323302820059, 5998.370171132143, 6095.299040610386, 9743.464109474047, 9934.155596774355, 10297.74255643615, 10313.381197128196, 10341.534630941474, 10133.13868321201, 10430.061294483532, 10451.895481045396, 10475.476226188812, 10491.213159013258, 6988.37104660583, 7381.8523629526035, 7430.182679905098, 7668.80827979305, 7766.378689704697, 8348.791280218044, 8423.663053477792, 8459.0, 8491.74524764258, 8495.02307234676, 7389.187189409268, 7557.6221188939235, 7632.923670763222, 7632.961835190788, 7666.540007599562, 7298.890516642361, 7333.193348731742, 7409.888851667121, 7459.962700186465, 7519.924800752141, 7001.649917504206, 7065.8341373672765, 7079.787606371817, 7097.503174777716, 7109.644517773987, 4815.903681926412, 4818.0, 4945.307656928105, 4963.975180124076, 5125.077486052397, 4864.3189953405845, 4950.529699678525, 4978.4025916890205, 5005.074061298671, 5145.485451454974], "value": 4542.949582803127, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.90739731779126, 315.04227149465623, 318.1378464361581, 320.0861540302435, 323.10338809802806, 4539.750313732743, 4543.500214976354, 4589.426321709786, 4594.793234304456, 5421.512063914247, 4334.653227741781, 4688.460827004896, 4911.2633105034265, 5363.436839131893, 5379.031774280628, 3165.9525107123413, 4005.479287692596, 4100.897477563055, 4104.6921480888905, 4124.649404800595, 3991.9201615967663, 4036.919261614766, 4091.89770255743, 4094.89762755932, 4141.358089496133, 3784.337740895346, 4092.138077174893, 4094.263032654136, 4111.609397107285, 4118.19695159444, 3405.8297085145646, 3792.0709426190483, 4114.80670605524, 4115.999999999985, 4116.608922152391, 2957.6450825900815, 3133.2636830345077, 3405.1487128217946, 3515.9803656939457, 3552.7513074084823, 5110.463401342842, 5205.345273910333, 5215.322008138955, 5216.243644671501, 5229.581633469314, 4352.347147927804, 4658.883527911796, 4731.574158325767, 4746.5490778376, 4783.378160839069, 5544.6118771686, 5725.856853578653, 5729.312482502085, 5732.254806875121, 5783.450572195635, 3336.9332613347597, 3358.4458564336855, 3701.870434534805, 3886.844526218976, 3894.941575876364, 5876.559258055663, 5949.821505354803, 5993.700314984277, 6036.6679832609625, 6075.665838378887, 3765.755225910307, 3913.3347330953807, 3931.6461518463475, 3941.7240793144206, 3953.2093581283857, 3539.2213712983616, 3878.5539662939123, 3998.6801055915457, 4003.3594624859884, 4011.538673052578, 4133.21468920904, 4620.353150558924, 4663.836765713184, 4676.789544470507, 4691.413573303337, 5314.73426328682, 5431.348238211361, 5644.125160600113, 5771.278590176228, 5830.82507524775, 1346.9730605387838, 1363.3047145955436, 1365.8429280632656, 1371.8628137186402, 1377.6418131285939, 707.9946476003984, 727.1165533876366, 844.345632135088, 847.2205570874687, 885.7785553611598, 5289.175234544076, 5311.229871668586, 5317.627766056339, 5332.3867755207875, 5345.438728933406, 4890.510948905081, 5823.5923485355615, 5843.766249350064, 5861.912071318934, 5879.412058794172, 4779.689320194177, 5005.849824505271, 5255.76349064293, 5257.579393648575, 5278.0, 2620.751028652275, 2798.412333410007, 2846.4876322261775, 3070.309180434429, 3091.8144911304944, 5176.4047134580005, 6027.57806953509, 6140.495578583275, 6168.797084568466, 6172.629642221481, 4447.265566429095, 4976.715367857197, 5203.063448579292, 6094.9695251524345, 6163.291221509584, 5973.850653733604, 6103.755849765959, 6243.406876346739, 6266.9005883028785, 6285.622862628257, 5239.135542635422, 5423.041179938746, 5898.873596993601, 5949.553783466171, 5988.640681559121, 5224.4848993791375, 5645.745941432563, 5945.464908158287, 5961.642301461926, 5971.701414929323, 5193.584513239008, 5557.388687244319, 5925.703714814328, 6243.0, 6299.330677370409, 3541.274038822087, 3653.7442379033214, 3916.6670832978375, 3951.5653278138807, 3984.322665146874, 5061.266116413173, 5641.379448260606, 5945.583809133319, 5953.0, 5982.307961417293, 4806.423229212517, 5418.748750749519, 5753.827385178452, 5754.827355179351, 5788.102844059177, 4837.661363704507, 5259.42146363892, 5324.520793128637, 5452.563794896478, 5734.684592347461, 5054.646174767731, 5374.435684253253, 5394.622376433612, 5559.0, 5593.776248949996, 5623.328918763555, 5733.168690539932, 5756.100486839249, 5763.538916886723, 5770.5095066919785, 4827.637927155548, 5633.8591535211945, 5657.349404818498, 5664.971675141763, 5670.0], "value": 4125.2191197232, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [644.4103645164674, 667.2760055339955, 728.1698863295841, 735.0481126940612, 759.6809340077167, 15007.549773506798, 15138.394464221432, 15489.070655760663, 15511.0, 15660.765088523682, 14270.785938210935, 14290.857091429083, 14303.78544321836, 14352.712945741105, 14362.569122926303, 716.1513606376435, 889.9065598112202, 890.4657205676607, 907.0430695616122, 912.7991841794794, 892.2950868813662, 901.9368644194909, 904.4754042655244, 904.5251243097393, 905.7916679163797, 928.7956649537091, 929.3169520402499, 974.6783561424713, 974.8147851908114, 978.7406337320616, 924.089771574998, 925.2089463508704, 964.113016025255, 964.8890377606525, 965.7923546437514, 684.6097724297152, 685.8353995041205, 686.3959715450371, 686.7253098760485, 714.7141143542573, 14743.705125897422, 14824.555263342008, 14853.851461485356, 14930.62673433162, 14936.029158104688, 12497.75004499914, 12590.24458532482, 12706.618801435972, 12920.353982300847, 12954.287514186715, 9886.604535818558, 10144.0, 10164.898351016469, 10264.538095785707, 10412.167026637851, 3490.8170485007395, 3498.3877821381157, 3542.1498840278146, 3587.802670853102, 3598.442241452579, 74385.0, 76571.23428765697, 77254.0, 84401.31197376018, 84654.73017904736, 9459.959404465504, 9537.666181683608, 9659.565319560637, 9661.178799801955, 9816.361936474106, 20691.172353105707, 21029.579408412053, 21115.049822758014, 21137.365879023655, 21779.891100544395, 7606.087269527692, 7728.304452599293, 7732.342750866127, 7832.530048197126, 8115.0, 3659.6340365963724, 3690.2435000824767, 3724.050367156358, 3779.3575092234387, 3982.183652351261, 3522.1018640246575, 3617.131888346778, 3622.492851000862, 3624.2751449710163, 3626.546681664792, 517.7411294352823, 604.2597817673314, 604.6848105370801, 611.1077826373455, 614.2751553167216, 536.8979893820161, 586.8591538030842, 598.8981873081586, 605.1497645807648, 612.3539665652779, 7851.568163751049, 7942.0, 8165.510069395856, 8175.3459723222, 8183.345332373396, 564.7938502446577, 589.3634874335708, 593.4955288005161, 598.1147901106386, 606.2240332374568, 3842.1739326045035, 3889.7082718796205, 3946.1515774108702, 4055.41196526502, 4169.437125988014, 92803.535982321, 93823.53088234515, 94009.0, 94073.0, 95739.08521829525, 81192.37615247662, 81765.59117204495, 82051.17948820435, 86255.56872215724, 87177.56411217904, 21303.0, 28356.738975017724, 56364.43635563674, 72912.0, 75119.49761004749, 5967.8209653710455, 7622.428317876071, 7742.225777422213, 7775.57234352116, 7846.960765196138, 45578.54421455876, 46168.07663846771, 46620.0, 47410.0, 47828.04343913172, 62072.0, 65678.67160664166, 66193.33806661871, 66567.66716166388, 67421.66289168522, 10127.442990635585, 10230.028147325993, 10510.527026283988, 10645.201609879445, 10874.02133807961, 11021.0, 11233.438328083726, 11272.7745445089, 11276.492557835081, 11726.530938762695, 8771.736847894574, 10118.696439106838, 10291.63629828576, 10395.480225988518, 10647.94676026615, 9974.950125249326, 10182.134518566005, 10358.896411035794, 10595.788084238426, 10655.786884262427, 10178.338408003456, 10502.579896804042, 10545.841812372973, 10578.047975682226, 10584.153267738408, 8531.872021919551, 8638.0, 8734.650613975624, 8927.241184499131, 8983.371164018456, 8648.264897483785, 8793.648254070022, 8818.294536437197, 8943.195112439911, 9269.814603707753], "value": 6696.657531743358, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1617.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 109.0, 116.0, 116.0, 116.0, 112.0, 120.0, 120.0, 118.0, 116.0], "value": 116.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 122.0, 146.0, 199.0, 120.0, 140.0, 142.0, 122.0, 167.0, 123.0], "value": 143.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 198.0, 208.0, 230.0, 201.0, 195.0, 200.0, 197.0, 199.0, 233.0], "value": 206.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 77.0, 74.0, 175.0, 80.0, 51.0, 60.0, 93.0, 157.0, 81.0], "value": 92.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 86.0, 155.0, 77.0, 83.0, 81.0, 124.0, 80.0, 82.0, 124.0], "value": 97.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 96.0, 133.0, 102.0, 91.0, 88.0, 104.0, 109.0, 92.0, 88.0], "value": 99.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 97.0, 120.0, 148.0, 97.0, 96.0, 97.0, 96.0, 96.0, 97.0], "value": 104.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 91.0, 115.0, 94.0, 141.0, 91.0, 149.0, 95.0, 150.0, 147.0], "value": 117.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 58.0, 58.0, 60.0, 58.0, 67.0, 161.0, 92.0, 69.0], "value": 73.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 76.0, 75.0, 82.0, 81.0, 83.0, 98.0, 99.0, 71.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 99.0, 109.0, 70.0, 94.0, 107.0, 107.0, 92.0, 87.0], "value": 94.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 129.0, 152.0, 150.0, 142.0, 136.0, 137.0, 144.0, 250.0, 143.0], "value": 153.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 164.0, 169.0, 163.0, 168.0, 220.0, 175.0, 164.0, 169.0, 163.0], "value": 172.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 68.0, 64.0, 66.0, 66.0, 65.0, 66.0, 76.0, 75.0], "value": 67.9, "unit": "score"}]}]} 02:22:31 INFO - Return code: 0 02:22:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:22:31 ERROR - # TBPL SUCCESS # 02:22:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:22:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:22:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:22:31 INFO - 2016-05-24 02:22:31.829 screenresolution[1979:22436] starting screenresolution argv=screenresolution get 02:22:31 INFO - 2016-05-24 02:22:31.831 screenresolution[1979:22436] Display 0: 1600x1200x32@60 02:22:31 INFO - 2016-05-24 02:22:31.837 screenresolution[1980:22439] starting screenresolution argv=screenresolution list 02:22:31 INFO - Available Modes on Display 0 02:22:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:22:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:22:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:22:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:22:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:22:32 INFO - Intel Iris: 02:22:32 INFO - Chipset Model: Intel Iris 02:22:32 INFO - Type: GPU 02:22:32 INFO - Bus: Built-In 02:22:32 INFO - VRAM (Dynamic, Max): 1536 MB 02:22:32 INFO - Vendor: Intel (0x8086) 02:22:32 INFO - Device ID: 0x0a2e 02:22:32 INFO - Revision ID: 0x0009 02:22:32 INFO - Displays: 02:22:32 INFO - Display: 02:22:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:22:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:22:32 INFO - Display Serial Number: 1600x1200 60 02:22:32 INFO - Main Display: Yes 02:22:32 INFO - Mirror: Off 02:22:32 INFO - Online: Yes 02:22:32 INFO - Rotation: Supported 02:22:32 INFO - Return code: 0 02:22:32 INFO - Running post-action listener: _resource_record_post_action 02:22:32 INFO - ##### 02:22:32 INFO - ##### Finished run-tests step (success) 02:22:32 INFO - ##### 02:22:32 INFO - Running post-run listener: _resource_record_post_run 02:22:32 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 0; Write bytes: 696437248; Read time: 0; Write time: 1937 02:22:32 INFO - TinderboxPrint: CPU usage
54.4% 02:22:32 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 02:22:32 INFO - TinderboxPrint: I/O write bytes / time
696,437,248 / 1,937 02:22:32 INFO - TinderboxPrint: CPU idle
2,205.6 (45.6%) 02:22:32 INFO - TinderboxPrint: CPU system
975.3 (20.2%) 02:22:32 INFO - TinderboxPrint: CPU user
1,656.7 (34.2%) 02:22:32 INFO - TinderboxPrint: Swap in / out
395,624,448 / 0 02:22:32 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 385786368; Write bytes: 379975168; Read time: 29446; Write time: 764 02:22:32 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 0; Write bytes: 296952832; Read time: 0; Write time: 1122 02:22:32 INFO - Running post-run listener: _upload_blobber_files 02:22:32 INFO - Blob upload gear active. 02:22:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:22:32 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 02:22:32 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'] 02:22:32 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 02:22:32 INFO - (blobuploader) - INFO - Open directory for files ... 02:22:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:22:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:22:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:22:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:22:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:22:33 INFO - (blobuploader) - INFO - Done attempting. 02:22:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:22:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:22:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:22:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:22:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:22:34 INFO - (blobuploader) - INFO - Done attempting. 02:22:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:22:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:22:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:22:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:22:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:22:37 INFO - (blobuploader) - INFO - Done attempting. 02:22:37 INFO - (blobuploader) - INFO - Iteration through files over. 02:22:37 INFO - Return code: 0 02:22:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:22:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:22:37 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/18f89af86641b46df61a5b64d00a806a2d21b881dd383304962e93b110f7c18aee4603396c7f3cd9c14a765314bdb3742b0b3626721df059ae114a8bffe1349a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ab6075c32610e1e444ad5fd22ceeec6b525cdc77956a970fcda26ff9770d2b6640ab83496a0eba1f3f92b6df8c5335a0dd647c37419a470b071a9d57ab3c788f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a4d3ccd5a2c5bd4bf38062adf045f80ee7a5cf3bf3f265904df4669af7cf26599e166ee684218191a08dfba14ac1cf199ba9b8457030e218a25d5cf27c5e8490"} 02:22:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:22:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:22:37 INFO - Contents: 02:22:37 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/18f89af86641b46df61a5b64d00a806a2d21b881dd383304962e93b110f7c18aee4603396c7f3cd9c14a765314bdb3742b0b3626721df059ae114a8bffe1349a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ab6075c32610e1e444ad5fd22ceeec6b525cdc77956a970fcda26ff9770d2b6640ab83496a0eba1f3f92b6df8c5335a0dd647c37419a470b071a9d57ab3c788f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a4d3ccd5a2c5bd4bf38062adf045f80ee7a5cf3bf3f265904df4669af7cf26599e166ee684218191a08dfba14ac1cf199ba9b8457030e218a25d5cf27c5e8490"} 02:22:37 INFO - Running post-run listener: copy_logs_to_upload_dir 02:22:37 INFO - Copying logs to upload dir... 02:22:37 INFO - mkdir: /builds/slave/test/build/upload/logs 02:22:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.359350 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-05-24 02:22:37.436383) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 02:22:37.440398) ========= 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.e2wh4c73nC/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.3EEyC2V988/Listeners TMPDIR=/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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/18f89af86641b46df61a5b64d00a806a2d21b881dd383304962e93b110f7c18aee4603396c7f3cd9c14a765314bdb3742b0b3626721df059ae114a8bffe1349a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ab6075c32610e1e444ad5fd22ceeec6b525cdc77956a970fcda26ff9770d2b6640ab83496a0eba1f3f92b6df8c5335a0dd647c37419a470b071a9d57ab3c788f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a4d3ccd5a2c5bd4bf38062adf045f80ee7a5cf3bf3f265904df4669af7cf26599e166ee684218191a08dfba14ac1cf199ba9b8457030e218a25d5cf27c5e8490"} build_url:https://queue.taskcluster.net/v1/task/aIJ4r_sbT1q3WFnjBl9moA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011190 build_url: 'https://queue.taskcluster.net/v1/task/aIJ4r_sbT1q3WFnjBl9moA/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/18f89af86641b46df61a5b64d00a806a2d21b881dd383304962e93b110f7c18aee4603396c7f3cd9c14a765314bdb3742b0b3626721df059ae114a8bffe1349a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ab6075c32610e1e444ad5fd22ceeec6b525cdc77956a970fcda26ff9770d2b6640ab83496a0eba1f3f92b6df8c5335a0dd647c37419a470b071a9d57ab3c788f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a4d3ccd5a2c5bd4bf38062adf045f80ee7a5cf3bf3f265904df4669af7cf26599e166ee684218191a08dfba14ac1cf199ba9b8457030e218a25d5cf27c5e8490"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 02:22:37.474130) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 02:22:37.474857) ========= 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.e2wh4c73nC/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.3EEyC2V988/Listeners TMPDIR=/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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.005079 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 02:22:37.527292) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 02:22:37.528062) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 02:22:37.528789) ========= ========= Total master_lag: 0.19 =========