builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0230 starttime: 1464048569.23 results: success (0) buildid: 20160523151340 builduid: ef4c186141b34990b37a69b5173375d2 revision: cb4081774f86e6f121feeb86c923ec54de47441c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 17:09:29.234278) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 17:09:29.234724) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 17:09:29.235002) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 17:09:29.289706) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 17:09:29.290085) ========= 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.b5tKPQfxms/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.6HwiSwKaqP/Listeners TMPDIR=/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/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-23 17:09:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.61M=0.001s 2016-05-23 17:09:29 (8.61 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.190603 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 17:09:29.515426) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 17:09:29.515748) ========= 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.b5tKPQfxms/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.6HwiSwKaqP/Listeners TMPDIR=/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/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.020842 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 17:09:29.567129) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-05-23 17:09:29.567454) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev cb4081774f86e6f121feeb86c923ec54de47441c --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 cb4081774f86e6f121feeb86c923ec54de47441c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.b5tKPQfxms/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.6HwiSwKaqP/Listeners TMPDIR=/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/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-23 17:09:29,588 truncating revision to first 12 chars 2016-05-23 17:09:29,588 Setting DEBUG logging. 2016-05-23 17:09:29,588 attempt 1/10 2016-05-23 17:09:29,588 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/cb4081774f86?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-23 17:09:31,632 unpacking tar archive at: fx-team-cb4081774f86/testing/mozharness/ program finished with exit code 0 elapsedTime=2.301314 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-05-23 17:09:31.888348) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 17:09:31.888683) ========= script_repo_revision: cb4081774f86e6f121feeb86c923ec54de47441c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 17:09:31.889082) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 17:09:31.889360) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 17:09:31.904653) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 37 secs) (at 2016-05-23 17:09:31.904962) ========= /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.b5tKPQfxms/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.6HwiSwKaqP/Listeners TMPDIR=/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/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 17:09:32 INFO - MultiFileLogger online at 20160523 17:09:32 in /builds/slave/test 17:09:32 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 17:09:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:09:32 INFO - {'append_to_log': False, 17:09:32 INFO - 'base_work_dir': '/builds/slave/test', 17:09:32 INFO - 'blob_upload_branch': 'Fx-Team', 17:09:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:09:32 INFO - 'branch': 'Fx-Team', 17:09:32 INFO - 'buildbot_json_path': 'buildprops.json', 17:09:32 INFO - 'config_files': ('talos/mac_config.py',), 17:09:32 INFO - 'default_actions': ('clobber', 17:09:32 INFO - 'read-buildbot-config', 17:09:32 INFO - 'download-and-extract', 17:09:32 INFO - 'populate-webroot', 17:09:32 INFO - 'create-virtualenv', 17:09:32 INFO - 'install', 17:09:32 INFO - 'run-tests'), 17:09:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:09:32 INFO - 'download_minidump_stackwalk': True, 17:09:32 INFO - 'download_symbols': 'ondemand', 17:09:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:09:32 INFO - 'tooltool.py': '/tools/tooltool.py', 17:09:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:09:32 INFO - '/tools/misc-python/virtualenv.py')}, 17:09:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:09:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:09:32 INFO - 'installer_path': 'installer.exe', 17:09:32 INFO - 'log_level': 'info', 17:09:32 INFO - 'log_name': 'talos', 17:09:32 INFO - 'log_to_console': True, 17:09:32 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:09:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:09:32 INFO - 'opt_config_files': (), 17:09:32 INFO - 'pip_index': False, 17:09:32 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:09:32 INFO - 'cmd': ('bash', 17:09:32 INFO - '-c', 17:09:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:09:32 INFO - 'enabled': True, 17:09:32 INFO - 'halt_on_failure': False, 17:09:32 INFO - 'name': 'check_screen_resolution'},), 17:09:32 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:09:32 INFO - 'cmd': ('bash', 17:09:32 INFO - '-c', 17:09:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:09:32 INFO - 'enabled': True, 17:09:32 INFO - 'halt_on_failure': False, 17:09:32 INFO - 'name': 'check_screen_resolution'},), 17:09:32 INFO - 'run_cmd_checks_enabled': True, 17:09:32 INFO - 'sps_profile': False, 17:09:32 INFO - 'sps_profile_interval': 0, 17:09:32 INFO - 'suite': 'dromaeojs-e10s', 17:09:32 INFO - 'system_bits': '32', 17:09:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:09:32 INFO - 'title': 't-yosemite-r7-0230', 17:09:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:09:32 INFO - 'use_talos_json': True, 17:09:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:09:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:09:32 INFO - 'work_dir': 'build'} 17:09:32 INFO - ##### 17:09:32 INFO - ##### Running clobber step. 17:09:32 INFO - ##### 17:09:32 INFO - Running pre-action listener: _resource_record_pre_action 17:09:32 INFO - Running main action method: clobber 17:09:32 INFO - rmtree: /builds/slave/test/build 17:09:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:09:33 INFO - Running post-action listener: _resource_record_post_action 17:09:33 INFO - ##### 17:09:33 INFO - ##### Finished clobber step (success) 17:09:33 INFO - ##### 17:09:33 INFO - ##### 17:09:33 INFO - ##### Running read-buildbot-config step. 17:09:33 INFO - ##### 17:09:33 INFO - Running pre-action listener: _resource_record_pre_action 17:09:33 INFO - Running main action method: read_buildbot_config 17:09:33 INFO - Using buildbot properties: 17:09:33 INFO - { 17:09:33 INFO - "project": "", 17:09:33 INFO - "product": "firefox", 17:09:33 INFO - "script_repo_revision": "production", 17:09:33 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 17:09:33 INFO - "repository": "", 17:09:33 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 17:09:33 INFO - "buildid": "20160523151340", 17:09:33 INFO - "pgo_build": "False", 17:09:33 INFO - "basedir": "/builds/slave/test", 17:09:33 INFO - "buildnumber": 677, 17:09:33 INFO - "slavename": "t-yosemite-r7-0230", 17:09:33 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 17:09:33 INFO - "platform": "yosemite_r7", 17:09:33 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 17:09:33 INFO - "branch": "fx-team", 17:09:33 INFO - "repo_path": "integration/fx-team", 17:09:33 INFO - "revision": "cb4081774f86e6f121feeb86c923ec54de47441c", 17:09:33 INFO - "stage_platform": "macosx64", 17:09:33 INFO - "builduid": "ef4c186141b34990b37a69b5173375d2", 17:09:33 INFO - "slavebuilddir": "test" 17:09:33 INFO - } 17:09:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/eaqnZR3wSb6b9FD60K96ug/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 17:09:33 INFO - Running post-action listener: _resource_record_post_action 17:09:33 INFO - ##### 17:09:33 INFO - ##### Finished read-buildbot-config step (success) 17:09:33 INFO - ##### 17:09:33 INFO - ##### 17:09:33 INFO - ##### Running download-and-extract step. 17:09:33 INFO - ##### 17:09:33 INFO - Running pre-action listener: _resource_record_pre_action 17:09:33 INFO - Running main action method: download_and_extract 17:09:33 INFO - mkdir: /builds/slave/test/build/tests 17:09: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')]} 17:09:33 INFO - https://queue.taskcluster.net/v1/task/eaqnZR3wSb6b9FD60K96ug/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 17:09:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eaqnZR3wSb6b9FD60K96ug/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 17:09:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eaqnZR3wSb6b9FD60K96ug/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 17:09:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eaqnZR3wSb6b9FD60K96ug/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 17:09:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eaqnZR3wSb6b9FD60K96ug/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 17:09:57 INFO - Downloaded 1199 bytes. 17:09:57 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 17:09:57 INFO - Using the following test package requirements: 17:09:57 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 17:09:57 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 17:09:57 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 17:09:57 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 17:09:57 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 17:09:57 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 17:09:57 INFO - u'jsshell-mac.zip'], 17:09:57 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 17:09:57 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 17:09:57 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 17:09:57 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 17:09:57 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 17:09:57 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 17:09:57 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 17:09:57 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 17:09:57 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 17:09:57 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 17:09:57 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 17:09:57 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:09: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')]} 17:09:57 INFO - https://queue.taskcluster.net/v1/task/eaqnZR3wSb6b9FD60K96ug/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:09:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eaqnZR3wSb6b9FD60K96ug/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 17:09:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eaqnZR3wSb6b9FD60K96ug/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 17:09:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eaqnZR3wSb6b9FD60K96ug/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 17:09:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eaqnZR3wSb6b9FD60K96ug/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 17:09:59 INFO - Downloaded 18630445 bytes. 17:09:59 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'] 17:09:59 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 17:10:02 INFO - Return code: 0 17:10:02 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 17:10:02 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')]} 17:10:02 INFO - https://queue.taskcluster.net/v1/task/eaqnZR3wSb6b9FD60K96ug/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:10:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eaqnZR3wSb6b9FD60K96ug/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 17:10:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eaqnZR3wSb6b9FD60K96ug/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 17:10:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eaqnZR3wSb6b9FD60K96ug/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 17:10:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eaqnZR3wSb6b9FD60K96ug/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 17:10:06 INFO - Downloaded 18630445 bytes. 17:10:06 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'] 17:10:06 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 17:10:09 INFO - Return code: 0 17:10:09 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')]} 17:10:09 INFO - https://queue.taskcluster.net/v1/task/eaqnZR3wSb6b9FD60K96ug/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 17:10:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eaqnZR3wSb6b9FD60K96ug/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 17:10:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eaqnZR3wSb6b9FD60K96ug/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 17:10:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eaqnZR3wSb6b9FD60K96ug/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 17:10:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eaqnZR3wSb6b9FD60K96ug/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 17:10:10 INFO - Downloaded 10840359 bytes. 17:10:10 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'] 17:10:10 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 17:10:10 INFO - Return code: 0 17:10:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:10 INFO - https://queue.taskcluster.net/v1/task/eaqnZR3wSb6b9FD60K96ug/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 17:10:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eaqnZR3wSb6b9FD60K96ug/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 17:10:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eaqnZR3wSb6b9FD60K96ug/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 17:10:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eaqnZR3wSb6b9FD60K96ug/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 17:10:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eaqnZR3wSb6b9FD60K96ug/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 17:10:16 INFO - Downloaded 110167748 bytes. 17:10:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eaqnZR3wSb6b9FD60K96ug/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 17:10:16 INFO - mkdir: /builds/slave/test/properties 17:10:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:10:16 INFO - Writing to file /builds/slave/test/properties/build_url 17:10:16 INFO - Contents: 17:10:16 INFO - build_url:https://queue.taskcluster.net/v1/task/eaqnZR3wSb6b9FD60K96ug/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 17:10:17 INFO - Running post-action listener: _resource_record_post_action 17:10:17 INFO - Running post-action listener: set_extra_try_arguments 17:10:17 INFO - ##### 17:10:17 INFO - ##### Finished download-and-extract step (success) 17:10:17 INFO - ##### 17:10:17 INFO - ##### 17:10:17 INFO - ##### Running populate-webroot step. 17:10:17 INFO - ##### 17:10:17 INFO - Running pre-action listener: _resource_record_pre_action 17:10:17 INFO - Running main action method: populate_webroot 17:10:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:10:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:10:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:10:17 INFO - '--tppagecycles', 17:10:17 INFO - '7'], 17:10:17 INFO - 'tests': ['tsvgm']}}, 17:10:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:10:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:10:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:10:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:10:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:10:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:10:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:17 INFO - 'talos_options': ['--disable-e10s'], 17:10:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:10:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:10:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:17 INFO - 'talos_options': ['--disable-e10s'], 17:10:17 INFO - 'tests': ['damp', 'tps']}, 17:10:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:17 INFO - 'tests': ['damp', 'tps']}, 17:10:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:10:17 INFO - 'tests': ['dromaeo_dom']}, 17:10:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:10:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:10:17 INFO - 'tests': ['a11yr', 17:10:17 INFO - 'ts_paint', 17:10:17 INFO - 'tpaint', 17:10:17 INFO - 'sessionrestore', 17:10:17 INFO - 'sessionrestore_no_auto_restore', 17:10:17 INFO - 'tabpaint']}, 17:10:17 INFO - 'other-e10s': {'tests': ['a11yr', 17:10:17 INFO - 'ts_paint', 17:10:17 INFO - 'tpaint', 17:10:17 INFO - 'sessionrestore', 17:10:17 INFO - 'sessionrestore_no_auto_restore', 17:10:17 INFO - 'tabpaint']}, 17:10:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:10:17 INFO - 'ts_paint', 17:10:17 INFO - 'tpaint', 17:10:17 INFO - 'sessionrestore', 17:10:17 INFO - 'sessionrestore_no_auto_restore', 17:10:17 INFO - 'tabpaint']}, 17:10:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:10:17 INFO - 'ts_paint', 17:10:17 INFO - 'tpaint', 17:10:17 INFO - 'sessionrestore', 17:10:17 INFO - 'sessionrestore_no_auto_restore', 17:10:17 INFO - 'tabpaint']}, 17:10:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:10:17 INFO - 'tests': ['a11yr', 17:10:17 INFO - 'ts_paint', 17:10:17 INFO - 'tpaint', 17:10:17 INFO - 'sessionrestore', 17:10:17 INFO - 'sessionrestore_no_auto_restore', 17:10:17 INFO - 'tabpaint']}, 17:10:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:10:17 INFO - 'tests': ['a11yr', 17:10:17 INFO - 'ts_paint', 17:10:17 INFO - 'tpaint', 17:10:17 INFO - 'sessionrestore', 17:10:17 INFO - 'sessionrestore_no_auto_restore', 17:10:17 INFO - 'tabpaint']}, 17:10:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:10:17 INFO - 'tests': ['tsvgx', 17:10:17 INFO - 'tsvgr_opacity', 17:10:17 INFO - 'tart', 17:10:17 INFO - 'tscrollx', 17:10:17 INFO - 'cart']}, 17:10:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:10:17 INFO - 'tsvgr_opacity', 17:10:17 INFO - 'tart', 17:10:17 INFO - 'tscrollx', 17:10:17 INFO - 'cart']}, 17:10:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:17 INFO - 'talos_options': ['--disable-e10s'], 17:10:17 INFO - 'tests': ['tp5o']}, 17:10:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:17 INFO - 'tests': ['tp5o']}, 17:10:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:17 INFO - 'talos_options': ['--disable-e10s', 17:10:17 INFO - '--xperf_path', 17:10:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:10:17 INFO - 'tests': ['tp5n']}, 17:10:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:17 INFO - 'talos_options': ['--xperf_path', 17:10:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:10:17 INFO - 'tests': ['tp5n']}}, 17:10:17 INFO - 'talos.zip': {'path': '', 17:10:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:10:17 INFO - Running post-action listener: _resource_record_post_action 17:10:17 INFO - ##### 17:10:17 INFO - ##### Finished populate-webroot step (success) 17:10:17 INFO - ##### 17:10:17 INFO - ##### 17:10:17 INFO - ##### Running create-virtualenv step. 17:10:17 INFO - ##### 17:10:17 INFO - Running pre-action listener: _resource_record_pre_action 17:10:17 INFO - Running main action method: create_virtualenv 17:10:17 INFO - Creating virtualenv /builds/slave/test/build/venv 17:10:17 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 17:10:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:10:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:10:17 INFO - Using real prefix '/tools/python27' 17:10:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:10:18 INFO - Installing distribute.............................................................................................................................................................................................done. 17:10:21 INFO - Installing pip.................done. 17:10:21 INFO - Return code: 0 17:10:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:10:21 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')]} 17:10:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:21 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')]} 17:10:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:21 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 0x10ad9aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ada0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce2849ebf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac3ed30>, '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 0x10aa62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac35b20>, '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.b5tKPQfxms/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.6HwiSwKaqP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/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 17:10:21 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 17:10:21 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 17:10:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b5tKPQfxms/Render', 17:10:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:10:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:10:21 INFO - 'HOME': '/Users/cltbld', 17:10:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:10:21 INFO - 'LOGNAME': 'cltbld', 17:10:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:21 INFO - 'MOZ_NO_REMOTE': '1', 17:10:21 INFO - 'NO_EM_RESTART': '1', 17:10:21 INFO - 'PAGER': '/bin/cat', 17:10:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:10:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:21 INFO - 'PWD': '/builds/slave/test', 17:10:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:10:21 INFO - 'SHELL': '/bin/bash', 17:10:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6HwiSwKaqP/Listeners', 17:10:21 INFO - 'TMPDIR': '/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/', 17:10:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:10:21 INFO - 'USER': 'cltbld', 17:10:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:10:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:10:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:21 INFO - 'XPC_FLAGS': '0x0', 17:10:21 INFO - 'XPC_SERVICE_NAME': '0', 17:10:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:10:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:21 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 17:10:21 INFO - Cleaning up... 17:10:21 INFO - Return code: 0 17:10:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:10:21 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')]} 17:10:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:21 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')]} 17:10:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:21 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 0x10ad9aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ada0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce2849ebf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac3ed30>, '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 0x10aa62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac35b20>, '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.b5tKPQfxms/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.6HwiSwKaqP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/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 17:10:21 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 17:10:21 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 17:10:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b5tKPQfxms/Render', 17:10:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:10:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:10:21 INFO - 'HOME': '/Users/cltbld', 17:10:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:10:21 INFO - 'LOGNAME': 'cltbld', 17:10:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:21 INFO - 'MOZ_NO_REMOTE': '1', 17:10:21 INFO - 'NO_EM_RESTART': '1', 17:10:21 INFO - 'PAGER': '/bin/cat', 17:10:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:10:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:21 INFO - 'PWD': '/builds/slave/test', 17:10:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:10:21 INFO - 'SHELL': '/bin/bash', 17:10:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6HwiSwKaqP/Listeners', 17:10:21 INFO - 'TMPDIR': '/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/', 17:10:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:10:21 INFO - 'USER': 'cltbld', 17:10:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:10:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:10:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:21 INFO - 'XPC_FLAGS': '0x0', 17:10:21 INFO - 'XPC_SERVICE_NAME': '0', 17:10:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:10:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:21 INFO - Downloading/unpacking psutil>=3.1.1 17:10: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 17:10: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 17:10: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 17:10: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 17:10: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 17:10: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 17:10:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:10:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:10:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:10:24 INFO - Installing collected packages: psutil 17:10:24 INFO - Running setup.py install for psutil 17:10:24 INFO - building 'psutil._psutil_osx' extension 17:10:24 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 17:10:25 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 17:10:25 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 17:10:25 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 17:10:25 INFO - building 'psutil._psutil_posix' extension 17:10:25 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 17:10:25 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:10:25 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:10:25 INFO - ^ 17:10:25 INFO - 1 warning generated. 17:10:25 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 17:10:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:10:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:10:25 INFO - Successfully installed psutil 17:10:25 INFO - Cleaning up... 17:10:25 INFO - Return code: 0 17:10:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:10:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:25 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 0x10ad9aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ada0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce2849ebf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac3ed30>, '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 0x10aa62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac35b20>, '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.b5tKPQfxms/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.6HwiSwKaqP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/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 17:10:25 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 17:10:25 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 17:10:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b5tKPQfxms/Render', 17:10:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:10:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:10:25 INFO - 'HOME': '/Users/cltbld', 17:10:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:10:25 INFO - 'LOGNAME': 'cltbld', 17:10:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:25 INFO - 'MOZ_NO_REMOTE': '1', 17:10:25 INFO - 'NO_EM_RESTART': '1', 17:10:25 INFO - 'PAGER': '/bin/cat', 17:10:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:10:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:25 INFO - 'PWD': '/builds/slave/test', 17:10:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:10:25 INFO - 'SHELL': '/bin/bash', 17:10:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6HwiSwKaqP/Listeners', 17:10:25 INFO - 'TMPDIR': '/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/', 17:10:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:10:25 INFO - 'USER': 'cltbld', 17:10:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:10:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:10:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:25 INFO - 'XPC_FLAGS': '0x0', 17:10:25 INFO - 'XPC_SERVICE_NAME': '0', 17:10:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:10:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:10:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:10:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:10:28 INFO - Installing collected packages: mozsystemmonitor 17:10:28 INFO - Running setup.py install for mozsystemmonitor 17:10:28 INFO - Successfully installed mozsystemmonitor 17:10:28 INFO - Cleaning up... 17:10:28 INFO - Return code: 0 17:10:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:10:28 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')]} 17:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:28 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')]} 17:10:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:28 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 0x10ad9aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ada0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce2849ebf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac3ed30>, '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 0x10aa62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac35b20>, '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.b5tKPQfxms/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.6HwiSwKaqP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/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 17:10:28 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 17:10:28 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 17:10:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b5tKPQfxms/Render', 17:10:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:10:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:10:28 INFO - 'HOME': '/Users/cltbld', 17:10:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:10:28 INFO - 'LOGNAME': 'cltbld', 17:10:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:28 INFO - 'MOZ_NO_REMOTE': '1', 17:10:28 INFO - 'NO_EM_RESTART': '1', 17:10:28 INFO - 'PAGER': '/bin/cat', 17:10:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:10:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:28 INFO - 'PWD': '/builds/slave/test', 17:10:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:10:28 INFO - 'SHELL': '/bin/bash', 17:10:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6HwiSwKaqP/Listeners', 17:10:28 INFO - 'TMPDIR': '/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/', 17:10:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:10:28 INFO - 'USER': 'cltbld', 17:10:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:10:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:10:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:28 INFO - 'XPC_FLAGS': '0x0', 17:10:28 INFO - 'XPC_SERVICE_NAME': '0', 17:10:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:10:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:28 INFO - Downloading/unpacking blobuploader==1.2.4 17:10:28 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 17:10:28 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 17:10:28 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 17:10:28 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 17:10:28 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 17:10:28 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 17:10:31 INFO - Downloading blobuploader-1.2.4.tar.gz 17:10:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:10:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:10:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:10:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:10:32 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 17:10:32 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 17:10:32 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 17:10:32 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 17:10:32 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 17:10:32 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 17:10:32 INFO - Downloading docopt-0.6.1.tar.gz 17:10:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:10:32 INFO - Installing collected packages: blobuploader, requests, docopt 17:10:32 INFO - Running setup.py install for blobuploader 17:10:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:10:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:10:32 INFO - Running setup.py install for requests 17:10:33 INFO - Running setup.py install for docopt 17:10:33 INFO - Successfully installed blobuploader requests docopt 17:10:33 INFO - Cleaning up... 17:10:33 INFO - Return code: 0 17:10:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:10: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')]} 17:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:34 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 0x10ad9aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ada0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce2849ebf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac3ed30>, '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 0x10aa62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac35b20>, '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.b5tKPQfxms/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.6HwiSwKaqP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/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 17:10:34 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 17:10:34 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 17:10:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b5tKPQfxms/Render', 17:10:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:10:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:10:34 INFO - 'HOME': '/Users/cltbld', 17:10:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:10:34 INFO - 'LOGNAME': 'cltbld', 17:10:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:34 INFO - 'MOZ_NO_REMOTE': '1', 17:10:34 INFO - 'NO_EM_RESTART': '1', 17:10:34 INFO - 'PAGER': '/bin/cat', 17:10:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:10:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:34 INFO - 'PWD': '/builds/slave/test', 17:10:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:10:34 INFO - 'SHELL': '/bin/bash', 17:10:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6HwiSwKaqP/Listeners', 17:10:34 INFO - 'TMPDIR': '/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/', 17:10:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:10:34 INFO - 'USER': 'cltbld', 17:10:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:10:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:10:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:34 INFO - 'XPC_FLAGS': '0x0', 17:10:34 INFO - 'XPC_SERVICE_NAME': '0', 17:10:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:10:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:10:34 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-LcrXAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:10:34 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-jX2Nwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:10:34 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-dlme9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:10:34 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-7yNpnz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:10:34 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-QLgUs7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:10:34 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-tbXRbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:10:35 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-SHM_ua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:10:35 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-GSfgdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:10:35 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-GumZRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:10:35 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-bpN23X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:10:35 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-jawCpV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:10:35 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-dlDFTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:10:35 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-YXQP1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:10:35 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-Vl49Gw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:10:35 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-TLLNxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:10:35 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-Rhvgdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:10:36 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-_bjJHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:10:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:10:36 INFO - Running setup.py install for manifestparser 17:10:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:10:36 INFO - Running setup.py install for mozcrash 17:10:36 INFO - Running setup.py install for mozdebug 17:10:36 INFO - Running setup.py install for mozdevice 17:10:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:10:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:10:36 INFO - Running setup.py install for mozfile 17:10:36 INFO - Running setup.py install for mozhttpd 17:10:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:10:37 INFO - Running setup.py install for mozinfo 17:10:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:10:37 INFO - Running setup.py install for mozInstall 17:10:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:10:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:10:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:10:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:10:37 INFO - Running setup.py install for mozleak 17:10:37 INFO - Running setup.py install for mozlog 17:10:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:10:37 INFO - Running setup.py install for moznetwork 17:10:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:10:37 INFO - Running setup.py install for mozprocess 17:10:37 INFO - Running setup.py install for mozprofile 17:10:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:10:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:10:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:10:38 INFO - Running setup.py install for mozrunner 17:10:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:10:38 INFO - Running setup.py install for mozscreenshot 17:10:38 INFO - Running setup.py install for moztest 17:10:38 INFO - Running setup.py install for mozversion 17:10:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:10:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:10:38 INFO - Cleaning up... 17:10:38 INFO - Return code: 0 17:10:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:10:38 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')]} 17:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:38 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')]} 17:10:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:38 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 0x10ad9aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ada0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce2849ebf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac3ed30>, '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 0x10aa62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac35b20>, '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.b5tKPQfxms/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.6HwiSwKaqP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/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 17:10:38 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 17:10:38 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 17:10:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b5tKPQfxms/Render', 17:10:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:10:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:10:38 INFO - 'HOME': '/Users/cltbld', 17:10:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:10:38 INFO - 'LOGNAME': 'cltbld', 17:10:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:38 INFO - 'MOZ_NO_REMOTE': '1', 17:10:38 INFO - 'NO_EM_RESTART': '1', 17:10:38 INFO - 'PAGER': '/bin/cat', 17:10:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:10:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:38 INFO - 'PWD': '/builds/slave/test', 17:10:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:10:38 INFO - 'SHELL': '/bin/bash', 17:10:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6HwiSwKaqP/Listeners', 17:10:38 INFO - 'TMPDIR': '/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/', 17:10:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:10:38 INFO - 'USER': 'cltbld', 17:10:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:10:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:10:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:38 INFO - 'XPC_FLAGS': '0x0', 17:10:38 INFO - 'XPC_SERVICE_NAME': '0', 17:10:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:10:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:10:39 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-Rdt5Iw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:10:39 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)) 17:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:10:39 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-arDH_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:10:39 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)) 17:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:10:39 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-Wm0Z2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:10:39 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)) 17:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:10:39 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-KtYYNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:10:39 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)) 17:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:10:39 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-wEnB8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:10:39 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)) 17:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:10:39 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-7EGlpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:10:39 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)) 17:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:10:39 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-Xe8yWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:10:39 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)) 17:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:10:39 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-5jjgdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:10:39 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)) 17:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:10:39 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-La1aa7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:10:39 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)) 17:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:10:40 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-tHrXG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:10:40 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)) 17:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:10:40 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-MkUwqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:10:40 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)) 17:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:10:40 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-558JZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:10:40 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)) 17:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:10:40 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-OzxKqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:10:40 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)) 17:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:10:40 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-WsbWbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:10:40 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)) 17:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:10:40 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-rtaXtE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:10:40 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)) 17:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:10:40 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-dtwuz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:10:40 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)) 17:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:10:40 INFO - Running setup.py (path:/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/pip-1lvgbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:10:40 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)) 17:10:40 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)) 17:10:40 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)) 17:10:40 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)) 17:10:40 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)) 17:10:40 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)) 17:10:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:10:40 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 17:10:40 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 17:10:40 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 17:10:40 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 17:10:40 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 17:10:40 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 17:10:43 INFO - Downloading blessings-1.6.tar.gz 17:10:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:10:43 INFO - Installing collected packages: blessings 17:10:43 INFO - Running setup.py install for blessings 17:10:43 INFO - Successfully installed blessings 17:10:43 INFO - Cleaning up... 17:10:43 INFO - Return code: 0 17:10:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:10:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:10:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:10:43 INFO - Reading from file tmpfile_stdout 17:10:43 INFO - Current package versions: 17:10:43 INFO - blessings == 1.6 17:10:43 INFO - blobuploader == 1.2.4 17:10:43 INFO - docopt == 0.6.1 17:10:43 INFO - manifestparser == 1.1 17:10:43 INFO - mozInstall == 1.12 17:10:43 INFO - mozcrash == 0.17 17:10:43 INFO - mozdebug == 0.1 17:10:43 INFO - mozdevice == 0.48 17:10:43 INFO - mozfile == 1.2 17:10:43 INFO - mozhttpd == 0.7 17:10:43 INFO - mozinfo == 0.9 17:10:43 INFO - mozleak == 0.1 17:10:43 INFO - mozlog == 3.2 17:10:43 INFO - moznetwork == 0.27 17:10:43 INFO - mozprocess == 0.22 17:10:43 INFO - mozprofile == 0.28 17:10:43 INFO - mozrunner == 6.11 17:10:43 INFO - mozscreenshot == 0.1 17:10:43 INFO - mozsystemmonitor == 0.3 17:10:43 INFO - moztest == 0.7 17:10:43 INFO - mozversion == 1.4 17:10:43 INFO - psutil == 3.1.1 17:10:43 INFO - requests == 1.2.3 17:10:43 INFO - wsgiref == 0.1.2 17:10:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:10: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')]} 17:10:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10: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')]} 17:10:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:43 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 0x10ad9aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ada0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce2849ebf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac3ed30>, '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 0x10aa62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac35b20>, '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.b5tKPQfxms/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.6HwiSwKaqP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/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 17:10:43 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 17:10:43 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 17:10:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b5tKPQfxms/Render', 17:10:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:10:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:10:43 INFO - 'HOME': '/Users/cltbld', 17:10:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:10:43 INFO - 'LOGNAME': 'cltbld', 17:10:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:43 INFO - 'MOZ_NO_REMOTE': '1', 17:10:43 INFO - 'NO_EM_RESTART': '1', 17:10:43 INFO - 'PAGER': '/bin/cat', 17:10:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:10:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:43 INFO - 'PWD': '/builds/slave/test', 17:10:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:10:43 INFO - 'SHELL': '/bin/bash', 17:10:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6HwiSwKaqP/Listeners', 17:10:43 INFO - 'TMPDIR': '/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/', 17:10:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:10:43 INFO - 'USER': 'cltbld', 17:10:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:10:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:10:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:43 INFO - 'XPC_FLAGS': '0x0', 17:10:43 INFO - 'XPC_SERVICE_NAME': '0', 17:10:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:10:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:44 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)) 17:10:44 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)) 17:10:44 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)) 17:10:44 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)) 17:10:44 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)) 17:10:44 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)) 17:10:44 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)) 17:10:44 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)) 17:10:44 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)) 17:10:44 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)) 17:10:44 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)) 17:10:44 INFO - Cleaning up... 17:10:44 INFO - Return code: 0 17:10:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:10:44 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')]} 17:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:44 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')]} 17:10:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:44 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 0x10ad9aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ada0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce2849ebf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac3ed30>, '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 0x10aa62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac35b20>, '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.b5tKPQfxms/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.6HwiSwKaqP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/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 17:10:44 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 17:10:44 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 17:10:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b5tKPQfxms/Render', 17:10:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:10:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:10:44 INFO - 'HOME': '/Users/cltbld', 17:10:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:10:44 INFO - 'LOGNAME': 'cltbld', 17:10:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:44 INFO - 'MOZ_NO_REMOTE': '1', 17:10:44 INFO - 'NO_EM_RESTART': '1', 17:10:44 INFO - 'PAGER': '/bin/cat', 17:10:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:10:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:44 INFO - 'PWD': '/builds/slave/test', 17:10:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:10:44 INFO - 'SHELL': '/bin/bash', 17:10:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6HwiSwKaqP/Listeners', 17:10:44 INFO - 'TMPDIR': '/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/', 17:10:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:10:44 INFO - 'USER': 'cltbld', 17:10:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:10:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:10:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:44 INFO - 'XPC_FLAGS': '0x0', 17:10:44 INFO - 'XPC_SERVICE_NAME': '0', 17:10:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:10:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:44 INFO - Downloading/unpacking jsonschema 17:10:44 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 17:10:44 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 17:10:44 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 17:10:44 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 17:10:44 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 17:10:44 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 17:10:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:10:46 INFO - Downloading/unpacking functools32 (from jsonschema) 17:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:47 INFO - Downloading functools32-3.2.3-2.tar.gz 17:10:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:10:47 INFO - warning: no files found matching '*.txt' 17:10:47 INFO - no previously-included directories found matching 'build' 17:10:47 INFO - no previously-included directories found matching 'dist' 17:10:47 INFO - no previously-included directories found matching '.git*' 17:10:47 INFO - Installing collected packages: jsonschema, functools32 17:10:47 INFO - Running setup.py install for functools32 17:10:47 INFO - warning: no files found matching '*.txt' 17:10:47 INFO - no previously-included directories found matching 'build' 17:10:47 INFO - no previously-included directories found matching 'dist' 17:10:47 INFO - no previously-included directories found matching '.git*' 17:10:47 INFO - Successfully installed jsonschema functools32 17:10:47 INFO - Cleaning up... 17:10:47 INFO - Return code: 0 17:10:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:10:47 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')]} 17:10:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:47 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')]} 17:10:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:47 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 0x10ad9aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ada0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce2849ebf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac3ed30>, '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 0x10aa62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac35b20>, '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.b5tKPQfxms/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.6HwiSwKaqP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/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 17:10:47 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 17:10:47 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 17:10:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b5tKPQfxms/Render', 17:10:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:10:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:10:47 INFO - 'HOME': '/Users/cltbld', 17:10:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:10:47 INFO - 'LOGNAME': 'cltbld', 17:10:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:47 INFO - 'MOZ_NO_REMOTE': '1', 17:10:47 INFO - 'NO_EM_RESTART': '1', 17:10:47 INFO - 'PAGER': '/bin/cat', 17:10:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:10:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:47 INFO - 'PWD': '/builds/slave/test', 17:10:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:10:47 INFO - 'SHELL': '/bin/bash', 17:10:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6HwiSwKaqP/Listeners', 17:10:47 INFO - 'TMPDIR': '/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/', 17:10:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:10:47 INFO - 'USER': 'cltbld', 17:10:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:10:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:10:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:47 INFO - 'XPC_FLAGS': '0x0', 17:10:47 INFO - 'XPC_SERVICE_NAME': '0', 17:10:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:10:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:47 INFO - Downloading/unpacking flake8 17:10:47 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 17:10:47 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 17:10:47 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 17:10:47 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 17:10:47 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 17:10:47 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 17:10:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:10:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:10:50 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 17:10:50 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 17:10:50 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 17:10:50 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 17:10:50 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 17:10:50 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 17:10:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:10:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:10:50 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 17:10:50 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 17:10:50 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 17:10:50 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 17:10:50 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 17:10:50 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 17:10:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:10:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:10:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:10:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:10:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:10:51 INFO - no previously-included directories found matching 'docs/_build' 17:10:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:10:51 INFO - Running setup.py install for pep8 17:10:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:10:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:10:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:10:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:10:51 INFO - no previously-included directories found matching 'docs/_build' 17:10:52 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:10:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:10:52 INFO - Cleaning up... 17:10:52 INFO - Return code: 0 17:10:52 INFO - Running post-action listener: _resource_record_post_action 17:10:52 INFO - Running post-action listener: _start_resource_monitoring 17:10:52 INFO - Starting resource monitoring. 17:10:52 INFO - ##### 17:10:52 INFO - ##### Finished create-virtualenv step (success) 17:10:52 INFO - ##### 17:10:52 INFO - ##### 17:10:52 INFO - ##### Running install step. 17:10:52 INFO - ##### 17:10:52 INFO - Running pre-action listener: _resource_record_pre_action 17:10:52 INFO - Running main action method: install 17:10:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:10:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:10:52 INFO - Reading from file tmpfile_stdout 17:10:52 INFO - Detecting whether we're running mozinstall >=1.0... 17:10:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:10:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:10:52 INFO - Reading from file tmpfile_stdout 17:10:52 INFO - Output received: 17:10:52 INFO - Usage: mozinstall [options] installer 17:10:52 INFO - Options: 17:10:52 INFO - -h, --help show this help message and exit 17:10:52 INFO - -d DEST, --destination=DEST 17:10:52 INFO - Directory to install application into. [default: 17:10:52 INFO - "/builds/slave/test"] 17:10:52 INFO - --app=APP Application being installed. [default: firefox] 17:10:52 INFO - mkdir: /builds/slave/test/build/application 17:10:52 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'] 17:10:52 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 17:11:26 INFO - Reading from file tmpfile_stdout 17:11:26 INFO - Output received: 17:11:26 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:11:26 INFO - Running post-action listener: _resource_record_post_action 17:11:26 INFO - ##### 17:11:26 INFO - ##### Finished install step (success) 17:11:26 INFO - ##### 17:11:26 INFO - ##### 17:11:26 INFO - ##### Running run-tests step. 17:11:26 INFO - ##### 17:11:26 INFO - Running pre-action listener: _resource_record_pre_action 17:11:26 INFO - Running main action method: run_tests 17:11:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:11:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:11:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:11:26 INFO - 2016-05-23 17:11:26.574 screenresolution[2495:37264] starting screenresolution argv=screenresolution get 17:11:26 INFO - 2016-05-23 17:11:26.577 screenresolution[2495:37264] Display 0: 1600x1200x32@60 17:11:26 INFO - 2016-05-23 17:11:26.582 screenresolution[2496:37267] starting screenresolution argv=screenresolution list 17:11:26 INFO - Available Modes on Display 0 17:11:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:11:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:11:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:11:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:11:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:11:26 INFO - Intel Iris: 17:11:26 INFO - Chipset Model: Intel Iris 17:11:26 INFO - Type: GPU 17:11:26 INFO - Bus: Built-In 17:11:26 INFO - VRAM (Dynamic, Max): 1536 MB 17:11:26 INFO - Vendor: Intel (0x8086) 17:11:26 INFO - Device ID: 0x0a2e 17:11:26 INFO - Revision ID: 0x0009 17:11:26 INFO - Displays: 17:11:26 INFO - Display: 17:11:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:11:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:11:26 INFO - Display Serial Number: 1600x1200 60 17:11:26 INFO - Main Display: Yes 17:11:26 INFO - Mirror: Off 17:11:26 INFO - Online: Yes 17:11:26 INFO - Rotation: Supported 17:11:26 INFO - Return code: 0 17:11:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:11:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:11:26 INFO - Python 2.7.3 17:11:26 INFO - Return code: 0 17:11:26 INFO - grabbing minidump binary from tooltool 17:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:11:26 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 0x10ac3ed30>, '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 0x10aa62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac35b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:11:26 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 17:11:26 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 17:11:26 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 17:11:26 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:11:26 INFO - Return code: 0 17:11:26 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:11:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:11:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:11:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:11:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:11:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:11:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:11:28 INFO - Return code: 0 17:11:28 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/eaqnZR3wSb6b9FD60K96ug/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0230', '--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 17:11:28 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/eaqnZR3wSb6b9FD60K96ug/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0230 --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 17:11:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b5tKPQfxms/Render', 17:11:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:11:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:11:28 INFO - 'HOME': '/Users/cltbld', 17:11:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:11:28 INFO - 'LOGNAME': 'cltbld', 17:11:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:11:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:11:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:28 INFO - 'MOZ_NO_REMOTE': '1', 17:11:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:11:28 INFO - 'NO_EM_RESTART': '1', 17:11:28 INFO - 'PAGER': '/bin/cat', 17:11:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:11:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:28 INFO - 'PWD': '/builds/slave/test', 17:11:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:11:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:11:28 INFO - 'SHELL': '/bin/bash', 17:11:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6HwiSwKaqP/Listeners', 17:11:28 INFO - 'TMPDIR': '/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/', 17:11:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:11:28 INFO - 'USER': 'cltbld', 17:11:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:11:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:11:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:28 INFO - 'XPC_FLAGS': '0x0', 17:11:28 INFO - 'XPC_SERVICE_NAME': '0', 17:11:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:11:28 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/eaqnZR3wSb6b9FD60K96ug/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0230', '--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 17:11:28 INFO - mozversion application_buildid: 20160523151340 17:11:28 INFO - mozversion application_changeset: cb4081774f86e6f121feeb86c923ec54de47441c 17:11:28 INFO - mozversion application_display_name: Nightly 17:11:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:11:28 INFO - mozversion application_name: Firefox 17:11:28 INFO - mozversion application_remotingname: firefox 17:11:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 17:11:28 INFO - mozversion application_vendor: Mozilla 17:11:28 INFO - mozversion application_version: 49.0a1 17:11:28 INFO - mozversion platform_buildid: 20160523151340 17:11:28 INFO - mozversion platform_changeset: cb4081774f86e6f121feeb86c923ec54de47441c 17:11:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 17:11:28 INFO - mozversion platform_version: 49.0a1 17:11:28 INFO - using testdate: 1464048688 17:11:28 INFO - actual date: 1464048688 17:11:28 INFO - starting webserver on 'localhost:61078' 17:11:28 INFO - SUITE-START | Running 2 tests 17:11:28 INFO - TEST-START | dromaeo_css 17:11:28 INFO - operating with platform_type : mac_ 17:11:28 INFO - Initialising browser for dromaeo_css test... 17:11:28 INFO - TEST-INFO | started process 2514 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/tmp5jsgDh/profile http://localhost:61078/getInfo.html) 17:11:31 INFO - PROCESS | 2514 | __metrics Screen width/height:1600/1200 17:11:31 INFO - PROCESS | 2514 | colorDepth:24 17:11:31 INFO - PROCESS | 2514 | Browser inner width/height: 1024/689 17:11:31 INFO - PROCESS | 2514 | __metrics 17:11:31 ERROR - PROCESS | 2514 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 17:11:32 INFO - TEST-INFO | 2514: exit 0 17:11:32 INFO - Browser initialized. 17:11:32 INFO - Running cycle 1/1 for dromaeo_css test... 17:11:32 INFO - TEST-INFO | started process 2517 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/tmp5jsgDh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:11:44 INFO - PROCESS | 2517 | RSS: Main: 249872384 17:11:44 INFO - PROCESS | 2517 | 17:12:33 INFO - PROCESS | 2517 | 1464048753813 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] 17:14:44 INFO - PROCESS | 2517 | Cycle 1(1): loaded http://localhost:61078/tests/dromaeo/cssquery-dojo.html (next: http://localhost:61078/tests/dromaeo/cssquery-ext.html) 17:14:45 INFO - PROCESS | 2517 | RSS: Main: 262492160 17:14:45 INFO - PROCESS | 2517 | 17:17:47 INFO - PROCESS | 2517 | Cycle 1(1): loaded http://localhost:61078/tests/dromaeo/cssquery-ext.html (next: http://localhost:61078/tests/dromaeo/cssquery-jquery.html) 17:17:48 INFO - PROCESS | 2517 | RSS: Main: 273567744 17:17:48 INFO - PROCESS | 2517 | 17:20:50 INFO - PROCESS | 2517 | Cycle 1(1): loaded http://localhost:61078/tests/dromaeo/cssquery-jquery.html (next: http://localhost:61078/tests/dromaeo/cssquery-mootools.html) 17:20:51 INFO - PROCESS | 2517 | RSS: Main: 275709952 17:20:51 INFO - PROCESS | 2517 | 17:23:52 INFO - PROCESS | 2517 | Cycle 1(1): loaded http://localhost:61078/tests/dromaeo/cssquery-mootools.html (next: http://localhost:61078/tests/dromaeo/cssquery-prototype.html) 17:23:53 INFO - PROCESS | 2517 | RSS: Main: 277274624 17:23:53 INFO - PROCESS | 2517 | 17:26:56 INFO - PROCESS | 2517 | Cycle 1(1): loaded http://localhost:61078/tests/dromaeo/cssquery-prototype.html (next: http://localhost:61078/tests/dromaeo/cssquery-yui.html) 17:26:57 INFO - PROCESS | 2517 | RSS: Main: 280162304 17:26:57 INFO - PROCESS | 2517 | 17:29:59 INFO - PROCESS | 2517 | Cycle 1(1): loaded http://localhost:61078/tests/dromaeo/cssquery-yui.html (next: http://localhost:61078/tests/dromaeo/cssquery-dojo.html) 17:29:59 INFO - PROCESS | 2517 | RSS: Main: 281284608 17:29:59 INFO - PROCESS | 2517 | 17:29:59 INFO - PROCESS | 2517 | __start_tp_report 17:29:59 INFO - PROCESS | 2517 | _x_x_mozilla_page_load 17:29:59 INFO - PROCESS | 2517 | _x_x_mozilla_page_load_details 17:29:59 INFO - PROCESS | 2517 | |i|pagename|runs| 17:29:59 INFO - PROCESS | 2517 | |0;dojo.html;3224.903252902413;3530.029241958461;3535.39898217303;3560.786352818831;3576.642335766422;5855.648661080333;5866.090755932826;5969.343372229062;6007.909881351778;6017.097435384694;5737.598368114233;5849.415058494148;5864.882702345951;5940.405959404057;5992.640441573509;5258.894822103565;5310;5420.620556561043;5460.26286451328;5466.726663666821;220.53730049149658;5442.727863606824;5445.101558242905;5456.236126942231;5506.146547285177;5339.492748188916;5383.327084114466;5390.649607775502;5408.756605952722;5434.728263586805;5299.470052994709;5429.755660995225;5457.481539253765;5482.780688772445;5485;5273.973630131824;5292.629515933886;5321.920171197435;5334.333208348957;5373.623846330758;4984.2025275955675;5223.347081614798;5792.102224155263;5831.88336233273;5882.411758824126;5280.81517146898;6167.568270221086;6192.535559833031;6224.470919971808;6291.245050593958;5213.191955246905;6108.08378743192;6341.143945567335;6358.1734374531015;6360.427561519486;6086.573939824214;6110.511159107261;6118.694065296718;6122.571420000601;6131.662758548278;6246.250449945945;6288.8427789304715;6335.904961425582;6468.029795530708;6490.675466226764;6268.811935641938;6298.685065746694;6306;6319.715612797343;6352.110704501373;6316.589421687576;6324.810255692337;6336.271328797156;6355.904661430082;6361.332060133712;6189.597676151036;6223.439890409794;6281.780137695158;6285.340039295808;6318.147050148263;6197.690115494207;6209.534284928648;6214.533909956771;6219.315875253718;6255.186825712719;5111.105556527593;5124.538791508708;5130.820421285237;5131.999260144311;5146.150885103991;4499.1451624191295;4499.6400287976885;4509.098180363941;4576.610988065985;4604.194266003436;4635.351050852883;5842.649441033552;5943.58394912352;6070.696465176724;6105.725242364104;6378.872422551616;6379.075034120026;6379.840503987438;6392.456641185551;6398.29618741938;5861.501772349398;5999.760009599567;6041.214642096587;6076.453119219292;6101.206843110456;5521.861953451196;5606.859828504238;5607;5610.719464026783;5616.213730077792;5570.777168913279;6305.464035557029;6565.343465653492;6579.24338701046;6622.2715501294815;6241.407066328691;6248.156498872776;6368.840778980562;6368.872622547616;6372.936270637234;5475.780968761205;6566.474682025522;6613.834654133685;6627.569208001464;6651.06885036105;6196.597221180609;6220.564560480904;6287.182666253358;6334.303226644974;6336.746530138743;6221.968890155701;6364.64994425311;6377.394147555975;6384.042393640805;6386.393292637192;6157.199564056823;6157.72290246931;6271.310155882758;6298.338674439118;6305.716242768995;4633.675642705113;6136.610985192662;6178.66017369049;6255.96872015637;6283;5777.277840269966;6010.819675409744;6052.273727152594;6146.5248340398875;6148.016317389196;6219.626822390671;6248.312685604671;6315.210598675166;6321.336259692666;6335.429811317003;6040.395960403925;6049.51603871698;6092.543059270483;6226.533010024357;6245 17:29:59 INFO - PROCESS | 2517 | |1;ext.html;442.11576846307383;526.6129394894751;527.5700304252034;554.0829926471689;555.2615022020713;39535.0116247094;42681;42687.359689604644;42718;42749.35875961863;42769.572304276946;43337.34993975085;44058;44157.337639935344;44306.113877722426;9605.807883842337;9718.222542196607;9734.707958761213;9866.802663946717;9890.851637225447;9782.021797820233;9794.41233525987;9883.110520053193;9889.159421449149;9923.652672156475;9863.30956833022;9895;9921.305508614363;9934;9953.502324883762;9056.683016094405;9335.3465257432;9779.853302200401;9827.70516884491;9889.961554036794;9676.854847177297;9745.220382369393;9805.411675299505;9807;9811.803763924752;40869.591304086876;40959.59040409588;41231.58768412338;41465;41475.792621037006;2514.4342522932375;3109.253779093024;3194.185482701919;3213.4055199788113;3381.678740519647;28976.13071607855;29413.55879661807;30052.54921176184;30067.548986765218;30113.096607101605;2556.233130060993;2678.450917561895;2709.105995021638;2728.5770705540476;2959.0531030070388;474892.6255368736;488577;509516;558396;562147;66851;66934.66532667306;67481.32518674848;67851.66074169597;67968;31775.682243177736;35861.64138358583;36032.45951310732;36677.44983825245;69441.3055869445;16773.24520396585;16813.663726725397;16934.899231550156;16961.15194240283;16969.915150424167;12878.67803304925;12975.480980760853;12980.35098245084;12988.480460781462;13042.347882605833;20540.486487837923;20687.379378618665;20702.275420360515;20797.58404831925;20817.271395501386;8291.95854020726;8302.8339433211;8357.821737720435;8373.581320933929;8665;884.0938038510578;1009.5608410341379;1058.4496062047692;1066.861308029951;1076.3004047369272;29811;30144.026235671306;30222.84888575543;30452.84773576118;30642.69357306443;861.3798065392907;1089.4988305379457;1101.2126329674322;1142.8914253145938;1144.8454458648143;15302.158381288913;15428.84571154274;15634.921825391028;15654.530364089096;15718.030703235196;596094;684763;692437;696980;697580;60787.08819367713;61344;63147.36852631507;63614.36385636085;63796.043059354146;1449.0508716790519;1461.5907545886955;1468.801711768919;1472.4194212518253;1473.7641977283583;25879.22362329133;29678.81284748586;29906.85046574753;30021.24946876258;30116.342937034828;52607.73696131495;53761.655958601346;53826.92346153133;54471.18293225526;54775.72612136914;579309;585407;587485;589276.0536197291;590847;26343.20970370815;26347.868260658575;26389.208323750318;27187.320316992234;27592.758325874984;46355;47460;47729.28406073842;48027.03945921132;48177.75911120422;34195.14512137217;38908.80545597254;39597.40603891001;40080.79959600183;40617.78146655605;36216;38477.80761096177;38594.80702596469;38737;39536.60463395329;38520.61479385282;39091;39142.608573913894;39558.604413955494;39719;30045.3990920176;34317;34367.82816085903;34777.65222347744;35687.464688029184;23359.649605256276;24195.879020604785;25020.749792501843;25306.493870122125;25669.486610268064 17:29:59 INFO - PROCESS | 2517 | |2;jquery.html;372.7781969728012;374.6534455628543;377.08744837493265;390.3520156540144;397.9633055889408;19597;20898.89550552249;21012.26457073999;21577.13691452342;21754.12983480659;18779.967101809394;20879;21216.363509094714;21666.783332166673;22049.33851984443;4172.666186705072;5302.284191634138;5370.892582148354;5835.387284335136;6118.357572454895;5609.887802243953;6742.325767423267;6763.256041835394;6825.044493770876;6829.043933849265;6419.390157935012;6661.500387470935;6731.495137864656;6757.763478278262;6762.2223444304045;6406.775762848324;6693.765718199864;6745.3254674532645;6760.898586521206;6765.830854228634;5741.167530708024;5839.211706419622;5862.765489380419;5873.588848780544;5877.67672777997;22848.77151228483;22871.656925146137;23184.884075579514;24327.756722432725;26524.86737566319;689.3726708695114;2086.8330533557278;2175.749788774295;2227.8774667393286;2359;8966.730998070068;9843.704688859345;9915.752106197402;10954;15400.460983865623;1741.4340339389748;1777.4223377402395;1805.5666640006305;1841.815818418161;1851.3982955539368;61587.07654828844;101588;106613.46693266561;112985;124750.3762481191;9829.950850245703;10330.948345258226;10815.56737730482;11357.659270221906;11863.525458981716;14771.852281477048;14815.259237038104;14861;14861.851381486047;14867.182304973114;7589.468737188344;8221.301189398848;8468.322534197372;8621.655133794704;8691.826163476695;8374.413791034569;8534.70128545498;8636.093210212963;8638.185980944072;8661.350398720122;3970.086880017612;4508.813225585588;4626.791794369262;4665.393498845128;8055.556944368116;3641;3721.423179407196;3874.1670540833857;3892.2993861104706;3901.200253947934;815.2336803404899;830.5265998380864;857.9013413457408;972.411690926979;996.880374355082;16176.919115404584;20470.692939605917;20904.850233237317;21305.882760703644;21360.57278854414;904.7331037344;937.0650844200651;951.7382719751985;952.319091849331;1004.2919741582167;9250.537473126451;10602.628907988183;11080.445977701083;11108.777824443627;11146.331220126656;587942;616698;618967;625315;649140;104237.47881260545;137442;137849.93225101632;139925.9011114834;141438.29280853734;996.5067291690659;1017.7252141921788;1040.7554224757175;1043.5564884923876;1051.0855555666467;19302;19410.90294548518;19468.61062778765;19706.8029319705;19711.310104146287;50987.49012509976;51445;56302;57494;57746;77529.8370524454;79535.60232198802;83043.5847820757;85012.72480912668;85202;6102;6414.166158399378;7030.472714546532;7417.109946806418;7589.58257295854;9700.805983880142;10727.892721072689;12454.190477618926;12526.123171377916;12817.615471535868;8674.696385626472;10532.736681583021;10583.100436462679;10683.412412317086;10813.891861081289;7680.884786728316;10372.896271037192;10428.217883658604;10597.788044238918;10711.464426778473;5630.718464076862;8097.919020809716;10604.734881627712;10849.801485496375;10920;8076.71731489395;8087.353011758927;8252.917470825216;8279.586020699062;8331.791705207419;9840.42553191486;10782.67651970442;11030.007299342777;11043.503042363274;11085.334879907232 17:29:59 INFO - PROCESS | 2517 | |3;mootools.html;1317.3874148520936;1408.591508462546;1707.598714302139;1925.0759635375011;1929.266878586137;7816.609169541529;8598.183172598601;8606.139386061392;9103.271738260932;9116.042815504376;8700.695475658353;8838.204561589455;8977.281817454605;8977.596008179631;8994.820103597924;2376.275236053003;2406.6871306730186;2409.0484258717884;2410.301012706313;2414.7585241475886;2376.5484557934024;2383.9642405363934;2402.8798560072014;2412.0834083048503;2426.623873299641;2350.74141844397;2379.583572874749;2397.988010059956;2399.3881560202126;2400.099962514057;2326.906923723049;2336.3224664847257;2359.315798418465;2371.561261166681;2377.9643305350432;2354.3290162303833;2373.5964885969256;2374.8456350337174;2375.5248950209852;2404.4349577849366;8777;8866.601002954883;9021.503817290111;9026.45841249527;9032.729018129401;5297.761600727977;5463.508284254436;5481.561475081984;5484.478974497416;5492.588055895823;3511.438169892805;3571.089372210096;3600.063983364318;3617.5478065241846;3638.2177831766035;1012.3976234140748;1021.2697920986456;1027.7893031928436;1030.7165529479378;1032.7521394865253;10467.424291663956;11525.67454742707;11808.291502509877;12098.637040888787;12124;4764.251683916494;4775.5463230993;4856.1016212000895;4882.853514394503;4923.75381230937;10046.799064018678;10116.494175291205;10145;10145.137663298554;10151.746206344753;5124.282600435942;5330.92003619946;5339.813106541253;5363.892722145535;5439.075357189287;4278.679099067583;4767.404074490689;4907.411110666742;4923.655344125948;4943.036107958914;3974.6224108709625;4026.617471340218;4077.571854955246;4106.466159399259;4137.710360274812;1292.7220647560819;1317.6244770240435;1323.5103011885471;1324;1328.6744747536916;899.1727610598265;899.6086702284528;904.5070436612062;923.330585325647;943.2605472101392;5840.445157710011;5929.0513517836935;5959.7853366266245;6035.969820150871;6084.752625711719;416.75828019748474;430.24062529635216;434.4547592771052;437.25666367175927;453.3992459990526;3911.92176156481;3977.866308102177;3985.5416627087675;4008.018035581243;4045.130296986103;10644.042036216622;10833.512491937725;10867.510962006729;11010.889891100986;11057;10965.451727413598;10971.451427428598;10985.340879547093;10988.560457581607;10992.340459572451;8151.551664658501;8363.665453381918;8367.95816020916;8372.330213582898;8483.236508714246;5754.7122643866805;5841.094630332305;5907.586468947305;5943.286805583358;5979.4917432018765;10094.949525252327;10128.645497407555;10268.537915793659;10275.280730348804;10280.897191027994;10021.348612340174;10174.847377289494;10186.949065254626;10275.332103413255;10413.583456661649;6651.235107962646;7308.269173082649;7542.585157816373;7613.200613935457;7681.577513236825;8371.079181289932;8445.366597505335;8452.915470845213;8545.2309292164;8581.785455363417;7333.669984850588;7464.440166987389;7534.113206416675;7548.622568871425;7570.356519695667;7311.341979221896;7385.519941203805;7401.185869554452;7485.588292643957;7509.023826902468;7012.333828286304;7023.367896889305;7035.472339574655;7096.325849044332;7147.070880785673;4778.522147785194;4787.210110331756;4907.68100073494;4933.679310844784;5111.798727299156;4759.309900064402;4871.439784424837;4920.975395123145;4955.900881982412;5046.1926091825135 17:29:59 INFO - PROCESS | 2517 | |4;prototype.html;265.80861779518744;308.4986896293523;311.54047779525195;315.6370174299557;319.58294425774386;4757.643176761744;5732.914006289904;5754.367019627843;5771.394003629611;5805.941940580593;5570.86072848179;5571.637843540167;5636.027390413354;5642.463965923231;5676.205331253628;3616.6311066251646;3896.5129358830145;3998.9400158997564;4176.874693759177;4216.894577635553;3996.8001599920035;4134.607212314825;4182.351735481006;4186.392973018926;4203.7057405981595;3232.91917702057;3341.8496167672515;4123.092919557693;4228;4267.871963841089;3874.418837174418;4148.958510414887;4185.97907010463;4186.267403204442;4206.305959516676;3550.6449355064547;3604.297162053401;3606.4049431843714;3613.705297136311;3617.240379520304;5163.509466600667;5389.973050134724;5390.649607775482;5413.512783849433;5429.837104886859;3807.714421418377;4304.956950430518;4637.25803871379;4759.381280433556;4775.758302841252;4734.526547345273;5886.735096920606;5915.852103697399;5916;5934.673592952386;3357.529945807589;3927.528696556403;3959.544652364957;3962.663173630216;3971.821268042945;4349.434573505424;5989.8203053908455;6200.81397558074;6202.286737025254;6328.493720502394;3818.7326887117633;3946.7039972002217;3965.195835894661;3994;4011.9799401003393;3754.4180651998986;4064.227796718614;4064.451299074646;4079.8572049978106;4160.791960401968;3822.7132965027176;4063.7358571692744;4187.309093999456;4201.747895126241;4479.59683628475;5693.3168019837885;6009.308929473079;6013.4888534474185;6013.4888534474185;6015.368386319461;1366;1386.5978866128912;1396.7834985577251;1400.7408629403592;1401.1803095189225;653.8103949854584;763.8930549723043;800.5876973358725;834.6077343648476;892.2193081054078;4929.482404347492;5283.675182919503;5439.428859969726;5451.836444906659;5498.917516237259;5100.795968161232;5220.9819085278;5875.3267263395055;6067.423594758491;6112.969435152796;4830.589399900978;5101.770420331094;5370.597205209547;5374.516293533601;5477.233187353773;3193.984030079881;3196.5205219216837;3199.840007999591;3204.5419334202884;3226.306344136022;5420.855903575916;5917.763289468373;5982.73077711504;6321.333626496621;6342.651154186564;5371.650842695212;5816.883662326814;6012.488938440194;6244.687765611701;6281.811545653638;4967.801287948441;5959.731812068468;6363.395477429729;6370.74517019314;6400;5042.823501177588;5228.790848366023;5481.835544933659;5586.608937374507;6110.694465276807;4870.926936095891;6077.817665470043;6087.69561521931;6138.5396095292135;6145.404938111076;5241.764120614505;6110.938890611037;6344.113428390164;6409;6434.166262615132;3546.6985306249258;3953.2686453005135;4023.7928621414044;4062.943634654952;4068.389741538793;6195;6216.222972128484;6265.248170219421;6271.592346497463;6285.371462853678;5485.945140548543;5799.333076696234;6001.969990150022;6019.969900150471;6041.6375017499095;5497.560195184456;5585.871911729445;5669.618760120677;6026.246719160105;6052.606580572248;5253.03203689914;5570.2480165177185;5831.79588714393;5879.617824841372;5916.142159386951;5787.39232380594;5891.497668094608;5904.822855314347;5973.223480947449;5979.4618484336615;4492.483364413134;5600;5720.3707592165665;5766.365699773106;5785.045467497984 17:29:59 INFO - PROCESS | 2517 | |5;yui.html;643.9452646525045;680.3536640191816;684.7261095561774;702.6381413572008;704.0495331302741;13835.792463113035;14930.253487325632;15139;15145.469908553203;15498.147601881892;11768.882311176885;12276.5703200388;13897.513587024456;13948.860511394883;14290.428382864673;529.0213105754362;734.2547314475811;890.1187824054205;914.2320450821309;915.0026471146449;892.2326798952928;908.9454632722025;918.4535201555065;919.2691810011024;921.424109931293;957.6648173139415;970.8058388322329;973.4645944730405;975.7853272280087;978.7259567321162;941.6986564299461;957.2676902169845;966.4201479112546;966.9661561845337;968.1963969904962;685.2907241005536;708.518207618819;715.58138488984;716.2157437605813;716.2228981555019;13783.655408614864;13836.23900685462;14934.477293294682;15115.16866572338;15148.31832567526;12696.301703406309;12708.745825083446;12838.229706217564;12848.935755321258;12893.130496078016;9855.457949812757;9905.405675659484;9931.056549627774;10102.444365559892;10311.535980880879;3420.9144771380666;3458.2219000724635;3561.6794488495902;3690.022144131807;3699.5930447650735;85883.57058214668;86897;87822.5608871958;88005;88156.55921720415;9275.350725449154;9427.057294270518;9457.007014263541;9550.331476796697;9741.951290243504;21245.043973021253;21601.567968640855;21917.123315067536;21937.561248775255;22040.44898877541;7391.334779869838;7446.441516886255;7533.1336896256535;7562.773116806505;7634.503757255871;4007.29872272357;4067.1255680028935;4067.9796601016806;4077.7757223353;4083.4283200351974;3409.931801363959;3427.6572342765526;3430.9656903431146;3473.7047350974944;3525.858965641397;602.4939051197016;621.3196549777986;626.4174317884411;630.4168644004278;632.3929028132952;516.9015841337158;570.6718636783866;599.6462087368474;604.3442864491988;616.315889362807;7890.802729931683;8118.02583689961;8257.463264887763;8296.875546866802;8339.082700902896;501.63130099377656;554.5508138407903;592.3158751641861;595.1727099331932;601.8645804693908;3831.6934645228316;3868.400397938324;3915.784631845219;3923.2153569286256;3925.3130702127014;73015.26984730191;92304.15391692129;97175;97962.02037979671;98528.02943941225;82032.17967820365;86462.70305945416;86653.56673216594;87552.1244787544;87948;74988;75252;75447.62276188693;75872.10319742051;76613.6169319161;7565.508241964255;7624.961875190588;7700.922990770021;7833.09919359281;7940.682372705258;32445.837770810995;44072.779636101615;44637.55362446334;45332.32001520046;46250.768746156056;64782.35217647763;67099.3290067093;67322.99015514673;67443.3255667437;67547;9216.723498295061;9258.027907069662;9729.85405218908;9984;10256.53845576936;10930.726731831768;11033.889661103287;11097.223194376638;11124.110071194447;11211.71970700739;10150.49247537635;10464.267501274837;10495.842562361418;10557.419341936267;10902.836457452986;10326.380417174994;10491.475426228812;10520.263581549525;10714.464276786286;11499;9844.360116592685;10785.514651840529;11087.889121109009;11095;11131.10951123892;9376.812463750823;9512.239020878174;9519.278422043864;9569.33014688993;9668.516574171404;9210.480721155871;9629.711108666752;9657.985911479474;9685.854712179182;9851.310408271353 17:29:59 INFO - PROCESS | 2517 | __end_tp_report 17:29:59 INFO - PROCESS | 2517 | __start_cc_report 17:29:59 INFO - PROCESS | 2517 | _x_x_mozilla_cycle_collect,419 17:29:59 INFO - PROCESS | 2517 | __end_cc_report 17:29:59 INFO - PROCESS | 2517 | __startTimestamp1464049799793__endTimestamp 17:29:59 INFO - PROCESS | 2517 | 17:29:59 INFO - PROCESS | 2517 | ------- Summary: start ------- 17:29:59 INFO - PROCESS | 2517 | Number of tests: 6 17:29:59 INFO - PROCESS | 2517 | 17:29:59 INFO - PROCESS | 2517 | [#0] dojo.html Cycles:165 Average:5821.86 Median:6108.08 stddev:782.82 (12.8%) stddev-sans-first:758.25 17:29:59 INFO - PROCESS | 2517 | Values: 3224.9 3530.0 3535.4 3560.8 3576.6 5855.6 5866.1 5969.3 6007.9 6017.1 5737.6 5849.4 5864.9 5940.4 5992.6 5258.9 5310.0 5420.6 5460.3 5466.7 220.5 5442.7 5445.1 5456.2 5506.1 5339.5 5383.3 5390.6 5408.8 5434.7 5299.5 5429.8 5457.5 5482.8 5485.0 5274.0 5292.6 5321.9 5334.3 5373.6 4984.2 5223.3 5792.1 5831.9 5882.4 5280.8 6167.6 6192.5 6224.5 6291.2 5213.2 6108.1 6341.1 6358.2 6360.4 6086.6 6110.5 6118.7 6122.6 6131.7 6246.3 6288.8 6335.9 6468.0 6490.7 6268.8 6298.7 6306.0 6319.7 6352.1 6316.6 6324.8 6336.3 6355.9 6361.3 6189.6 6223.4 6281.8 6285.3 6318.1 6197.7 6209.5 6214.5 6219.3 6255.2 5111.1 5124.5 5130.8 5132.0 5146.2 4499.1 4499.6 4509.1 4576.6 4604.2 4635.4 5842.6 5943.6 6070.7 6105.7 6378.9 6379.1 6379.8 6392.5 6398.3 5861.5 5999.8 6041.2 6076.5 6101.2 5521.9 5606.9 5607.0 5610.7 5616.2 5570.8 6305.5 6565.3 6579.2 6622.3 6241.4 6248.2 6368.8 6368.9 6372.9 5475.8 6566.5 6613.8 6627.6 6651.1 6196.6 6220.6 6287.2 6334.3 6336.7 6222.0 6364.6 6377.4 6384.0 6386.4 6157.2 6157.7 6271.3 6298.3 6305.7 4633.7 6136.6 6178.7 6256.0 6283.0 5777.3 6010.8 6052.3 6146.5 6148.0 6219.6 6248.3 6315.2 6321.3 6335.4 6040.4 6049.5 6092.5 6226.5 6245.0 17:29:59 INFO - PROCESS | 2517 | 17:29:59 INFO - PROCESS | 2517 | [#1] ext.html Cycles:180 Average:72305.33 Median:39899.90 stddev:159746.98 (400.4%) stddev-sans-first:160103.99 17:29:59 INFO - PROCESS | 2517 | Values: 442.1 526.6 527.6 554.1 555.3 39535.0 42681.0 42687.4 42718.0 42749.4 42769.6 43337.3 44058.0 44157.3 44306.1 9605.8 9718.2 9734.7 9866.8 9890.9 9782.0 9794.4 9883.1 9889.2 9923.7 9863.3 9895.0 9921.3 9934.0 9953.5 9056.7 9335.3 9779.9 9827.7 9890.0 9676.9 9745.2 9805.4 9807.0 9811.8 40869.6 40959.6 41231.6 41465.0 41475.8 2514.4 3109.3 3194.2 3213.4 3381.7 28976.1 29413.6 30052.5 30067.5 30113.1 2556.2 2678.5 2709.1 2728.6 2959.1 474892.6 488577.0 509516.0 558396.0 562147.0 66851.0 66934.7 67481.3 67851.7 67968.0 31775.7 35861.6 36032.5 36677.4 69441.3 16773.2 16813.7 16934.9 16961.2 16969.9 12878.7 12975.5 12980.4 12988.5 13042.3 20540.5 20687.4 20702.3 20797.6 20817.3 8292.0 8302.8 8357.8 8373.6 8665.0 884.1 1009.6 1058.4 1066.9 1076.3 29811.0 30144.0 30222.8 30452.8 30642.7 861.4 1089.5 1101.2 1142.9 1144.8 15302.2 15428.8 15634.9 15654.5 15718.0 596094.0 684763.0 692437.0 696980.0 697580.0 60787.1 61344.0 63147.4 63614.4 63796.0 1449.1 1461.6 1468.8 1472.4 1473.8 25879.2 29678.8 29906.9 30021.2 30116.3 52607.7 53761.7 53826.9 54471.2 54775.7 579309.0 585407.0 587485.0 589276.1 590847.0 26343.2 26347.9 26389.2 27187.3 27592.8 46355.0 47460.0 47729.3 48027.0 48177.8 34195.1 38908.8 39597.4 40080.8 40617.8 36216.0 38477.8 38594.8 38737.0 39536.6 38520.6 39091.0 39142.6 39558.6 39719.0 30045.4 34317.0 34367.8 34777.7 35687.5 23359.6 24195.9 25020.7 25306.5 25669.5 17:29:59 INFO - PROCESS | 2517 | 17:29:59 INFO - PROCESS | 2517 | [#2] jquery.html Cycles:180 Average:35382.26 Median:2149.58 stddev:103202.23 (4801.0%) stddev-sans-first:103458.26 17:29:59 INFO - PROCESS | 2517 | Values: 372.8 374.7 377.1 390.4 398.0 19597.0 20898.9 21012.3 21577.1 21754.1 18780.0 20879.0 21216.4 21666.8 22049.3 4172.7 5302.3 5370.9 5835.4 6118.4 5609.9 6742.3 6763.3 6825.0 6829.0 6419.4 6661.5 6731.5 6757.8 6762.2 6406.8 6693.8 6745.3 6760.9 6765.8 5741.2 5839.2 5862.8 5873.6 5877.7 22848.8 22871.7 23184.9 24327.8 26524.9 689.4 2086.8 2175.7 2227.9 2359.0 8966.7 9843.7 9915.8 10954.0 15400.5 1741.4 1777.4 1805.6 1841.8 1851.4 61587.1 101588.0 106613.5 112985.0 124750.4 9830.0 10330.9 10815.6 11357.7 11863.5 14771.9 14815.3 14861.0 14861.9 14867.2 7589.5 8221.3 8468.3 8621.7 8691.8 8374.4 8534.7 8636.1 8638.2 8661.4 3970.1 4508.8 4626.8 4665.4 8055.6 3641.0 3721.4 3874.2 3892.3 3901.2 815.2 830.5 857.9 972.4 996.9 16176.9 20470.7 20904.9 21305.9 21360.6 904.7 937.1 951.7 952.3 1004.3 9250.5 10602.6 11080.4 11108.8 11146.3 587942.0 616698.0 618967.0 625315.0 649140.0 104237.5 137442.0 137849.9 139925.9 141438.3 996.5 1017.7 1040.8 1043.6 1051.1 19302.0 19410.9 19468.6 19706.8 19711.3 50987.5 51445.0 56302.0 57494.0 57746.0 77529.8 79535.6 83043.6 85012.7 85202.0 6102.0 6414.2 7030.5 7417.1 7589.6 9700.8 10727.9 12454.2 12526.1 12817.6 8674.7 10532.7 10583.1 10683.4 10813.9 7680.9 10372.9 10428.2 10597.8 10711.5 5630.7 8097.9 10604.7 10849.8 10920.0 8076.7 8087.4 8252.9 8279.6 8331.8 9840.4 10782.7 11030.0 11043.5 11085.3 17:29:59 INFO - PROCESS | 2517 | 17:29:59 INFO - PROCESS | 2517 | [#3] mootools.html Cycles:180 Average:5766.84 Median:2606.35 stddev:3266.45 (125.3%) stddev-sans-first:3258.50 17:29:59 INFO - PROCESS | 2517 | Values: 1317.4 1408.6 1707.6 1925.1 1929.3 7816.6 8598.2 8606.1 9103.3 9116.0 8700.7 8838.2 8977.3 8977.6 8994.8 2376.3 2406.7 2409.0 2410.3 2414.8 2376.5 2384.0 2402.9 2412.1 2426.6 2350.7 2379.6 2398.0 2399.4 2400.1 2326.9 2336.3 2359.3 2371.6 2378.0 2354.3 2373.6 2374.8 2375.5 2404.4 8777.0 8866.6 9021.5 9026.5 9032.7 5297.8 5463.5 5481.6 5484.5 5492.6 3511.4 3571.1 3600.1 3617.5 3638.2 1012.4 1021.3 1027.8 1030.7 1032.8 10467.4 11525.7 11808.3 12098.6 12124.0 4764.3 4775.5 4856.1 4882.9 4923.8 10046.8 10116.5 10145.0 10145.1 10151.7 5124.3 5330.9 5339.8 5363.9 5439.1 4278.7 4767.4 4907.4 4923.7 4943.0 3974.6 4026.6 4077.6 4106.5 4137.7 1292.7 1317.6 1323.5 1324.0 1328.7 899.2 899.6 904.5 923.3 943.3 5840.4 5929.1 5959.8 6036.0 6084.8 416.8 430.2 434.5 437.3 453.4 3911.9 3977.9 3985.5 4008.0 4045.1 10644.0 10833.5 10867.5 11010.9 11057.0 10965.5 10971.5 10985.3 10988.6 10992.3 8151.6 8363.7 8368.0 8372.3 8483.2 5754.7 5841.1 5907.6 5943.3 5979.5 10094.9 10128.6 10268.5 10275.3 10280.9 10021.3 10174.8 10186.9 10275.3 10413.6 6651.2 7308.3 7542.6 7613.2 7681.6 8371.1 8445.4 8452.9 8545.2 8581.8 7333.7 7464.4 7534.1 7548.6 7570.4 7311.3 7385.5 7401.2 7485.6 7509.0 7012.3 7023.4 7035.5 7096.3 7147.1 4778.5 4787.2 4907.7 4933.7 5111.8 4759.3 4871.4 4921.0 4955.9 5046.2 17:29:59 INFO - PROCESS | 2517 | 17:29:59 INFO - PROCESS | 2517 | [#4] prototype.html Cycles:180 Average:4730.38 Median:5390.31 stddev:1506.13 (27.9%) stddev-sans-first:1472.61 17:29:59 INFO - PROCESS | 2517 | Values: 265.8 308.5 311.5 315.6 319.6 4757.6 5732.9 5754.4 5771.4 5805.9 5570.9 5571.6 5636.0 5642.5 5676.2 3616.6 3896.5 3998.9 4176.9 4216.9 3996.8 4134.6 4182.4 4186.4 4203.7 3232.9 3341.8 4123.1 4228.0 4267.9 3874.4 4149.0 4186.0 4186.3 4206.3 3550.6 3604.3 3606.4 3613.7 3617.2 5163.5 5390.0 5390.6 5413.5 5429.8 3807.7 4305.0 4637.3 4759.4 4775.8 4734.5 5886.7 5915.9 5916.0 5934.7 3357.5 3927.5 3959.5 3962.7 3971.8 4349.4 5989.8 6200.8 6202.3 6328.5 3818.7 3946.7 3965.2 3994.0 4012.0 3754.4 4064.2 4064.5 4079.9 4160.8 3822.7 4063.7 4187.3 4201.7 4479.6 5693.3 6009.3 6013.5 6013.5 6015.4 1366.0 1386.6 1396.8 1400.7 1401.2 653.8 763.9 800.6 834.6 892.2 4929.5 5283.7 5439.4 5451.8 5498.9 5100.8 5221.0 5875.3 6067.4 6113.0 4830.6 5101.8 5370.6 5374.5 5477.2 3194.0 3196.5 3199.8 3204.5 3226.3 5420.9 5917.8 5982.7 6321.3 6342.7 5371.7 5816.9 6012.5 6244.7 6281.8 4967.8 5959.7 6363.4 6370.7 6400.0 5042.8 5228.8 5481.8 5586.6 6110.7 4870.9 6077.8 6087.7 6138.5 6145.4 5241.8 6110.9 6344.1 6409.0 6434.2 3546.7 3953.3 4023.8 4062.9 4068.4 6195.0 6216.2 6265.2 6271.6 6285.4 5485.9 5799.3 6002.0 6020.0 6041.6 5497.6 5585.9 5669.6 6026.2 6052.6 5253.0 5570.2 5831.8 5879.6 5916.1 5787.4 5891.5 5904.8 5973.2 5979.5 4492.5 5600.0 5720.4 5766.4 5785.0 17:29:59 INFO - PROCESS | 2517 | 17:29:59 INFO - PROCESS | 2517 | [#5] yui.html Cycles:180 Average:18449.75 Median:67211.16 stddev:26830.31 (39.9%) stddev-sans-first:26872.27 17:29:59 INFO - PROCESS | 2517 | Values: 643.9 680.4 684.7 702.6 704.0 13835.8 14930.3 15139.0 15145.5 15498.1 11768.9 12276.6 13897.5 13948.9 14290.4 529.0 734.3 890.1 914.2 915.0 892.2 908.9 918.5 919.3 921.4 957.7 970.8 973.5 975.8 978.7 941.7 957.3 966.4 967.0 968.2 685.3 708.5 715.6 716.2 716.2 13783.7 13836.2 14934.5 15115.2 15148.3 12696.3 12708.7 12838.2 12848.9 12893.1 9855.5 9905.4 9931.1 10102.4 10311.5 3420.9 3458.2 3561.7 3690.0 3699.6 85883.6 86897.0 87822.6 88005.0 88156.6 9275.4 9427.1 9457.0 9550.3 9742.0 21245.0 21601.6 21917.1 21937.6 22040.4 7391.3 7446.4 7533.1 7562.8 7634.5 4007.3 4067.1 4068.0 4077.8 4083.4 3409.9 3427.7 3431.0 3473.7 3525.9 602.5 621.3 626.4 630.4 632.4 516.9 570.7 599.6 604.3 616.3 7890.8 8118.0 8257.5 8296.9 8339.1 501.6 554.6 592.3 595.2 601.9 3831.7 3868.4 3915.8 3923.2 3925.3 73015.3 92304.2 97175.0 97962.0 98528.0 82032.2 86462.7 86653.6 87552.1 87948.0 74988.0 75252.0 75447.6 75872.1 76613.6 7565.5 7625.0 7700.9 7833.1 7940.7 32445.8 44072.8 44637.6 45332.3 46250.8 64782.4 67099.3 67323.0 67443.3 67547.0 9216.7 9258.0 9729.9 9984.0 10256.5 10930.7 11033.9 11097.2 11124.1 11211.7 10150.5 10464.3 10495.8 10557.4 10902.8 10326.4 10491.5 10520.3 10714.5 11499.0 9844.4 10785.5 11087.9 11095.0 11131.1 9376.8 9512.2 9519.3 9569.3 9668.5 9210.5 9629.7 9658.0 9685.9 9851.3 17:29:59 INFO - PROCESS | 2517 | -------- Summary: end -------- 17:29:59 INFO - PROCESS | 2517 | 17:30:00 INFO - TEST-INFO | 2517: exit 0 17:30:00 INFO - TEST-OK | dromaeo_css | took 1112111ms 17:30:00 INFO - TEST-START | kraken 17:30:00 INFO - operating with platform_type : mac_ 17:30:00 INFO - Initialising browser for kraken test... 17:30:00 INFO - TEST-INFO | started process 2523 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/tmpB8rZQE/profile http://localhost:61078/getInfo.html) 17:30:03 INFO - PROCESS | 2523 | __metrics Screen width/height:1600/1200 17:30:03 INFO - PROCESS | 2523 | colorDepth:24 17:30:03 INFO - PROCESS | 2523 | Browser inner width/height: 1024/689 17:30:03 INFO - PROCESS | 2523 | __metrics 17:30:03 ERROR - PROCESS | 2523 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 17:30:04 INFO - TEST-INFO | 2523: exit 0 17:30:04 INFO - Browser initialized. 17:30:04 INFO - Running cycle 1/1 for kraken test... 17:30:04 INFO - TEST-INFO | started process 2526 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/05/kvspgyq10sb_rylg685dcdw800000w/T/tmpB8rZQE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:30:16 INFO - PROCESS | 2526 | RSS: Main: 249692160 17:30:16 INFO - PROCESS | 2526 | 17:30:19 INFO - PROCESS | 2526 | Cycle 1(1): loaded http://localhost:61078/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:61078/tests/kraken/driver.html?testName=audio-beat-detection) 17:30:20 INFO - PROCESS | 2526 | RSS: Main: 261455872 17:30:20 INFO - PROCESS | 2526 | 17:30:22 INFO - PROCESS | 2526 | Cycle 1(1): loaded http://localhost:61078/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:61078/tests/kraken/driver.html?testName=audio-dft) 17:30:23 INFO - PROCESS | 2526 | RSS: Main: 266186752 17:30:23 INFO - PROCESS | 2526 | 17:30:27 INFO - PROCESS | 2526 | Cycle 1(1): loaded http://localhost:61078/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:61078/tests/kraken/driver.html?testName=audio-fft) 17:30:27 INFO - PROCESS | 2526 | RSS: Main: 267005952 17:30:27 INFO - PROCESS | 2526 | 17:30:30 INFO - PROCESS | 2526 | Cycle 1(1): loaded http://localhost:61078/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:61078/tests/kraken/driver.html?testName=audio-oscillator) 17:30:30 INFO - PROCESS | 2526 | RSS: Main: 267382784 17:30:30 INFO - PROCESS | 2526 | 17:30:33 INFO - PROCESS | 2526 | Cycle 1(1): loaded http://localhost:61078/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:61078/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:30:33 INFO - PROCESS | 2526 | RSS: Main: 267874304 17:30:33 INFO - PROCESS | 2526 | 17:30:36 INFO - PROCESS | 2526 | Cycle 1(1): loaded http://localhost:61078/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:61078/tests/kraken/driver.html?testName=imaging-darkroom) 17:30:37 INFO - PROCESS | 2526 | RSS: Main: 268431360 17:30:37 INFO - PROCESS | 2526 | 17:30:40 INFO - PROCESS | 2526 | Cycle 1(1): loaded http://localhost:61078/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:61078/tests/kraken/driver.html?testName=imaging-desaturate) 17:30:41 INFO - PROCESS | 2526 | RSS: Main: 269631488 17:30:41 INFO - PROCESS | 2526 | 17:30:44 INFO - PROCESS | 2526 | Cycle 1(1): loaded http://localhost:61078/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:61078/tests/kraken/driver.html?testName=json-parse-financial) 17:30:44 INFO - PROCESS | 2526 | RSS: Main: 269373440 17:30:44 INFO - PROCESS | 2526 | 17:30:46 INFO - PROCESS | 2526 | Cycle 1(1): loaded http://localhost:61078/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:61078/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:30:47 INFO - PROCESS | 2526 | RSS: Main: 268345344 17:30:47 INFO - PROCESS | 2526 | 17:30:49 INFO - PROCESS | 2526 | Cycle 1(1): loaded http://localhost:61078/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:61078/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:30:49 INFO - PROCESS | 2526 | RSS: Main: 268410880 17:30:49 INFO - PROCESS | 2526 | 17:30:52 INFO - PROCESS | 2526 | Cycle 1(1): loaded http://localhost:61078/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:61078/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:30:52 INFO - PROCESS | 2526 | RSS: Main: 268210176 17:30:52 INFO - PROCESS | 2526 | 17:30:55 INFO - PROCESS | 2526 | Cycle 1(1): loaded http://localhost:61078/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:61078/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:30:56 INFO - PROCESS | 2526 | RSS: Main: 268382208 17:30:56 INFO - PROCESS | 2526 | 17:30:59 INFO - PROCESS | 2526 | Cycle 1(1): loaded http://localhost:61078/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:61078/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:31:00 INFO - PROCESS | 2526 | RSS: Main: 268337152 17:31:00 INFO - PROCESS | 2526 | 17:31:02 INFO - PROCESS | 2526 | Cycle 1(1): loaded http://localhost:61078/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:61078/tests/kraken/driver.html?testName=ai-astar) 17:31:02 INFO - PROCESS | 2526 | RSS: Main: 271048704 17:31:02 INFO - PROCESS | 2526 | 17:31:02 INFO - PROCESS | 2526 | __start_tp_report 17:31:02 INFO - PROCESS | 2526 | _x_x_mozilla_page_load 17:31:02 INFO - PROCESS | 2526 | _x_x_mozilla_page_load_details 17:31:02 INFO - PROCESS | 2526 | |i|pagename|runs| 17:31:02 INFO - PROCESS | 2526 | |0;ai-astar;115;113;117;97;173;174;128;115;116;118 17:31:02 INFO - PROCESS | 2526 | |1;audio-beat-detection;165;142;178;203;123;152;171;150;199;126 17:31:02 INFO - PROCESS | 2526 | |2;audio-dft;206;251;230;236;200;205;238;199;193;195 17:31:02 INFO - PROCESS | 2526 | |3;audio-fft;64;111;76;183;59;59;71;99;166;86 17:31:02 INFO - PROCESS | 2526 | |4;audio-oscillator;81;100;180;117;119;93;124;79;83;130 17:31:02 INFO - PROCESS | 2526 | |5;imaging-gaussian-blur;89;86;90;125;95;90;91;87;90;88 17:31:02 INFO - PROCESS | 2526 | |6;imaging-darkroom;98;96;97;97;96;117;151;96;104;98 17:31:02 INFO - PROCESS | 2526 | |7;imaging-desaturate;105;147;93;98;93;97;153;98;96;96 17:31:02 INFO - PROCESS | 2526 | |8;json-parse-financial;58;59;60;65;80;94;90;122;62;60 17:31:02 INFO - PROCESS | 2526 | |9;json-stringify-tinderbox;70;69;72;74;73;75;73;72;74;73 17:31:02 INFO - PROCESS | 2526 | |10;stanford-crypto-aes;87;87;88;88;87;85;91;88;90;90 17:31:02 INFO - PROCESS | 2526 | |11;stanford-crypto-ccm;154;152;135;139;152;139;134;142;254;150 17:31:02 INFO - PROCESS | 2526 | |12;stanford-crypto-pbkdf2;173;167;199;240;183;190;232;230;175;174 17:31:02 INFO - PROCESS | 2526 | |13;stanford-crypto-sha256-iterative;68;69;66;67;70;67;65;65;65;68 17:31:02 INFO - PROCESS | 2526 | __end_tp_report 17:31:02 INFO - PROCESS | 2526 | __start_cc_report 17:31:02 INFO - PROCESS | 2526 | _x_x_mozilla_cycle_collect,1110 17:31:02 INFO - PROCESS | 2526 | __end_cc_report 17:31:02 INFO - PROCESS | 2526 | __startTimestamp1464049862459__endTimestamp 17:31:02 INFO - PROCESS | 2526 | 17:31:02 INFO - PROCESS | 2526 | ------- Summary: start ------- 17:31:02 INFO - PROCESS | 2526 | Number of tests: 14 17:31:02 INFO - PROCESS | 2526 | 17:31:02 INFO - PROCESS | 2526 | [#0] ai-astar Cycles:10 Average:126.60 Median:123.00 stddev:25.84 (21.0%) stddev-sans-first:27.07 17:31:02 INFO - PROCESS | 2526 | Values: 115.0 113.0 117.0 97.0 173.0 174.0 128.0 115.0 116.0 118.0 17:31:02 INFO - PROCESS | 2526 | 17:31:02 INFO - PROCESS | 2526 | [#1] audio-beat-detection Cycles:10 Average:160.90 Median:168.00 stddev:27.58 (16.4%) stddev-sans-first:29.21 17:31:02 INFO - PROCESS | 2526 | Values: 165.0 142.0 178.0 203.0 123.0 152.0 171.0 150.0 199.0 126.0 17:31:02 INFO - PROCESS | 2526 | 17:31:02 INFO - PROCESS | 2526 | [#2] audio-dft Cycles:10 Average:215.30 Median:218.00 stddev:21.18 (9.7%) stddev-sans-first:22.19 17:31:02 INFO - PROCESS | 2526 | Values: 206.0 251.0 230.0 236.0 200.0 205.0 238.0 199.0 193.0 195.0 17:31:02 INFO - PROCESS | 2526 | 17:31:02 INFO - PROCESS | 2526 | [#3] audio-fft Cycles:10 Average:97.40 Median:67.50 stddev:44.18 (65.5%) stddev-sans-first:45.18 17:31:02 INFO - PROCESS | 2526 | Values: 64.0 111.0 76.0 183.0 59.0 59.0 71.0 99.0 166.0 86.0 17:31:02 INFO - PROCESS | 2526 | 17:31:02 INFO - PROCESS | 2526 | [#4] audio-oscillator Cycles:10 Average:110.60 Median:129.50 stddev:30.81 (23.8%) stddev-sans-first:30.76 17:31:02 INFO - PROCESS | 2526 | Values: 81.0 100.0 180.0 117.0 119.0 93.0 124.0 79.0 83.0 130.0 17:31:02 INFO - PROCESS | 2526 | 17:31:02 INFO - PROCESS | 2526 | [#5] imaging-gaussian-blur Cycles:10 Average:93.10 Median:90.00 stddev:11.47 (12.7%) stddev-sans-first:12.07 17:31:02 INFO - PROCESS | 2526 | Values: 89.0 86.0 90.0 125.0 95.0 90.0 91.0 87.0 90.0 88.0 17:31:02 INFO - PROCESS | 2526 | 17:31:02 INFO - PROCESS | 2526 | [#6] imaging-darkroom Cycles:10 Average:105.00 Median:96.50 stddev:17.42 (18.0%) stddev-sans-first:18.29 17:31:02 INFO - PROCESS | 2526 | Values: 98.0 96.0 97.0 97.0 96.0 117.0 151.0 96.0 104.0 98.0 17:31:02 INFO - PROCESS | 2526 | 17:31:02 INFO - PROCESS | 2526 | [#7] imaging-desaturate Cycles:10 Average:107.60 Median:96.00 stddev:22.64 (23.6%) stddev-sans-first:23.99 17:31:02 INFO - PROCESS | 2526 | Values: 105.0 147.0 93.0 98.0 93.0 97.0 153.0 98.0 96.0 96.0 17:31:02 INFO - PROCESS | 2526 | 17:31:02 INFO - PROCESS | 2526 | [#8] json-parse-financial Cycles:10 Average:75.00 Median:63.50 stddev:21.30 (33.5%) stddev-sans-first:21.69 17:31:02 INFO - PROCESS | 2526 | Values: 58.0 59.0 60.0 65.0 80.0 94.0 90.0 122.0 62.0 60.0 17:31:02 INFO - PROCESS | 2526 | 17:31:02 INFO - PROCESS | 2526 | [#9] json-stringify-tinderbox Cycles:10 Average:72.50 Median:73.00 stddev:1.84 (2.5%) stddev-sans-first:1.72 17:31:02 INFO - PROCESS | 2526 | Values: 70.0 69.0 72.0 74.0 73.0 75.0 73.0 72.0 74.0 73.0 17:31:02 INFO - PROCESS | 2526 | 17:31:02 INFO - PROCESS | 2526 | [#10] stanford-crypto-aes Cycles:10 Average:88.10 Median:88.00 stddev:1.79 (2.0%) stddev-sans-first:1.86 17:31:02 INFO - PROCESS | 2526 | Values: 87.0 87.0 88.0 88.0 87.0 85.0 91.0 88.0 90.0 90.0 17:31:02 INFO - PROCESS | 2526 | 17:31:02 INFO - PROCESS | 2526 | [#11] stanford-crypto-ccm Cycles:10 Average:155.10 Median:151.00 stddev:35.54 (23.5%) stddev-sans-first:37.69 17:31:02 INFO - PROCESS | 2526 | Values: 154.0 152.0 135.0 139.0 152.0 139.0 134.0 142.0 254.0 150.0 17:31:02 INFO - PROCESS | 2526 | 17:31:02 INFO - PROCESS | 2526 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.30 Median:194.50 stddev:27.68 (14.2%) stddev-sans-first:28.05 17:31:02 INFO - PROCESS | 2526 | Values: 173.0 167.0 199.0 240.0 183.0 190.0 232.0 230.0 175.0 174.0 17:31:02 INFO - PROCESS | 2526 | 17:31:02 INFO - PROCESS | 2526 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.50 stddev:1.76 (2.6%) stddev-sans-first:1.83 17:31:02 INFO - PROCESS | 2526 | Values: 68.0 69.0 66.0 67.0 70.0 67.0 65.0 65.0 65.0 68.0 17:31:02 INFO - PROCESS | 2526 | -------- Summary: end -------- 17:31:02 INFO - PROCESS | 2526 | 17:31:03 INFO - TEST-INFO | 2526: exit 0 17:31:03 INFO - TEST-OK | kraken | took 62852ms 17:31:03 INFO - SUITE-END | took 1174s 17:31:03 INFO - Completed test suite (00:19:35) 17:31:03 INFO - javascript benchmark 17:31:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7263.828429802047, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3224.903252902413, 3530.029241958461, 3535.39898217303, 3560.786352818831, 3576.642335766422, 5855.648661080333, 5866.090755932826, 5969.343372229062, 6007.909881351778, 6017.097435384694, 5737.598368114233, 5849.415058494148, 5864.882702345951, 5940.405959404057, 5992.640441573509, 5258.894822103565, 5310.0, 5420.620556561043, 5460.26286451328, 5466.726663666821, 220.53730049149658, 5442.727863606824, 5445.101558242905, 5456.236126942231, 5506.146547285177, 5339.492748188916, 5383.327084114466, 5390.649607775502, 5408.756605952722, 5434.728263586805, 5299.470052994709, 5429.755660995225, 5457.481539253765, 5482.780688772445, 5485.0, 5273.973630131824, 5292.629515933886, 5321.920171197435, 5334.333208348957, 5373.623846330758, 4984.2025275955675, 5223.347081614798, 5792.102224155263, 5831.88336233273, 5882.411758824126, 5280.81517146898, 6167.568270221086, 6192.535559833031, 6224.470919971808, 6291.245050593958, 5213.191955246905, 6108.08378743192, 6341.143945567335, 6358.1734374531015, 6360.427561519486, 6086.573939824214, 6110.511159107261, 6118.694065296718, 6122.571420000601, 6131.662758548278, 6246.250449945945, 6288.8427789304715, 6335.904961425582, 6468.029795530708, 6490.675466226764, 6268.811935641938, 6298.685065746694, 6306.0, 6319.715612797343, 6352.110704501373, 6316.589421687576, 6324.810255692337, 6336.271328797156, 6355.904661430082, 6361.332060133712, 6189.597676151036, 6223.439890409794, 6281.780137695158, 6285.340039295808, 6318.147050148263, 6197.690115494207, 6209.534284928648, 6214.533909956771, 6219.315875253718, 6255.186825712719, 5111.105556527593, 5124.538791508708, 5130.820421285237, 5131.999260144311, 5146.150885103991, 4499.1451624191295, 4499.6400287976885, 4509.098180363941, 4576.610988065985, 4604.194266003436, 4635.351050852883, 5842.649441033552, 5943.58394912352, 6070.696465176724, 6105.725242364104, 6378.872422551616, 6379.075034120026, 6379.840503987438, 6392.456641185551, 6398.29618741938, 5861.501772349398, 5999.760009599567, 6041.214642096587, 6076.453119219292, 6101.206843110456, 5521.861953451196, 5606.859828504238, 5607.0, 5610.719464026783, 5616.213730077792, 5570.777168913279, 6305.464035557029, 6565.343465653492, 6579.24338701046, 6622.2715501294815, 6241.407066328691, 6248.156498872776, 6368.840778980562, 6368.872622547616, 6372.936270637234, 5475.780968761205, 6566.474682025522, 6613.834654133685, 6627.569208001464, 6651.06885036105, 6196.597221180609, 6220.564560480904, 6287.182666253358, 6334.303226644974, 6336.746530138743, 6221.968890155701, 6364.64994425311, 6377.394147555975, 6384.042393640805, 6386.393292637192, 6157.199564056823, 6157.72290246931, 6271.310155882758, 6298.338674439118, 6305.716242768995, 4633.675642705113, 6136.610985192662, 6178.66017369049, 6255.96872015637, 6283.0, 5777.277840269966, 6010.819675409744, 6052.273727152594, 6146.5248340398875, 6148.016317389196, 6219.626822390671, 6248.312685604671, 6315.210598675166, 6321.336259692666, 6335.429811317003, 6040.395960403925, 6049.51603871698, 6092.543059270483, 6226.533010024357, 6245.0], "value": 5778.436328040482, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [442.11576846307383, 526.6129394894751, 527.5700304252034, 554.0829926471689, 555.2615022020713, 39535.0116247094, 42681.0, 42687.359689604644, 42718.0, 42749.35875961863, 42769.572304276946, 43337.34993975085, 44058.0, 44157.337639935344, 44306.113877722426, 9605.807883842337, 9718.222542196607, 9734.707958761213, 9866.802663946717, 9890.851637225447, 9782.021797820233, 9794.41233525987, 9883.110520053193, 9889.159421449149, 9923.652672156475, 9863.30956833022, 9895.0, 9921.305508614363, 9934.0, 9953.502324883762, 9056.683016094405, 9335.3465257432, 9779.853302200401, 9827.70516884491, 9889.961554036794, 9676.854847177297, 9745.220382369393, 9805.411675299505, 9807.0, 9811.803763924752, 40869.591304086876, 40959.59040409588, 41231.58768412338, 41465.0, 41475.792621037006, 2514.4342522932375, 3109.253779093024, 3194.185482701919, 3213.4055199788113, 3381.678740519647, 28976.13071607855, 29413.55879661807, 30052.54921176184, 30067.548986765218, 30113.096607101605, 2556.233130060993, 2678.450917561895, 2709.105995021638, 2728.5770705540476, 2959.0531030070388, 474892.6255368736, 488577.0, 509516.0, 558396.0, 562147.0, 66851.0, 66934.66532667306, 67481.32518674848, 67851.66074169597, 67968.0, 31775.682243177736, 35861.64138358583, 36032.45951310732, 36677.44983825245, 69441.3055869445, 16773.24520396585, 16813.663726725397, 16934.899231550156, 16961.15194240283, 16969.915150424167, 12878.67803304925, 12975.480980760853, 12980.35098245084, 12988.480460781462, 13042.347882605833, 20540.486487837923, 20687.379378618665, 20702.275420360515, 20797.58404831925, 20817.271395501386, 8291.95854020726, 8302.8339433211, 8357.821737720435, 8373.581320933929, 8665.0, 884.0938038510578, 1009.5608410341379, 1058.4496062047692, 1066.861308029951, 1076.3004047369272, 29811.0, 30144.026235671306, 30222.84888575543, 30452.84773576118, 30642.69357306443, 861.3798065392907, 1089.4988305379457, 1101.2126329674322, 1142.8914253145938, 1144.8454458648143, 15302.158381288913, 15428.84571154274, 15634.921825391028, 15654.530364089096, 15718.030703235196, 596094.0, 684763.0, 692437.0, 696980.0, 697580.0, 60787.08819367713, 61344.0, 63147.36852631507, 63614.36385636085, 63796.043059354146, 1449.0508716790519, 1461.5907545886955, 1468.801711768919, 1472.4194212518253, 1473.7641977283583, 25879.22362329133, 29678.81284748586, 29906.85046574753, 30021.24946876258, 30116.342937034828, 52607.73696131495, 53761.655958601346, 53826.92346153133, 54471.18293225526, 54775.72612136914, 579309.0, 585407.0, 587485.0, 589276.0536197291, 590847.0, 26343.20970370815, 26347.868260658575, 26389.208323750318, 27187.320316992234, 27592.758325874984, 46355.0, 47460.0, 47729.28406073842, 48027.03945921132, 48177.75911120422, 34195.14512137217, 38908.80545597254, 39597.40603891001, 40080.79959600183, 40617.78146655605, 36216.0, 38477.80761096177, 38594.80702596469, 38737.0, 39536.60463395329, 38520.61479385282, 39091.0, 39142.608573913894, 39558.604413955494, 39719.0, 30045.3990920176, 34317.0, 34367.82816085903, 34777.65222347744, 35687.464688029184, 23359.649605256276, 24195.879020604785, 25020.749792501843, 25306.493870122125, 25669.486610268064], "value": 20144.00973687194, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.7781969728012, 374.6534455628543, 377.08744837493265, 390.3520156540144, 397.9633055889408, 19597.0, 20898.89550552249, 21012.26457073999, 21577.13691452342, 21754.12983480659, 18779.967101809394, 20879.0, 21216.363509094714, 21666.783332166673, 22049.33851984443, 4172.666186705072, 5302.284191634138, 5370.892582148354, 5835.387284335136, 6118.357572454895, 5609.887802243953, 6742.325767423267, 6763.256041835394, 6825.044493770876, 6829.043933849265, 6419.390157935012, 6661.500387470935, 6731.495137864656, 6757.763478278262, 6762.2223444304045, 6406.775762848324, 6693.765718199864, 6745.3254674532645, 6760.898586521206, 6765.830854228634, 5741.167530708024, 5839.211706419622, 5862.765489380419, 5873.588848780544, 5877.67672777997, 22848.77151228483, 22871.656925146137, 23184.884075579514, 24327.756722432725, 26524.86737566319, 689.3726708695114, 2086.8330533557278, 2175.749788774295, 2227.8774667393286, 2359.0, 8966.730998070068, 9843.704688859345, 9915.752106197402, 10954.0, 15400.460983865623, 1741.4340339389748, 1777.4223377402395, 1805.5666640006305, 1841.815818418161, 1851.3982955539368, 61587.07654828844, 101588.0, 106613.46693266561, 112985.0, 124750.3762481191, 9829.950850245703, 10330.948345258226, 10815.56737730482, 11357.659270221906, 11863.525458981716, 14771.852281477048, 14815.259237038104, 14861.0, 14861.851381486047, 14867.182304973114, 7589.468737188344, 8221.301189398848, 8468.322534197372, 8621.655133794704, 8691.826163476695, 8374.413791034569, 8534.70128545498, 8636.093210212963, 8638.185980944072, 8661.350398720122, 3970.086880017612, 4508.813225585588, 4626.791794369262, 4665.393498845128, 8055.556944368116, 3641.0, 3721.423179407196, 3874.1670540833857, 3892.2993861104706, 3901.200253947934, 815.2336803404899, 830.5265998380864, 857.9013413457408, 972.411690926979, 996.880374355082, 16176.919115404584, 20470.692939605917, 20904.850233237317, 21305.882760703644, 21360.57278854414, 904.7331037344, 937.0650844200651, 951.7382719751985, 952.319091849331, 1004.2919741582167, 9250.537473126451, 10602.628907988183, 11080.445977701083, 11108.777824443627, 11146.331220126656, 587942.0, 616698.0, 618967.0, 625315.0, 649140.0, 104237.47881260545, 137442.0, 137849.93225101632, 139925.9011114834, 141438.29280853734, 996.5067291690659, 1017.7252141921788, 1040.7554224757175, 1043.5564884923876, 1051.0855555666467, 19302.0, 19410.90294548518, 19468.61062778765, 19706.8029319705, 19711.310104146287, 50987.49012509976, 51445.0, 56302.0, 57494.0, 57746.0, 77529.8370524454, 79535.60232198802, 83043.5847820757, 85012.72480912668, 85202.0, 6102.0, 6414.166158399378, 7030.472714546532, 7417.109946806418, 7589.58257295854, 9700.805983880142, 10727.892721072689, 12454.190477618926, 12526.123171377916, 12817.615471535868, 8674.696385626472, 10532.736681583021, 10583.100436462679, 10683.412412317086, 10813.891861081289, 7680.884786728316, 10372.896271037192, 10428.217883658604, 10597.788044238918, 10711.464426778473, 5630.718464076862, 8097.919020809716, 10604.734881627712, 10849.801485496375, 10920.0, 8076.71731489395, 8087.353011758927, 8252.917470825216, 8279.586020699062, 8331.791705207419, 9840.42553191486, 10782.67651970442, 11030.007299342777, 11043.503042363274, 11085.334879907232], "value": 9659.358471847429, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1317.3874148520936, 1408.591508462546, 1707.598714302139, 1925.0759635375011, 1929.266878586137, 7816.609169541529, 8598.183172598601, 8606.139386061392, 9103.271738260932, 9116.042815504376, 8700.695475658353, 8838.204561589455, 8977.281817454605, 8977.596008179631, 8994.820103597924, 2376.275236053003, 2406.6871306730186, 2409.0484258717884, 2410.301012706313, 2414.7585241475886, 2376.5484557934024, 2383.9642405363934, 2402.8798560072014, 2412.0834083048503, 2426.623873299641, 2350.74141844397, 2379.583572874749, 2397.988010059956, 2399.3881560202126, 2400.099962514057, 2326.906923723049, 2336.3224664847257, 2359.315798418465, 2371.561261166681, 2377.9643305350432, 2354.3290162303833, 2373.5964885969256, 2374.8456350337174, 2375.5248950209852, 2404.4349577849366, 8777.0, 8866.601002954883, 9021.503817290111, 9026.45841249527, 9032.729018129401, 5297.761600727977, 5463.508284254436, 5481.561475081984, 5484.478974497416, 5492.588055895823, 3511.438169892805, 3571.089372210096, 3600.063983364318, 3617.5478065241846, 3638.2177831766035, 1012.3976234140748, 1021.2697920986456, 1027.7893031928436, 1030.7165529479378, 1032.7521394865253, 10467.424291663956, 11525.67454742707, 11808.291502509877, 12098.637040888787, 12124.0, 4764.251683916494, 4775.5463230993, 4856.1016212000895, 4882.853514394503, 4923.75381230937, 10046.799064018678, 10116.494175291205, 10145.0, 10145.137663298554, 10151.746206344753, 5124.282600435942, 5330.92003619946, 5339.813106541253, 5363.892722145535, 5439.075357189287, 4278.679099067583, 4767.404074490689, 4907.411110666742, 4923.655344125948, 4943.036107958914, 3974.6224108709625, 4026.617471340218, 4077.571854955246, 4106.466159399259, 4137.710360274812, 1292.7220647560819, 1317.6244770240435, 1323.5103011885471, 1324.0, 1328.6744747536916, 899.1727610598265, 899.6086702284528, 904.5070436612062, 923.330585325647, 943.2605472101392, 5840.445157710011, 5929.0513517836935, 5959.7853366266245, 6035.969820150871, 6084.752625711719, 416.75828019748474, 430.24062529635216, 434.4547592771052, 437.25666367175927, 453.3992459990526, 3911.92176156481, 3977.866308102177, 3985.5416627087675, 4008.018035581243, 4045.130296986103, 10644.042036216622, 10833.512491937725, 10867.510962006729, 11010.889891100986, 11057.0, 10965.451727413598, 10971.451427428598, 10985.340879547093, 10988.560457581607, 10992.340459572451, 8151.551664658501, 8363.665453381918, 8367.95816020916, 8372.330213582898, 8483.236508714246, 5754.7122643866805, 5841.094630332305, 5907.586468947305, 5943.286805583358, 5979.4917432018765, 10094.949525252327, 10128.645497407555, 10268.537915793659, 10275.280730348804, 10280.897191027994, 10021.348612340174, 10174.847377289494, 10186.949065254626, 10275.332103413255, 10413.583456661649, 6651.235107962646, 7308.269173082649, 7542.585157816373, 7613.200613935457, 7681.577513236825, 8371.079181289932, 8445.366597505335, 8452.915470845213, 8545.2309292164, 8581.785455363417, 7333.669984850588, 7464.440166987389, 7534.113206416675, 7548.622568871425, 7570.356519695667, 7311.341979221896, 7385.519941203805, 7401.185869554452, 7485.588292643957, 7509.023826902468, 7012.333828286304, 7023.367896889305, 7035.472339574655, 7096.325849044332, 7147.070880785673, 4778.522147785194, 4787.210110331756, 4907.68100073494, 4933.679310844784, 5111.798727299156, 4759.309900064402, 4871.439784424837, 4920.975395123145, 4955.900881982412, 5046.1926091825135], "value": 4543.81780012376, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [265.80861779518744, 308.4986896293523, 311.54047779525195, 315.6370174299557, 319.58294425774386, 4757.643176761744, 5732.914006289904, 5754.367019627843, 5771.394003629611, 5805.941940580593, 5570.86072848179, 5571.637843540167, 5636.027390413354, 5642.463965923231, 5676.205331253628, 3616.6311066251646, 3896.5129358830145, 3998.9400158997564, 4176.874693759177, 4216.894577635553, 3996.8001599920035, 4134.607212314825, 4182.351735481006, 4186.392973018926, 4203.7057405981595, 3232.91917702057, 3341.8496167672515, 4123.092919557693, 4228.0, 4267.871963841089, 3874.418837174418, 4148.958510414887, 4185.97907010463, 4186.267403204442, 4206.305959516676, 3550.6449355064547, 3604.297162053401, 3606.4049431843714, 3613.705297136311, 3617.240379520304, 5163.509466600667, 5389.973050134724, 5390.649607775482, 5413.512783849433, 5429.837104886859, 3807.714421418377, 4304.956950430518, 4637.25803871379, 4759.381280433556, 4775.758302841252, 4734.526547345273, 5886.735096920606, 5915.852103697399, 5916.0, 5934.673592952386, 3357.529945807589, 3927.528696556403, 3959.544652364957, 3962.663173630216, 3971.821268042945, 4349.434573505424, 5989.8203053908455, 6200.81397558074, 6202.286737025254, 6328.493720502394, 3818.7326887117633, 3946.7039972002217, 3965.195835894661, 3994.0, 4011.9799401003393, 3754.4180651998986, 4064.227796718614, 4064.451299074646, 4079.8572049978106, 4160.791960401968, 3822.7132965027176, 4063.7358571692744, 4187.309093999456, 4201.747895126241, 4479.59683628475, 5693.3168019837885, 6009.308929473079, 6013.4888534474185, 6013.4888534474185, 6015.368386319461, 1366.0, 1386.5978866128912, 1396.7834985577251, 1400.7408629403592, 1401.1803095189225, 653.8103949854584, 763.8930549723043, 800.5876973358725, 834.6077343648476, 892.2193081054078, 4929.482404347492, 5283.675182919503, 5439.428859969726, 5451.836444906659, 5498.917516237259, 5100.795968161232, 5220.9819085278, 5875.3267263395055, 6067.423594758491, 6112.969435152796, 4830.589399900978, 5101.770420331094, 5370.597205209547, 5374.516293533601, 5477.233187353773, 3193.984030079881, 3196.5205219216837, 3199.840007999591, 3204.5419334202884, 3226.306344136022, 5420.855903575916, 5917.763289468373, 5982.73077711504, 6321.333626496621, 6342.651154186564, 5371.650842695212, 5816.883662326814, 6012.488938440194, 6244.687765611701, 6281.811545653638, 4967.801287948441, 5959.731812068468, 6363.395477429729, 6370.74517019314, 6400.0, 5042.823501177588, 5228.790848366023, 5481.835544933659, 5586.608937374507, 6110.694465276807, 4870.926936095891, 6077.817665470043, 6087.69561521931, 6138.5396095292135, 6145.404938111076, 5241.764120614505, 6110.938890611037, 6344.113428390164, 6409.0, 6434.166262615132, 3546.6985306249258, 3953.2686453005135, 4023.7928621414044, 4062.943634654952, 4068.389741538793, 6195.0, 6216.222972128484, 6265.248170219421, 6271.592346497463, 6285.371462853678, 5485.945140548543, 5799.333076696234, 6001.969990150022, 6019.969900150471, 6041.6375017499095, 5497.560195184456, 5585.871911729445, 5669.618760120677, 6026.246719160105, 6052.606580572248, 5253.03203689914, 5570.2480165177185, 5831.79588714393, 5879.617824841372, 5916.142159386951, 5787.39232380594, 5891.497668094608, 5904.822855314347, 5973.223480947449, 5979.4618484336615, 4492.483364413134, 5600.0, 5720.3707592165665, 5766.365699773106, 5785.045467497984], "value": 4238.60508682282, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [643.9452646525045, 680.3536640191816, 684.7261095561774, 702.6381413572008, 704.0495331302741, 13835.792463113035, 14930.253487325632, 15139.0, 15145.469908553203, 15498.147601881892, 11768.882311176885, 12276.5703200388, 13897.513587024456, 13948.860511394883, 14290.428382864673, 529.0213105754362, 734.2547314475811, 890.1187824054205, 914.2320450821309, 915.0026471146449, 892.2326798952928, 908.9454632722025, 918.4535201555065, 919.2691810011024, 921.424109931293, 957.6648173139415, 970.8058388322329, 973.4645944730405, 975.7853272280087, 978.7259567321162, 941.6986564299461, 957.2676902169845, 966.4201479112546, 966.9661561845337, 968.1963969904962, 685.2907241005536, 708.518207618819, 715.58138488984, 716.2157437605813, 716.2228981555019, 13783.655408614864, 13836.23900685462, 14934.477293294682, 15115.16866572338, 15148.31832567526, 12696.301703406309, 12708.745825083446, 12838.229706217564, 12848.935755321258, 12893.130496078016, 9855.457949812757, 9905.405675659484, 9931.056549627774, 10102.444365559892, 10311.535980880879, 3420.9144771380666, 3458.2219000724635, 3561.6794488495902, 3690.022144131807, 3699.5930447650735, 85883.57058214668, 86897.0, 87822.5608871958, 88005.0, 88156.55921720415, 9275.350725449154, 9427.057294270518, 9457.007014263541, 9550.331476796697, 9741.951290243504, 21245.043973021253, 21601.567968640855, 21917.123315067536, 21937.561248775255, 22040.44898877541, 7391.334779869838, 7446.441516886255, 7533.1336896256535, 7562.773116806505, 7634.503757255871, 4007.29872272357, 4067.1255680028935, 4067.9796601016806, 4077.7757223353, 4083.4283200351974, 3409.931801363959, 3427.6572342765526, 3430.9656903431146, 3473.7047350974944, 3525.858965641397, 602.4939051197016, 621.3196549777986, 626.4174317884411, 630.4168644004278, 632.3929028132952, 516.9015841337158, 570.6718636783866, 599.6462087368474, 604.3442864491988, 616.315889362807, 7890.802729931683, 8118.02583689961, 8257.463264887763, 8296.875546866802, 8339.082700902896, 501.63130099377656, 554.5508138407903, 592.3158751641861, 595.1727099331932, 601.8645804693908, 3831.6934645228316, 3868.400397938324, 3915.784631845219, 3923.2153569286256, 3925.3130702127014, 73015.26984730191, 92304.15391692129, 97175.0, 97962.02037979671, 98528.02943941225, 82032.17967820365, 86462.70305945416, 86653.56673216594, 87552.1244787544, 87948.0, 74988.0, 75252.0, 75447.62276188693, 75872.10319742051, 76613.6169319161, 7565.508241964255, 7624.961875190588, 7700.922990770021, 7833.09919359281, 7940.682372705258, 32445.837770810995, 44072.779636101615, 44637.55362446334, 45332.32001520046, 46250.768746156056, 64782.35217647763, 67099.3290067093, 67322.99015514673, 67443.3255667437, 67547.0, 9216.723498295061, 9258.027907069662, 9729.85405218908, 9984.0, 10256.53845576936, 10930.726731831768, 11033.889661103287, 11097.223194376638, 11124.110071194447, 11211.71970700739, 10150.49247537635, 10464.267501274837, 10495.842562361418, 10557.419341936267, 10902.836457452986, 10326.380417174994, 10491.475426228812, 10520.263581549525, 10714.464276786286, 11499.0, 9844.360116592685, 10785.514651840529, 11087.889121109009, 11095.0, 11131.10951123892, 9376.812463750823, 9512.239020878174, 9519.278422043864, 9569.33014688993, 9668.516574171404, 9210.480721155871, 9629.711108666752, 9657.985911479474, 9685.854712179182, 9851.310408271353], "value": 6782.660177066156, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1670.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 113.0, 117.0, 97.0, 173.0, 174.0, 128.0, 115.0, 116.0, 118.0], "value": 126.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 142.0, 178.0, 203.0, 123.0, 152.0, 171.0, 150.0, 199.0, 126.0], "value": 160.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [206.0, 251.0, 230.0, 236.0, 200.0, 205.0, 238.0, 199.0, 193.0, 195.0], "value": 215.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 111.0, 76.0, 183.0, 59.0, 59.0, 71.0, 99.0, 166.0, 86.0], "value": 97.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 100.0, 180.0, 117.0, 119.0, 93.0, 124.0, 79.0, 83.0, 130.0], "value": 110.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 90.0, 125.0, 95.0, 90.0, 91.0, 87.0, 90.0, 88.0], "value": 93.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 96.0, 97.0, 97.0, 96.0, 117.0, 151.0, 96.0, 104.0, 98.0], "value": 105.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 147.0, 93.0, 98.0, 93.0, 97.0, 153.0, 98.0, 96.0, 96.0], "value": 107.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 60.0, 65.0, 80.0, 94.0, 90.0, 122.0, 62.0, 60.0], "value": 75.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 72.0, 74.0, 73.0, 75.0, 73.0, 72.0, 74.0, 73.0], "value": 72.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 88.0, 88.0, 87.0, 85.0, 91.0, 88.0, 90.0, 90.0], "value": 88.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 152.0, 135.0, 139.0, 152.0, 139.0, 134.0, 142.0, 254.0, 150.0], "value": 155.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 167.0, 199.0, 240.0, 183.0, 190.0, 232.0, 230.0, 175.0, 174.0], "value": 196.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 66.0, 67.0, 70.0, 67.0, 65.0, 65.0, 65.0, 68.0], "value": 67.0, "unit": "score"}]}]} 17:31:03 INFO - Return code: 0 17:31:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:31:03 ERROR - # TBPL SUCCESS # 17:31:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:31:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:31:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:31:03 INFO - 2016-05-23 17:31:03.777 screenresolution[2531:39696] starting screenresolution argv=screenresolution get 17:31:03 INFO - 2016-05-23 17:31:03.780 screenresolution[2531:39696] Display 0: 1600x1200x32@60 17:31:03 INFO - 2016-05-23 17:31:03.786 screenresolution[2532:39699] starting screenresolution argv=screenresolution list 17:31:03 INFO - Available Modes on Display 0 17:31:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:31:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:31:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:31:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:31:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:31:04 INFO - Intel Iris: 17:31:04 INFO - Chipset Model: Intel Iris 17:31:04 INFO - Type: GPU 17:31:04 INFO - Bus: Built-In 17:31:04 INFO - VRAM (Dynamic, Max): 1536 MB 17:31:04 INFO - Vendor: Intel (0x8086) 17:31:04 INFO - Device ID: 0x0a2e 17:31:04 INFO - Revision ID: 0x0009 17:31:04 INFO - Displays: 17:31:04 INFO - Display: 17:31:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:31:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:31:04 INFO - Display Serial Number: 1600x1200 60 17:31:04 INFO - Main Display: Yes 17:31:04 INFO - Mirror: Off 17:31:04 INFO - Online: Yes 17:31:04 INFO - Rotation: Supported 17:31:04 INFO - Return code: 0 17:31:04 INFO - Running post-action listener: _resource_record_post_action 17:31:04 INFO - ##### 17:31:04 INFO - ##### Finished run-tests step (success) 17:31:04 INFO - ##### 17:31:04 INFO - Running post-run listener: _resource_record_post_run 17:31:04 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 0; Write bytes: 698641920; Read time: 0; Write time: 1937 17:31:04 INFO - TinderboxPrint: CPU usage
54.4% 17:31:04 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 17:31:04 INFO - TinderboxPrint: I/O write bytes / time
698,641,920 / 1,937 17:31:04 INFO - TinderboxPrint: CPU idle
2,211.3 (45.6%) 17:31:04 INFO - TinderboxPrint: CPU system
980.3 (20.2%) 17:31:04 INFO - TinderboxPrint: CPU user
1,654.1 (34.1%) 17:31:04 INFO - TinderboxPrint: Swap in / out
395,587,584 / 0 17:31:04 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 389980672; Write bytes: 384360960; Read time: 29548; Write time: 774 17:31:04 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 0; Write bytes: 298966016; Read time: 0; Write time: 1117 17:31:04 INFO - Running post-run listener: _upload_blobber_files 17:31:04 INFO - Blob upload gear active. 17:31:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:31:04 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 17:31:04 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'] 17:31:04 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 17:31:05 INFO - (blobuploader) - INFO - Open directory for files ... 17:31:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:31:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:31:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:31:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:31:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:31:06 INFO - (blobuploader) - INFO - Done attempting. 17:31:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:31:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:31:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:31:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:31:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:31:07 INFO - (blobuploader) - INFO - Done attempting. 17:31:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:31:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:31:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:31:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:31:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:31:09 INFO - (blobuploader) - INFO - Done attempting. 17:31:09 INFO - (blobuploader) - INFO - Iteration through files over. 17:31:09 INFO - Return code: 0 17:31:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:31:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:31:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a293163b171d9ae34799be26b1772345bc8d36b0c687662ad78c3d3d1ad6e2f56f76046f0b4c45e370bf546bb9b5990a7853acd683b1072b0d6732d69253502f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ab4b9257d52f6ef6dc6a871aed66d6504277bcc845d8e890cbbbfc8d725f5e5b0258cb94e610faa0d26e286438a462771ab6c2fc059b7107ed745458687a9757", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/869f0f7e4b3381db81b29bafb15fff4ccf757152fa8cc991ae1341ec4383abf495f278dd7cae4018da9bbaab74072d6df788089a6d1d157ebe0241f94ca74aeb"} 17:31:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:31:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:31:09 INFO - Contents: 17:31:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a293163b171d9ae34799be26b1772345bc8d36b0c687662ad78c3d3d1ad6e2f56f76046f0b4c45e370bf546bb9b5990a7853acd683b1072b0d6732d69253502f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ab4b9257d52f6ef6dc6a871aed66d6504277bcc845d8e890cbbbfc8d725f5e5b0258cb94e610faa0d26e286438a462771ab6c2fc059b7107ed745458687a9757", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/869f0f7e4b3381db81b29bafb15fff4ccf757152fa8cc991ae1341ec4383abf495f278dd7cae4018da9bbaab74072d6df788089a6d1d157ebe0241f94ca74aeb"} 17:31:09 INFO - Running post-run listener: copy_logs_to_upload_dir 17:31:09 INFO - Copying logs to upload dir... 17:31:09 INFO - mkdir: /builds/slave/test/build/upload/logs 17:31:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1297.776958 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 37 secs) (at 2016-05-23 17:31:09.718735) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 17:31:09.724630) ========= 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.b5tKPQfxms/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.6HwiSwKaqP/Listeners TMPDIR=/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/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/a293163b171d9ae34799be26b1772345bc8d36b0c687662ad78c3d3d1ad6e2f56f76046f0b4c45e370bf546bb9b5990a7853acd683b1072b0d6732d69253502f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ab4b9257d52f6ef6dc6a871aed66d6504277bcc845d8e890cbbbfc8d725f5e5b0258cb94e610faa0d26e286438a462771ab6c2fc059b7107ed745458687a9757", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/869f0f7e4b3381db81b29bafb15fff4ccf757152fa8cc991ae1341ec4383abf495f278dd7cae4018da9bbaab74072d6df788089a6d1d157ebe0241f94ca74aeb"} build_url:https://queue.taskcluster.net/v1/task/eaqnZR3wSb6b9FD60K96ug/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011007 build_url: 'https://queue.taskcluster.net/v1/task/eaqnZR3wSb6b9FD60K96ug/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/a293163b171d9ae34799be26b1772345bc8d36b0c687662ad78c3d3d1ad6e2f56f76046f0b4c45e370bf546bb9b5990a7853acd683b1072b0d6732d69253502f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ab4b9257d52f6ef6dc6a871aed66d6504277bcc845d8e890cbbbfc8d725f5e5b0258cb94e610faa0d26e286438a462771ab6c2fc059b7107ed745458687a9757", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/869f0f7e4b3381db81b29bafb15fff4ccf757152fa8cc991ae1341ec4383abf495f278dd7cae4018da9bbaab74072d6df788089a6d1d157ebe0241f94ca74aeb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 17:31:09.753788) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 17:31:09.754132) ========= 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.b5tKPQfxms/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.6HwiSwKaqP/Listeners TMPDIR=/var/folders/05/kvspgyq10sb_rylg685dcdw800000w/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.005292 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 17:31:09.804459) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 17:31:09.804770) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 17:31:09.805112) ========= ========= Total master_lag: 0.18 =========