builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0168 starttime: 1464243860.43 results: success (0) buildid: 20160525204851 builduid: 5d679e607a424656ad6003a26e637ab7 revision: 25566a14a7ac98674bfe9b6e73edc59fcc286c22 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 23:24:20.431290) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 23:24:20.431688) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 23:24:20.431989) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 23:24:20.456569) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 23:24:20.456884) ========= 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.lQq1M8Clxe/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.Wl9SPVdJWv/Listeners TMPDIR=/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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-25 23:24:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 40.1M=0s 2016-05-25 23:24:20 (40.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.136941 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 23:24:20.658155) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 23:24:20.658641) ========= 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.lQq1M8Clxe/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.Wl9SPVdJWv/Listeners TMPDIR=/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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.027422 ========= master_lag: 0.16 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 23:24:20.845096) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-25 23:24:20.845628) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 25566a14a7ac98674bfe9b6e73edc59fcc286c22 --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 25566a14a7ac98674bfe9b6e73edc59fcc286c22 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lQq1M8Clxe/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.Wl9SPVdJWv/Listeners TMPDIR=/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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-25 23:24:20,924 truncating revision to first 12 chars 2016-05-25 23:24:20,925 Setting DEBUG logging. 2016-05-25 23:24:20,925 attempt 1/10 2016-05-25 23:24:20,925 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/25566a14a7ac?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-25 23:24:21,690 unpacking tar archive at: fx-team-25566a14a7ac/testing/mozharness/ program finished with exit code 0 elapsedTime=1.032045 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-25 23:24:21.901407) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 23:24:21.902037) ========= script_repo_revision: 25566a14a7ac98674bfe9b6e73edc59fcc286c22 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 23:24:21.902738) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 23:24:21.903218) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 23:24:21.920890) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-05-25 23:24:21.921282) ========= /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.lQq1M8Clxe/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.Wl9SPVdJWv/Listeners TMPDIR=/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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 23:24:22 INFO - MultiFileLogger online at 20160525 23:24:22 in /builds/slave/test 23:24:22 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 23:24:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:24:22 INFO - {'append_to_log': False, 23:24:22 INFO - 'base_work_dir': '/builds/slave/test', 23:24:22 INFO - 'blob_upload_branch': 'Fx-Team', 23:24:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:24:22 INFO - 'branch': 'Fx-Team', 23:24:22 INFO - 'buildbot_json_path': 'buildprops.json', 23:24:22 INFO - 'config_files': ('talos/mac_config.py',), 23:24:22 INFO - 'default_actions': ('clobber', 23:24:22 INFO - 'read-buildbot-config', 23:24:22 INFO - 'download-and-extract', 23:24:22 INFO - 'populate-webroot', 23:24:22 INFO - 'create-virtualenv', 23:24:22 INFO - 'install', 23:24:22 INFO - 'run-tests'), 23:24:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:24:22 INFO - 'download_minidump_stackwalk': True, 23:24:22 INFO - 'download_symbols': 'ondemand', 23:24:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:24:22 INFO - 'tooltool.py': '/tools/tooltool.py', 23:24:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:24:22 INFO - '/tools/misc-python/virtualenv.py')}, 23:24:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:24:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:24:22 INFO - 'installer_path': 'installer.exe', 23:24:22 INFO - 'log_level': 'info', 23:24:22 INFO - 'log_name': 'talos', 23:24:22 INFO - 'log_to_console': True, 23:24:22 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 23:24:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 23:24:22 INFO - 'opt_config_files': (), 23:24:22 INFO - 'pip_index': False, 23:24:22 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:24:22 INFO - 'cmd': ('bash', 23:24:22 INFO - '-c', 23:24:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:24:22 INFO - 'enabled': True, 23:24:22 INFO - 'halt_on_failure': False, 23:24:22 INFO - 'name': 'check_screen_resolution'},), 23:24:22 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:24:22 INFO - 'cmd': ('bash', 23:24:22 INFO - '-c', 23:24:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:24:22 INFO - 'enabled': True, 23:24:22 INFO - 'halt_on_failure': False, 23:24:22 INFO - 'name': 'check_screen_resolution'},), 23:24:22 INFO - 'run_cmd_checks_enabled': True, 23:24:22 INFO - 'sps_profile': False, 23:24:22 INFO - 'sps_profile_interval': 0, 23:24:22 INFO - 'suite': 'dromaeojs-e10s', 23:24:22 INFO - 'system_bits': '32', 23:24:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:24:22 INFO - 'title': 't-yosemite-r7-0168', 23:24:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:24:22 INFO - 'use_talos_json': True, 23:24:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:24:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:24:22 INFO - 'work_dir': 'build'} 23:24:22 INFO - ##### 23:24:22 INFO - ##### Running clobber step. 23:24:22 INFO - ##### 23:24:22 INFO - Running pre-action listener: _resource_record_pre_action 23:24:22 INFO - Running main action method: clobber 23:24:22 INFO - rmtree: /builds/slave/test/build 23:24:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:24:24 INFO - Running post-action listener: _resource_record_post_action 23:24:24 INFO - ##### 23:24:24 INFO - ##### Finished clobber step (success) 23:24:24 INFO - ##### 23:24:24 INFO - ##### 23:24:24 INFO - ##### Running read-buildbot-config step. 23:24:24 INFO - ##### 23:24:24 INFO - Running pre-action listener: _resource_record_pre_action 23:24:24 INFO - Running main action method: read_buildbot_config 23:24:24 INFO - Using buildbot properties: 23:24:24 INFO - { 23:24:24 INFO - "project": "", 23:24:24 INFO - "product": "firefox", 23:24:24 INFO - "script_repo_revision": "production", 23:24:24 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 23:24:24 INFO - "repository": "", 23:24:24 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 23:24:24 INFO - "buildid": "20160525204851", 23:24:24 INFO - "pgo_build": "False", 23:24:24 INFO - "basedir": "/builds/slave/test", 23:24:24 INFO - "buildnumber": 20, 23:24:24 INFO - "slavename": "t-yosemite-r7-0168", 23:24:24 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 23:24:24 INFO - "platform": "yosemite_r7", 23:24:24 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 23:24:24 INFO - "branch": "fx-team", 23:24:24 INFO - "repo_path": "integration/fx-team", 23:24:24 INFO - "revision": "25566a14a7ac98674bfe9b6e73edc59fcc286c22", 23:24:24 INFO - "stage_platform": "macosx64", 23:24:24 INFO - "builduid": "5d679e607a424656ad6003a26e637ab7", 23:24:24 INFO - "slavebuilddir": "test" 23:24:24 INFO - } 23:24:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/R7anaQXgTwKgFY0a0bDjjA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 23:24:24 INFO - Running post-action listener: _resource_record_post_action 23:24:24 INFO - ##### 23:24:24 INFO - ##### Finished read-buildbot-config step (success) 23:24:24 INFO - ##### 23:24:24 INFO - ##### 23:24:24 INFO - ##### Running download-and-extract step. 23:24:24 INFO - ##### 23:24:24 INFO - Running pre-action listener: _resource_record_pre_action 23:24:24 INFO - Running main action method: download_and_extract 23:24:24 INFO - mkdir: /builds/slave/test/build/tests 23:24:24 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')]} 23:24:24 INFO - https://queue.taskcluster.net/v1/task/R7anaQXgTwKgFY0a0bDjjA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 23:24:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7anaQXgTwKgFY0a0bDjjA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 23:24:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7anaQXgTwKgFY0a0bDjjA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 23:24:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7anaQXgTwKgFY0a0bDjjA/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 23:24:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7anaQXgTwKgFY0a0bDjjA/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 23:24:27 INFO - Downloaded 1199 bytes. 23:24:27 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 23:24:27 INFO - Using the following test package requirements: 23:24:27 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 23:24:27 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 23:24:27 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 23:24:27 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 23:24:27 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 23:24:27 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 23:24:27 INFO - u'jsshell-mac.zip'], 23:24:27 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 23:24:27 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 23:24:27 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 23:24:27 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 23:24:27 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 23:24:27 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 23:24:27 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 23:24:27 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 23:24:27 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 23:24:27 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 23:24:27 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 23:24:27 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 23:24:27 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')]} 23:24:27 INFO - https://queue.taskcluster.net/v1/task/R7anaQXgTwKgFY0a0bDjjA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 23:24:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7anaQXgTwKgFY0a0bDjjA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 23:24:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7anaQXgTwKgFY0a0bDjjA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 23:24:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7anaQXgTwKgFY0a0bDjjA/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 23:24:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7anaQXgTwKgFY0a0bDjjA/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 23:24:32 INFO - Downloaded 18622344 bytes. 23:24:32 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'] 23:24:32 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 23:24:35 INFO - Return code: 0 23:24:35 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 23:24:35 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')]} 23:24:35 INFO - https://queue.taskcluster.net/v1/task/R7anaQXgTwKgFY0a0bDjjA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 23:24:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7anaQXgTwKgFY0a0bDjjA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 23:24:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7anaQXgTwKgFY0a0bDjjA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 23:24:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7anaQXgTwKgFY0a0bDjjA/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 23:24:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7anaQXgTwKgFY0a0bDjjA/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 23:24:40 INFO - Downloaded 18622344 bytes. 23:24:40 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'] 23:24:40 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 23:24:44 INFO - Return code: 0 23:24: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')]} 23:24:44 INFO - https://queue.taskcluster.net/v1/task/R7anaQXgTwKgFY0a0bDjjA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 23:24:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7anaQXgTwKgFY0a0bDjjA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 23:24:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7anaQXgTwKgFY0a0bDjjA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 23:24:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7anaQXgTwKgFY0a0bDjjA/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 23:24:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7anaQXgTwKgFY0a0bDjjA/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 23:24:45 INFO - Downloaded 10834034 bytes. 23:24:45 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'] 23:24:45 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 23:24:45 INFO - Return code: 0 23:24:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:45 INFO - https://queue.taskcluster.net/v1/task/R7anaQXgTwKgFY0a0bDjjA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 23:24:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7anaQXgTwKgFY0a0bDjjA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 23:24:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7anaQXgTwKgFY0a0bDjjA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 23:24:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7anaQXgTwKgFY0a0bDjjA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 23:24:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7anaQXgTwKgFY0a0bDjjA/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 23:24:48 INFO - Downloaded 110500519 bytes. 23:24:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/R7anaQXgTwKgFY0a0bDjjA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 23:24:48 INFO - mkdir: /builds/slave/test/properties 23:24:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:24:48 INFO - Writing to file /builds/slave/test/properties/build_url 23:24:48 INFO - Contents: 23:24:48 INFO - build_url:https://queue.taskcluster.net/v1/task/R7anaQXgTwKgFY0a0bDjjA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 23:24:49 INFO - Running post-action listener: _resource_record_post_action 23:24:49 INFO - Running post-action listener: set_extra_try_arguments 23:24:49 INFO - ##### 23:24:49 INFO - ##### Finished download-and-extract step (success) 23:24:49 INFO - ##### 23:24:49 INFO - ##### 23:24:49 INFO - ##### Running populate-webroot step. 23:24:49 INFO - ##### 23:24:49 INFO - Running pre-action listener: _resource_record_pre_action 23:24:49 INFO - Running main action method: populate_webroot 23:24:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:24:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:24:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:24:49 INFO - '--tppagecycles', 23:24:49 INFO - '7'], 23:24:49 INFO - 'tests': ['tsvgm']}}, 23:24:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:24:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:24:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:24:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:24:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:24:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:24:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:49 INFO - 'talos_options': ['--disable-e10s'], 23:24:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:24:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:24:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:49 INFO - 'talos_options': ['--disable-e10s'], 23:24:49 INFO - 'tests': ['damp', 'tps']}, 23:24:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:49 INFO - 'tests': ['damp', 'tps']}, 23:24:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:24:49 INFO - 'tests': ['dromaeo_dom']}, 23:24:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:24:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:24:49 INFO - 'tests': ['a11yr', 23:24:49 INFO - 'ts_paint', 23:24:49 INFO - 'tpaint', 23:24:49 INFO - 'sessionrestore', 23:24:49 INFO - 'sessionrestore_no_auto_restore', 23:24:49 INFO - 'tabpaint']}, 23:24:49 INFO - 'other-e10s': {'tests': ['a11yr', 23:24:49 INFO - 'ts_paint', 23:24:49 INFO - 'tpaint', 23:24:49 INFO - 'sessionrestore', 23:24:49 INFO - 'sessionrestore_no_auto_restore', 23:24:49 INFO - 'tabpaint']}, 23:24:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:24:49 INFO - 'ts_paint', 23:24:49 INFO - 'tpaint', 23:24:49 INFO - 'sessionrestore', 23:24:49 INFO - 'sessionrestore_no_auto_restore', 23:24:49 INFO - 'tabpaint']}, 23:24:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:24:49 INFO - 'ts_paint', 23:24:49 INFO - 'tpaint', 23:24:49 INFO - 'sessionrestore', 23:24:49 INFO - 'sessionrestore_no_auto_restore', 23:24:49 INFO - 'tabpaint']}, 23:24:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:24:49 INFO - 'tests': ['a11yr', 23:24:49 INFO - 'ts_paint', 23:24:49 INFO - 'tpaint', 23:24:49 INFO - 'sessionrestore', 23:24:49 INFO - 'sessionrestore_no_auto_restore', 23:24:49 INFO - 'tabpaint']}, 23:24:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:24:49 INFO - 'tests': ['a11yr', 23:24:49 INFO - 'ts_paint', 23:24:49 INFO - 'tpaint', 23:24:49 INFO - 'sessionrestore', 23:24:49 INFO - 'sessionrestore_no_auto_restore', 23:24:49 INFO - 'tabpaint']}, 23:24:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:24:49 INFO - 'tests': ['tsvgx', 23:24:49 INFO - 'tsvgr_opacity', 23:24:49 INFO - 'tart', 23:24:49 INFO - 'tscrollx', 23:24:49 INFO - 'cart']}, 23:24:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:24:49 INFO - 'tsvgr_opacity', 23:24:49 INFO - 'tart', 23:24:49 INFO - 'tscrollx', 23:24:49 INFO - 'cart']}, 23:24:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:49 INFO - 'talos_options': ['--disable-e10s'], 23:24:49 INFO - 'tests': ['tp5o']}, 23:24:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:49 INFO - 'tests': ['tp5o']}, 23:24:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:49 INFO - 'talos_options': ['--disable-e10s', 23:24:49 INFO - '--xperf_path', 23:24:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:24:49 INFO - 'tests': ['tp5n']}, 23:24:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:49 INFO - 'talos_options': ['--xperf_path', 23:24:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:24:49 INFO - 'tests': ['tp5n']}}, 23:24:49 INFO - 'talos.zip': {'path': '', 23:24:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:24:49 INFO - Running post-action listener: _resource_record_post_action 23:24:49 INFO - ##### 23:24:49 INFO - ##### Finished populate-webroot step (success) 23:24:49 INFO - ##### 23:24:49 INFO - ##### 23:24:49 INFO - ##### Running create-virtualenv step. 23:24:49 INFO - ##### 23:24:49 INFO - Running pre-action listener: _resource_record_pre_action 23:24:49 INFO - Running main action method: create_virtualenv 23:24:49 INFO - Creating virtualenv /builds/slave/test/build/venv 23:24:49 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 23:24:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:24:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:24:49 INFO - Using real prefix '/tools/python27' 23:24:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:24:50 INFO - Installing distribute.............................................................................................................................................................................................done. 23:24:53 INFO - Installing pip.................done. 23:24:53 INFO - Return code: 0 23:24:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:24:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103ffca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104002570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa161c928c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ea0d30>, '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 0x103cc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e97b20>, '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.lQq1M8Clxe/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.Wl9SPVdJWv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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 23:24:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:24:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:24:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lQq1M8Clxe/Render', 23:24:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:24:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:24:53 INFO - 'HOME': '/Users/cltbld', 23:24:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:24:53 INFO - 'LOGNAME': 'cltbld', 23:24:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:53 INFO - 'MOZ_NO_REMOTE': '1', 23:24:53 INFO - 'NO_EM_RESTART': '1', 23:24:53 INFO - 'PAGER': '/bin/cat', 23:24:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:24:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:53 INFO - 'PWD': '/builds/slave/test', 23:24:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:24:53 INFO - 'SHELL': '/bin/bash', 23:24:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wl9SPVdJWv/Listeners', 23:24:53 INFO - 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', 23:24:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:24:53 INFO - 'USER': 'cltbld', 23:24:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:24:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:24:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:53 INFO - 'XPC_FLAGS': '0x0', 23:24:53 INFO - 'XPC_SERVICE_NAME': '0', 23:24:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:24:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:53 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 23:24:53 INFO - Cleaning up... 23:24:53 INFO - Return code: 0 23:24:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:24:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103ffca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104002570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa161c928c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ea0d30>, '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 0x103cc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e97b20>, '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.lQq1M8Clxe/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.Wl9SPVdJWv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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 23:24:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 23:24:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 23:24:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lQq1M8Clxe/Render', 23:24:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:24:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:24:53 INFO - 'HOME': '/Users/cltbld', 23:24:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:24:53 INFO - 'LOGNAME': 'cltbld', 23:24:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:53 INFO - 'MOZ_NO_REMOTE': '1', 23:24:53 INFO - 'NO_EM_RESTART': '1', 23:24:53 INFO - 'PAGER': '/bin/cat', 23:24:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:24:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:53 INFO - 'PWD': '/builds/slave/test', 23:24:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:24:53 INFO - 'SHELL': '/bin/bash', 23:24:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wl9SPVdJWv/Listeners', 23:24:53 INFO - 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', 23:24:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:24:53 INFO - 'USER': 'cltbld', 23:24:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:24:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:24:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:53 INFO - 'XPC_FLAGS': '0x0', 23:24:53 INFO - 'XPC_SERVICE_NAME': '0', 23:24:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:24:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:53 INFO - Downloading/unpacking psutil>=3.1.1 23:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:24:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:24:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:24:56 INFO - Installing collected packages: psutil 23:24:56 INFO - Running setup.py install for psutil 23:24:56 INFO - building 'psutil._psutil_osx' extension 23:24:56 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 23:24:57 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 23:24:57 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 23:24:57 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 23:24:57 INFO - building 'psutil._psutil_posix' extension 23:24:57 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 23:24:57 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 23:24:57 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 23:24:57 INFO - ^ 23:24:57 INFO - 1 warning generated. 23:24:57 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 23:24:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:24:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:24:58 INFO - Successfully installed psutil 23:24:58 INFO - Cleaning up... 23:24:58 INFO - Return code: 0 23:24:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:24:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:58 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 0x103ffca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104002570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa161c928c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ea0d30>, '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 0x103cc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e97b20>, '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.lQq1M8Clxe/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.Wl9SPVdJWv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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 23:24:58 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 23:24:58 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 23:24:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lQq1M8Clxe/Render', 23:24:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:24:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:24:58 INFO - 'HOME': '/Users/cltbld', 23:24:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:24:58 INFO - 'LOGNAME': 'cltbld', 23:24:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:58 INFO - 'MOZ_NO_REMOTE': '1', 23:24:58 INFO - 'NO_EM_RESTART': '1', 23:24:58 INFO - 'PAGER': '/bin/cat', 23:24:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:24:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:58 INFO - 'PWD': '/builds/slave/test', 23:24:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:24:58 INFO - 'SHELL': '/bin/bash', 23:24:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wl9SPVdJWv/Listeners', 23:24:58 INFO - 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', 23:24:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:24:58 INFO - 'USER': 'cltbld', 23:24:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:24:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:24:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:58 INFO - 'XPC_FLAGS': '0x0', 23:24:58 INFO - 'XPC_SERVICE_NAME': '0', 23:24:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:24:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:25:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:25:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:25:00 INFO - Installing collected packages: mozsystemmonitor 23:25:00 INFO - Running setup.py install for mozsystemmonitor 23:25:00 INFO - Successfully installed mozsystemmonitor 23:25:00 INFO - Cleaning up... 23:25:01 INFO - Return code: 0 23:25:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:25:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:25:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:25:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103ffca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104002570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa161c928c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ea0d30>, '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 0x103cc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e97b20>, '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.lQq1M8Clxe/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.Wl9SPVdJWv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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 23:25:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:25:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:25:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lQq1M8Clxe/Render', 23:25:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:25:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:25:01 INFO - 'HOME': '/Users/cltbld', 23:25:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:25:01 INFO - 'LOGNAME': 'cltbld', 23:25:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:25:01 INFO - 'MOZ_NO_REMOTE': '1', 23:25:01 INFO - 'NO_EM_RESTART': '1', 23:25:01 INFO - 'PAGER': '/bin/cat', 23:25:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:25:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:25:01 INFO - 'PWD': '/builds/slave/test', 23:25:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:25:01 INFO - 'SHELL': '/bin/bash', 23:25:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wl9SPVdJWv/Listeners', 23:25:01 INFO - 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', 23:25:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:25:01 INFO - 'USER': 'cltbld', 23:25:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:25:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:25:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:25:01 INFO - 'XPC_FLAGS': '0x0', 23:25:01 INFO - 'XPC_SERVICE_NAME': '0', 23:25:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:25:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:25:01 INFO - Downloading/unpacking blobuploader==1.2.4 23:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:03 INFO - Downloading blobuploader-1.2.4.tar.gz 23:25:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:25:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:25:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:25:04 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 23:25:04 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 23:25:04 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 23:25:04 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 23:25:04 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 23:25:04 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 23:25:04 INFO - Downloading docopt-0.6.1.tar.gz 23:25:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:25:05 INFO - Installing collected packages: blobuploader, requests, docopt 23:25:05 INFO - Running setup.py install for blobuploader 23:25:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:25:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:25:05 INFO - Running setup.py install for requests 23:25:05 INFO - Running setup.py install for docopt 23:25:05 INFO - Successfully installed blobuploader requests docopt 23:25:05 INFO - Cleaning up... 23:25:05 INFO - Return code: 0 23:25:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:25:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:25:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:25:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:05 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 0x103ffca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104002570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa161c928c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ea0d30>, '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 0x103cc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e97b20>, '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.lQq1M8Clxe/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.Wl9SPVdJWv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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 23:25:05 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 23:25:05 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 23:25:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lQq1M8Clxe/Render', 23:25:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:25:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:25:05 INFO - 'HOME': '/Users/cltbld', 23:25:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:25:05 INFO - 'LOGNAME': 'cltbld', 23:25:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:25:05 INFO - 'MOZ_NO_REMOTE': '1', 23:25:05 INFO - 'NO_EM_RESTART': '1', 23:25:05 INFO - 'PAGER': '/bin/cat', 23:25:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:25:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:25:05 INFO - 'PWD': '/builds/slave/test', 23:25:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:25:05 INFO - 'SHELL': '/bin/bash', 23:25:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wl9SPVdJWv/Listeners', 23:25:05 INFO - 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', 23:25:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:25:05 INFO - 'USER': 'cltbld', 23:25:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:25:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:25:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:25:05 INFO - 'XPC_FLAGS': '0x0', 23:25:05 INFO - 'XPC_SERVICE_NAME': '0', 23:25:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:25:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:25:06 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-BmAA9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:25:06 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-LKXeYq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:25:06 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-bCL3JK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:25:06 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-RNgPvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:25:06 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-Nk5Gum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:25:06 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-Qk1LNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:25:06 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-P0xNIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:25:06 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-c9nqd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:25:07 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-W0ZC3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:25:07 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-LgZfTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:25:07 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-WY6_HO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:25:07 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-PXZMfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:25:07 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-I0fDpR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:25:07 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-FyCB94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:25:07 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-VH2JTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:25:07 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-TYCTMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:25:07 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-L3tY4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:25:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:25:07 INFO - Running setup.py install for manifestparser 23:25:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:25:08 INFO - Running setup.py install for mozcrash 23:25:08 INFO - Running setup.py install for mozdebug 23:25:08 INFO - Running setup.py install for mozdevice 23:25:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:25:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:25:08 INFO - Running setup.py install for mozfile 23:25:08 INFO - Running setup.py install for mozhttpd 23:25:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:25:08 INFO - Running setup.py install for mozinfo 23:25:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:25:08 INFO - Running setup.py install for mozInstall 23:25:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:25:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:25:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:25:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:25:09 INFO - Running setup.py install for mozleak 23:25:09 INFO - Running setup.py install for mozlog 23:25:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:25:09 INFO - Running setup.py install for moznetwork 23:25:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:25:09 INFO - Running setup.py install for mozprocess 23:25:09 INFO - Running setup.py install for mozprofile 23:25:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:25:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:25:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:25:09 INFO - Running setup.py install for mozrunner 23:25:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:25:10 INFO - Running setup.py install for mozscreenshot 23:25:10 INFO - Running setup.py install for moztest 23:25:10 INFO - Running setup.py install for mozversion 23:25:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:25:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:25:10 INFO - Cleaning up... 23:25:10 INFO - Return code: 0 23:25:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:25: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')]} 23:25:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:25:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25: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')]} 23:25:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:25:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:10 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 0x103ffca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104002570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa161c928c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ea0d30>, '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 0x103cc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e97b20>, '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.lQq1M8Clxe/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.Wl9SPVdJWv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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 23:25:10 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 23:25:10 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 23:25:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lQq1M8Clxe/Render', 23:25:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:25:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:25:10 INFO - 'HOME': '/Users/cltbld', 23:25:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:25:10 INFO - 'LOGNAME': 'cltbld', 23:25:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:25:10 INFO - 'MOZ_NO_REMOTE': '1', 23:25:10 INFO - 'NO_EM_RESTART': '1', 23:25:10 INFO - 'PAGER': '/bin/cat', 23:25:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:25:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:25:10 INFO - 'PWD': '/builds/slave/test', 23:25:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:25:10 INFO - 'SHELL': '/bin/bash', 23:25:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wl9SPVdJWv/Listeners', 23:25:10 INFO - 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', 23:25:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:25:10 INFO - 'USER': 'cltbld', 23:25:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:25:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:25:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:25:10 INFO - 'XPC_FLAGS': '0x0', 23:25:10 INFO - 'XPC_SERVICE_NAME': '0', 23:25:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:25:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:25:10 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-Ag4Psz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:25:10 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)) 23:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:25:10 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-YKZdNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:25:11 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)) 23:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:25:11 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-v_GTlG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:25:11 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)) 23:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:25:11 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-dO6g7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:25:11 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)) 23:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:25:11 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-aBG2Rz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:25:11 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)) 23:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:25:11 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-VkhCTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:25:11 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)) 23:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:25:11 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-EStG7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:25:11 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)) 23:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:25:11 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-izt9Fj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:25:11 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)) 23:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:25:11 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-txAhjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:25:11 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)) 23:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:25:11 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-OuHP3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:25:11 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)) 23:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:25:11 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-ipo1H8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:25:11 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)) 23:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:25:11 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-adCgFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:25:12 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)) 23:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:25:12 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-REdKCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:25:12 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)) 23:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:25:12 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-sryAYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:25:12 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)) 23:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:25:12 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-D05h5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:25:12 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)) 23:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:25:12 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-OaRhLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:25:12 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)) 23:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:25:12 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-ZqGook-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:25:12 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)) 23:25:12 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)) 23:25:12 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)) 23:25:12 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)) 23:25:12 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)) 23:25:12 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)) 23:25:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:25:12 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 23:25:12 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 23:25:12 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 23:25:12 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 23:25:12 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 23:25:12 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 23:25:14 INFO - Downloading blessings-1.6.tar.gz 23:25:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:25:15 INFO - Installing collected packages: blessings 23:25:15 INFO - Running setup.py install for blessings 23:25:15 INFO - Successfully installed blessings 23:25:15 INFO - Cleaning up... 23:25:15 INFO - Return code: 0 23:25:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:25:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:25:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:25:15 INFO - Reading from file tmpfile_stdout 23:25:15 INFO - Current package versions: 23:25:15 INFO - blessings == 1.6 23:25:15 INFO - blobuploader == 1.2.4 23:25:15 INFO - docopt == 0.6.1 23:25:15 INFO - manifestparser == 1.1 23:25:15 INFO - mozInstall == 1.12 23:25:15 INFO - mozcrash == 0.17 23:25:15 INFO - mozdebug == 0.1 23:25:15 INFO - mozdevice == 0.48 23:25:15 INFO - mozfile == 1.2 23:25:15 INFO - mozhttpd == 0.7 23:25:15 INFO - mozinfo == 0.9 23:25:15 INFO - mozleak == 0.1 23:25:15 INFO - mozlog == 3.2 23:25:15 INFO - moznetwork == 0.27 23:25:15 INFO - mozprocess == 0.22 23:25:15 INFO - mozprofile == 0.28 23:25:15 INFO - mozrunner == 6.11 23:25:15 INFO - mozscreenshot == 0.1 23:25:15 INFO - mozsystemmonitor == 0.3 23:25:15 INFO - moztest == 0.7 23:25:15 INFO - mozversion == 1.4 23:25:15 INFO - psutil == 3.1.1 23:25:15 INFO - requests == 1.2.3 23:25:15 INFO - wsgiref == 0.1.2 23:25:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:25:15 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')]} 23:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:25:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:15 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')]} 23:25:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:25:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:15 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 0x103ffca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104002570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa161c928c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ea0d30>, '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 0x103cc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e97b20>, '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.lQq1M8Clxe/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.Wl9SPVdJWv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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 23:25:15 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 23:25:15 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 23:25:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lQq1M8Clxe/Render', 23:25:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:25:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:25:15 INFO - 'HOME': '/Users/cltbld', 23:25:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:25:15 INFO - 'LOGNAME': 'cltbld', 23:25:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:25:15 INFO - 'MOZ_NO_REMOTE': '1', 23:25:15 INFO - 'NO_EM_RESTART': '1', 23:25:15 INFO - 'PAGER': '/bin/cat', 23:25:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:25:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:25:15 INFO - 'PWD': '/builds/slave/test', 23:25:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:25:15 INFO - 'SHELL': '/bin/bash', 23:25:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wl9SPVdJWv/Listeners', 23:25:15 INFO - 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', 23:25:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:25:15 INFO - 'USER': 'cltbld', 23:25:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:25:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:25:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:25:15 INFO - 'XPC_FLAGS': '0x0', 23:25:15 INFO - 'XPC_SERVICE_NAME': '0', 23:25:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:25:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:25:15 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)) 23:25:15 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)) 23:25:15 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)) 23:25:15 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)) 23:25:15 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)) 23:25:15 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)) 23:25:15 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)) 23:25:15 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)) 23:25:15 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)) 23:25:15 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)) 23:25:15 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)) 23:25:15 INFO - Cleaning up... 23:25:15 INFO - Return code: 0 23:25:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:25:15 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')]} 23:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:25:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:15 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')]} 23:25:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:25:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:15 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 0x103ffca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104002570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa161c928c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ea0d30>, '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 0x103cc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e97b20>, '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.lQq1M8Clxe/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.Wl9SPVdJWv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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 23:25:15 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 23:25:15 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 23:25:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lQq1M8Clxe/Render', 23:25:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:25:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:25:15 INFO - 'HOME': '/Users/cltbld', 23:25:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:25:15 INFO - 'LOGNAME': 'cltbld', 23:25:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:25:15 INFO - 'MOZ_NO_REMOTE': '1', 23:25:15 INFO - 'NO_EM_RESTART': '1', 23:25:15 INFO - 'PAGER': '/bin/cat', 23:25:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:25:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:25:15 INFO - 'PWD': '/builds/slave/test', 23:25:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:25:15 INFO - 'SHELL': '/bin/bash', 23:25:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wl9SPVdJWv/Listeners', 23:25:15 INFO - 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', 23:25:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:25:15 INFO - 'USER': 'cltbld', 23:25:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:25:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:25:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:25:15 INFO - 'XPC_FLAGS': '0x0', 23:25:15 INFO - 'XPC_SERVICE_NAME': '0', 23:25:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:25:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:25:16 INFO - Downloading/unpacking jsonschema 23:25:16 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 23:25:16 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 23:25:16 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 23:25:16 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 23:25:16 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 23:25:16 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 23:25:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:25:18 INFO - Downloading/unpacking functools32 (from jsonschema) 23:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:19 INFO - Downloading functools32-3.2.3-2.tar.gz 23:25:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:25:19 INFO - warning: no files found matching '*.txt' 23:25:19 INFO - no previously-included directories found matching 'build' 23:25:19 INFO - no previously-included directories found matching 'dist' 23:25:19 INFO - no previously-included directories found matching '.git*' 23:25:19 INFO - Installing collected packages: jsonschema, functools32 23:25:19 INFO - Running setup.py install for functools32 23:25:19 INFO - warning: no files found matching '*.txt' 23:25:19 INFO - no previously-included directories found matching 'build' 23:25:19 INFO - no previously-included directories found matching 'dist' 23:25:19 INFO - no previously-included directories found matching '.git*' 23:25:19 INFO - Successfully installed jsonschema functools32 23:25:19 INFO - Cleaning up... 23:25:19 INFO - Return code: 0 23:25:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:25:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:25:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:19 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 0x103ffca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104002570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa161c928c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ea0d30>, '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 0x103cc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e97b20>, '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.lQq1M8Clxe/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.Wl9SPVdJWv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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 23:25:19 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 23:25:19 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 23:25:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lQq1M8Clxe/Render', 23:25:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:25:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:25:19 INFO - 'HOME': '/Users/cltbld', 23:25:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:25:19 INFO - 'LOGNAME': 'cltbld', 23:25:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:25:19 INFO - 'MOZ_NO_REMOTE': '1', 23:25:19 INFO - 'NO_EM_RESTART': '1', 23:25:19 INFO - 'PAGER': '/bin/cat', 23:25:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:25:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:25:19 INFO - 'PWD': '/builds/slave/test', 23:25:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:25:19 INFO - 'SHELL': '/bin/bash', 23:25:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wl9SPVdJWv/Listeners', 23:25:19 INFO - 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', 23:25:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:25:19 INFO - 'USER': 'cltbld', 23:25:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:25:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:25:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:25:19 INFO - 'XPC_FLAGS': '0x0', 23:25:19 INFO - 'XPC_SERVICE_NAME': '0', 23:25:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:25:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:25:19 INFO - Downloading/unpacking flake8 23:25:19 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 23:25:19 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 23:25:19 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 23:25:19 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 23:25:19 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 23:25:19 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 23:25:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:25:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:25:22 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 23:25:22 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 23:25:22 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 23:25:22 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 23:25:22 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 23:25:22 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 23:25:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:25:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:25:22 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 23:25:22 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 23:25:22 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 23:25:22 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 23:25:22 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 23:25:22 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 23:25:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:25:22 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 23:25:22 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 23:25:22 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 23:25:22 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 23:25:22 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 23:25:22 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 23:25:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:25:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:25:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:25:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:25:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:25:23 INFO - no previously-included directories found matching 'docs/_build' 23:25:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:25:23 INFO - Running setup.py install for pep8 23:25:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:25:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:25:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:25:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:25:23 INFO - no previously-included directories found matching 'docs/_build' 23:25:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:25:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:25:23 INFO - Cleaning up... 23:25:23 INFO - Return code: 0 23:25:23 INFO - Running post-action listener: _resource_record_post_action 23:25:23 INFO - Running post-action listener: _start_resource_monitoring 23:25:23 INFO - Starting resource monitoring. 23:25:23 INFO - ##### 23:25:23 INFO - ##### Finished create-virtualenv step (success) 23:25:23 INFO - ##### 23:25:23 INFO - ##### 23:25:23 INFO - ##### Running install step. 23:25:23 INFO - ##### 23:25:23 INFO - Running pre-action listener: _resource_record_pre_action 23:25:23 INFO - Running main action method: install 23:25:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:25:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:25:23 INFO - Reading from file tmpfile_stdout 23:25:23 INFO - Detecting whether we're running mozinstall >=1.0... 23:25:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:25:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:25:24 INFO - Reading from file tmpfile_stdout 23:25:24 INFO - Output received: 23:25:24 INFO - Usage: mozinstall [options] installer 23:25:24 INFO - Options: 23:25:24 INFO - -h, --help show this help message and exit 23:25:24 INFO - -d DEST, --destination=DEST 23:25:24 INFO - Directory to install application into. [default: 23:25:24 INFO - "/builds/slave/test"] 23:25:24 INFO - --app=APP Application being installed. [default: firefox] 23:25:24 INFO - mkdir: /builds/slave/test/build/application 23:25:24 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'] 23:25:24 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 23:25:58 INFO - Reading from file tmpfile_stdout 23:25:58 INFO - Output received: 23:25:58 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 23:25:58 INFO - Running post-action listener: _resource_record_post_action 23:25:58 INFO - ##### 23:25:58 INFO - ##### Finished install step (success) 23:25:58 INFO - ##### 23:25:58 INFO - ##### 23:25:58 INFO - ##### Running run-tests step. 23:25:58 INFO - ##### 23:25:58 INFO - Running pre-action listener: _resource_record_pre_action 23:25:58 INFO - Running main action method: run_tests 23:25:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:25:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:25:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:25:58 INFO - 2016-05-25 23:25:58.018 screenresolution[1651:9413] starting screenresolution argv=screenresolution get 23:25:58 INFO - 2016-05-25 23:25:58.021 screenresolution[1651:9413] Display 0: 1600x1200x32@60 23:25:58 INFO - 2016-05-25 23:25:58.027 screenresolution[1652:9416] starting screenresolution argv=screenresolution list 23:25:58 INFO - Available Modes on Display 0 23:25:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:25:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:25:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:25:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:25:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:25:58 INFO - Intel Iris: 23:25:58 INFO - Chipset Model: Intel Iris 23:25:58 INFO - Type: GPU 23:25:58 INFO - Bus: Built-In 23:25:58 INFO - VRAM (Dynamic, Max): 1536 MB 23:25:58 INFO - Vendor: Intel (0x8086) 23:25:58 INFO - Device ID: 0x0a2e 23:25:58 INFO - Revision ID: 0x0009 23:25:58 INFO - Displays: 23:25:58 INFO - Display: 23:25:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:25:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:25:58 INFO - Display Serial Number: 1600x1200 60 23:25:58 INFO - Main Display: Yes 23:25:58 INFO - Mirror: Off 23:25:58 INFO - Online: Yes 23:25:58 INFO - Rotation: Supported 23:25:58 INFO - Return code: 0 23:25:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:25:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:25:58 INFO - Python 2.7.3 23:25:58 INFO - Return code: 0 23:25:58 INFO - grabbing minidump binary from tooltool 23:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:58 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 0x103ea0d30>, '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 0x103cc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e97b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:25:58 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 23:25:58 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 23:25:58 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 23:25:58 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:25:58 INFO - Return code: 0 23:25:58 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 23:25:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:25:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:25:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 23:25:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:25:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:25:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:25:59 INFO - Return code: 0 23:25:59 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/R7anaQXgTwKgFY0a0bDjjA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0168', '--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 23:25:59 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/R7anaQXgTwKgFY0a0bDjjA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0168 --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 23:25:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lQq1M8Clxe/Render', 23:25:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:25:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:25:59 INFO - 'HOME': '/Users/cltbld', 23:25:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:25:59 INFO - 'LOGNAME': 'cltbld', 23:25:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:25:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 23:25:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:25:59 INFO - 'MOZ_NO_REMOTE': '1', 23:25:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:25:59 INFO - 'NO_EM_RESTART': '1', 23:25:59 INFO - 'PAGER': '/bin/cat', 23:25:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:25:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:25:59 INFO - 'PWD': '/builds/slave/test', 23:25:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:25:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:25:59 INFO - 'SHELL': '/bin/bash', 23:25:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wl9SPVdJWv/Listeners', 23:25:59 INFO - 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', 23:25:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:25:59 INFO - 'USER': 'cltbld', 23:25:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:25:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:25:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:25:59 INFO - 'XPC_FLAGS': '0x0', 23:25:59 INFO - 'XPC_SERVICE_NAME': '0', 23:25:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:25:59 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/R7anaQXgTwKgFY0a0bDjjA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0168', '--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 23:25:59 INFO - mozversion application_buildid: 20160525204851 23:25:59 INFO - mozversion application_changeset: 25566a14a7ac98674bfe9b6e73edc59fcc286c22 23:25:59 INFO - mozversion application_display_name: Nightly 23:25:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:25:59 INFO - mozversion application_name: Firefox 23:25:59 INFO - mozversion application_remotingname: firefox 23:25:59 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:25:59 INFO - mozversion application_vendor: Mozilla 23:25:59 INFO - mozversion application_version: 49.0a1 23:25:59 INFO - mozversion platform_buildid: 20160525204851 23:25:59 INFO - mozversion platform_changeset: 25566a14a7ac98674bfe9b6e73edc59fcc286c22 23:25:59 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:25:59 INFO - mozversion platform_version: 49.0a1 23:25:59 INFO - using testdate: 1464243959 23:25:59 INFO - actual date: 1464243959 23:25:59 INFO - starting webserver on 'localhost:49275' 23:25:59 INFO - SUITE-START | Running 2 tests 23:25:59 INFO - TEST-START | dromaeo_css 23:25:59 INFO - operating with platform_type : mac_ 23:25:59 INFO - Initialising browser for dromaeo_css test... 23:25:59 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/tmpwsKIYo/profile http://localhost:49275/getInfo.html) 23:26:02 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 23:26:02 INFO - PROCESS | 1670 | colorDepth:24 23:26:02 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 23:26:02 INFO - PROCESS | 1670 | __metrics 23:26:02 ERROR - PROCESS | 1670 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 23:26:03 INFO - TEST-INFO | 1670: exit 0 23:26:03 INFO - Browser initialized. 23:26:03 INFO - Running cycle 1/1 for dromaeo_css test... 23:26:03 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/tmpwsKIYo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:26:15 INFO - PROCESS | 1674 | RSS: Main: 252211200 23:26:15 INFO - PROCESS | 1674 | 23:27:05 INFO - PROCESS | 1674 | 1464244025272 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] 23:29:17 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 23:29:18 INFO - PROCESS | 1674 | RSS: Main: 265097216 23:29:18 INFO - PROCESS | 1674 | 23:32:20 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 23:32:21 INFO - PROCESS | 1674 | RSS: Main: 275746816 23:32:21 INFO - PROCESS | 1674 | 23:35:23 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 23:35:23 INFO - PROCESS | 1674 | RSS: Main: 277487616 23:35:23 INFO - PROCESS | 1674 | 23:38:25 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 23:38:26 INFO - PROCESS | 1674 | RSS: Main: 279252992 23:38:26 INFO - PROCESS | 1674 | 23:41:29 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 23:41:29 INFO - PROCESS | 1674 | RSS: Main: 282120192 23:41:29 INFO - PROCESS | 1674 | 23:44:32 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 23:44:32 INFO - PROCESS | 1674 | RSS: Main: 283103232 23:44:32 INFO - PROCESS | 1674 | 23:44:32 INFO - PROCESS | 1674 | __start_tp_report 23:44:32 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 23:44:32 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 23:44:32 INFO - PROCESS | 1674 | |i|pagename|runs| 23:44:32 INFO - PROCESS | 1674 | |0;dojo.html;3440.638732933042;3519.0322661268146;3533.823308834559;3575.6245594212623;3578.821058947052;5789.5368370530305;5862.765489380419;5908.231929849119;5923.17075609415;5935.554833387497;5739.799107031255;5870.61840980336;5876.559258055641;5908.113782932563;5929.970350148254;4744.098621261949;4840.9757951210195;5297.523222909937;5379;5397.62216644835;5356.38401583819;5452.509274165324;5472.50747432731;5505.779768809243;5515.779368825242;5226.05930932432;5283.101872681654;5292.761825717852;5307.973460132714;5346.652467589594;5274.446183150752;5307.336582927134;5316.494932981399;5319.468053194688;5324.041672498949;3845.9807700961596;3922.5292964844116;5316.3354580677415;5355.6251062425645;5363.436839131874;4605.792739326738;5676.460736230051;5762.538996880281;5768.97115514424;5789.131630255453;6209.813705588839;6211.81364559064;6225.937740622581;6241.375862413768;6242.937570624281;6188.10272510488;6283;6292.622442653455;6314.084457753646;6328.778492752732;5199.610029247821;5969.791057313017;5992.250968628921;6019.608725432833;6026.7890623828835;6434.581752186093;6490.4807615390655;6495.350464953467;6500.349965003462;6506.739730410731;6126.120738204466;6168.136460895478;6232.971559692691;6241.812745617639;6257.311695713468;6196.504279657616;6294.65379404128;6327.3988971047675;6334.651594162366;6341.207349081365;6136.6011209271255;6183.196184496077;6224.906626400608;6262.499000079983;6277.466415354655;5904.114382842522;6151.507879369639;6154.415330543591;6189.8452538686;6235.657038862815;4914.115459217303;4944.629152813553;4972.105021096238;4994.90010199794;5032.295478632921;4410.2282100632265;4430.512225024153;4450.421445212167;4465.910681786346;4521.005378816655;5900.734466948998;5955.493783028404;5962.22491076166;5987.820365389045;6008.188894499274;6220.564560480723;6257.1240026395435;6264.561480696399;6264.874702505925;6291.182146320949;5098.872528186825;5431.131019036935;5753.280839895013;5977.731002104916;6035.426634469718;4885.706857588556;5366.651167674088;5452.6455780374945;5473.589480788957;5482.314710661168;6516.818077563545;6542;6553.606783593;6580.341965803382;6600.471962243009;6274.717637706405;6284.874302514016;6290.182276304051;6306.9684651576445;6313.116163736989;5335.733213339395;5355.866103347447;5698.971505142447;6398.456131228898;6399.200099987502;6175.4532442747095;6249.906251406142;6263.060540918898;6266.185395898504;6275.717592708431;5069.746512674278;6188;6287.339829317856;6334.619922804646;6350.841228969312;6112.602680825732;6146.678464130234;6183.072539119168;6196.597221180609;6249.812505624838;6250.499960003098;6255.437010669061;6261.3112557617715;6270.623762574261;6275.246970363585;6036.154938308552;6043.395660433922;6121.204243448323;6132.877342453036;6212.192414986203;6169.660668663267;6195.473384762346;6196.442320191204;6239.220097487814;6244.594101383395;6119.4798442132915;6151.9384806151365;6171.691415429121;6172.012478003498;6183.072539119168 23:44:32 INFO - PROCESS | 1674 | |1;ext.html;491.6116268148163;502.4422890591443;523.8637954131924;539.1050855579739;552.207582119658;31253;34656;39756;39803.800980995125;39928.40107398388;40133.197336053265;40158.799206004005;41014.58985410153;41091;41116.17767644645;8252.339812814991;9325.300602454809;9592.616295348213;9613.327067105305;9622.855657165148;9406.341556091076;9516.429014259133;9519.476428796414;9522.238220942343;9544.141027307542;8775.736727898142;8814.64741410346;9459.574319155654;9595.904040959605;9643.324967252294;9437.858432123523;9529.380590261646;9529.666461673844;9545.570449329796;9569.712908612753;8293.709720159766;9451.432914025181;9467.147956683932;9481.762955926088;9495.097965693249;31460.685393146003;38122.61877381218;38661;38686.613133868865;38788.612113878786;2885.1633026422314;2959.215807810932;3005.173577266269;3265.2489927316615;3309.7848639838335;26807.46385072307;27900;28166.85916570404;28777.136685899455;28820.567691484644;2551.4259291659414;2650.363912660967;2682.6512553368134;2696.8786404611837;2930.6043684102588;497108;500283;502188;504177.47911260574;507401;54409.1838622421;63485;64490.35509644937;64717.35282647207;64798.352016480174;34519;34806.47790283148;35321;36636.633633663325;36645.26709465849;16540.503784886474;16665.666686666198;16742;16763.832361676472;16791.2443940023;12785.552505662443;12844;12904.419301131471;12921.741565168644;12935.611931642066;19409.926278169045;19459.4162175135;19562.90218548898;19596.608067838562;19618.803811961698;6671.633060181736;7830.2952734254195;7842.9215707842195;7976.760697179094;8088.757337279891;907.8184363127401;944.6127087893931;968.4867020479157;999.0658734083655;1038.9636362727267;23463.88268058649;24182.758172418402;24526.223880300822;29283.85358073196;29472.96844610428;1034.9741256468649;1066.088494337346;1069.2675517270695;1092.9617463388743;1112.6662001399548;14407.495737649131;14942.40230390794;14989.475368362055;15186.46847360337;15807.972481788647;576383;691353;699803;701758;706837;58930.41069589335;59680.10479842806;59847.40152598418;59851.60593576208;60093.39906600965;1389.666480044782;1412.2867951684334;1446.5371081253898;1446.7106578684095;1448.8478709735537;24880.875595621907;27735.445291094467;28642.713572864006;28783.856080719463;29212.415751685272;50188.247176291654;50558;50911;50914.74542627263;51052.48947510626;575108;577881;578731.1063444824;581244;584546;25940.740592594586;26115.477690445703;26318.21045368642;26344;26815.865920670272;44850;45014.77492612516;45560;45914.540854591025;46299;28436.715632844236;36902.8154859224;37048.629513704516;37961.81019094887;38220;31728;36691.63308366882;36829.815850920575;37177.44233836549;37592.43611345887;30212.5468117974;33166.33667326592;36824.81587592045;37546.436803448516;39552;29183.124506264845;30957.226069348446;32374.35251295008;32898.62131347976;33152;24008.51982960296;24359.269221923372;24600.507989840462;25015.87492062528;25163.87418062898 23:44:32 INFO - PROCESS | 1674 | |2;jquery.html;325.5637445822598;377.83941824724485;386.3817891373802;392.725092435295;400.7375169264133;19243.4104530515;19648.21407143714;20328.491787705316;20435.18259269631;20468.99999999998;20236;20806.47983800406;21167.364979050613;21320.786792132076;21392.25127120551;5260.8158714445;5836.9124463133085;6020.939790602081;6054.364291749369;6061.636301821883;5951.702414879261;5978.282606087276;5996.790112346069;6008.068749343837;6067.514598832083;5570.916436253439;5926.496247818941;5938.88122237555;5981.700914954256;6024.668643224621;5939.910901336483;5994.46049855513;6195.783147589836;6539.444147247442;6755.9324406755795;5901.439363260483;5920.407959204088;5927.318358388754;5939.70301484924;5947.762089516415;22426.102955881746;24450.510989780283;25299.494010119877;25889.611655825178;26209.73790262092;1892.9810701892943;2064.7522297324417;2087.4676957375923;2221.8777967211795;2246.0117548278704;9949.154321882648;9979.950100249453;10060.24548158891;10194.745131371701;10253.179745620333;1759.1468137953082;1769.2070410061972;1776.1740790532335;1800.3788692900928;1819.1995521970423;100690;102166;103093;119194;129225.70774292231;11122.110231181648;11281.94359028216;11319.434028298718;11452.54189832414;11688.889555492215;14389.208593527457;14456.638584035483;14504.782428263585;14523;14565.271736413137;6620.536562440583;8323.95838020806;8356.707515236938;8366.916330836613;8472.788180295418;8048.5170889746805;8087.110417854032;8103.230193131643;8190.426670133033;8219.342452603778;4594.310853371954;4601.5168407317415;4613.331066995334;4617.561331673553;4643.071385722869;1686;1939.1370839976357;1954.8142926421967;1980.6632872411724;1986.5828176082896;868.6351732272461;921.7326975177124;927.638221093774;933.705882646964;953.6280850468323;19525;19698.31055913036;20284.087216075313;20322.796772032387;20349.898250508948;775.5230533222028;789.2344425906862;798.1340245833336;881.9813115851202;940.7365937537501;7820.960895195488;8204.261616454429;9684.370515916444;9699.563519641633;10658.840117398246;483170;523313.3834330804;592511;606565;607129;136014;141118;143487.5651243495;143898.2805085968;147165;878.6468837989553;974.5370948799264;1029.1406675426103;1091.6397588795678;1092.595739576362;17837.554061148574;17865.553361166076;17959.461216163538;17995.640087198444;18235.726464103314;36749;37986.810065949496;48501.75749121232;52627.473725263786;54348.64128396664;76145.61927190328;76762.23237767551;76800.46399071875;77243.84134238103;77376.6131169363;7945.404094692805;8044.074931382966;8053.194680532134;8093.028836539653;8419.789505262417;10278.948605256926;11820.290782553075;12300.938495307466;12474.18917770342;12709.682257943625;10763.838542422027;10876.945615271872;10890.183236257153;10929;11071.280366776457;10562.630307939186;10665.040146386862;10832.945835270773;10942;11076.390798505838;11050.834237486604;11214.607488737855;11271;11294.322340659586;11432.256903301259;6875.7937261882225;7211.2428195038765;7258.564486130849;7319.194888562361;8358.45670031446;8305.086440491421;10894.891051089387;11026.062784663394;11192.720181995515;11281 23:44:32 INFO - PROCESS | 1674 | |3;mootools.html;1565.3347327385861;1595.0987691954044;1779.3950056980625;1870.494966359084;1908.7995760445144;7968.920310796891;8508.957455212723;8547.487150770958;9011.324150688692;9037.18665320121;8632.39573229874;8683.609237584307;8828.07305232951;8839.513826739527;8857.601407936641;2144.4638840289927;2265.796078352948;2368.7275963264274;2371.703537057868;2397.760223977597;2195.6157672407344;2216.7007453993665;2364.207990323244;2385.1651921827397;2411.4574220800355;2375.58427275227;2392.102961389479;2393.5930891748358;2416.4079800448912;2419.7538267792015;2353.9293821185393;2363.775441333071;2366.822488313375;2374.4538756086113;2401.4716762312437;2353.917612883558;2365.160368069345;2381.833271670984;2382.225776622587;2396.0775101586014;8812.911870881273;8840.911590884138;8877.33419993503;8936;8971;5249.396319423277;5369.785208591691;5374.838754837361;5411.756470958816;5415.350157981067;3395.3888300105973;3515.490253913194;3543.4861945018088;3594.8202589870402;3608.0799396154075;786.1156199275815;939.746268507506;994.472929347447;1014.4268488304158;1033.62272770439;11153.609623663133;11489.770204595945;11525.135614828921;11647.534098636044;11736.178467507192;4558.680892337571;4601.769911504478;4637.443506779141;4648.279516674921;4687.929681054787;9142.268618510503;9208.309376796633;9218.58516366765;9228.538573071319;9231.723048308562;4459.9331010034875;4596.839110631112;4889.975550122226;5204.661696989683;5278.630495865253;4317.460317460317;4714.811407543729;4844.975775121173;4888.535589119028;4896.706197628154;3784.545854497423;3835.7314987950576;3885.6502914737807;3935.4293627423863;3968.6031396860085;1175.1773758369177;1184.8341232227494;1190.4999900042003;1201.7536405036947;1208.6011616166643;770.3529035610114;851.2594043182347;909.4725059465494;909.6952520905571;944.9227880216558;4817.975910120497;5636.0982242841765;5807.738651760681;5881.500796755047;6088.482478989247;965.3725078698761;970.6942313171328;1021.7037059252882;1035.6582327831798;1081.0810810810906;3562.109472631842;3884.8251828667776;3949.624785645359;4016.1566071124807;4039.6768258539246;10538.420386878643;10558.630447934285;10737.731556711145;10870.347779133119;10934.015938565568;10591.735206619896;10700;10818.026377625894;10844.728881778019;10854.945725271324;8074.273315401642;8214.219649133323;8221.835563288701;8223.259906608433;8272.586370681562;4723.409573803275;5539.639923404966;5713.400092990176;5719.456651618089;5814.127880817911;9559.904400955902;9567;9721.951390243003;10051.597936082475;10074.798504030025;9610.471424071744;9971.800563988825;9994.800103997733;10219;10227.386356818615;7953.204679532;8005.199480051948;8237.011558613005;8253.711120111007;8301;8396.916030839859;8441.15588441151;8448.324134069137;8462.873056904275;8490.957545212234;7322.231165727735;7482.738104166546;7512.436567257369;7520.435967302365;7562.659680314289;7296.96351518239;7374.446916481178;7383.926160738324;7472.327490525879;7480.027596412431;6908.1019467470915;7012.439004879496;7056.894146587702;7063.611501367269;7079.469039821931;4666.92999605013;4821.421429428351;4832.589229915497;4922.212446008764;5121.206213036985;4841.273808928548;4934.062528119646;5009.974950125226;5019.422766381766;5099.413567439644 23:44:32 INFO - PROCESS | 1674 | |4;prototype.html;281.0472498230997;284.9358894248793;320.49042023183137;322.9375355081781;326.29845831462336;5606.887862242757;5613.186088017235;5642.7178641067885;5667.376588575254;5715.142728590714;5344.465553444663;5426.538744206747;5560.332760068797;5588.497035266825;5638.492535671789;3580.785152890822;3778.4143457763953;3955.7428767130186;3967.2065586882595;4217.873463796076;3472.531208286887;3967.8809635710977;4033.0925541753018;4086.734362266458;4203.642690371322;3693.1874987502706;4204.390363397306;4261.424707664472;4280.657547396217;4298.161858437606;3569.7501174917766;3995.7402768819934;4297.001894119249;4310.719803212781;4321.222180007598;3243.8540265687866;3361.3781450431748;3482.4253998090285;3743.9438408423894;3748.475213470116;4677.853925788204;5263.499967503081;5421.150982802215;5455.345358556959;5471.890562188773;4150.792460376969;4174.478190226222;4706.482286948433;4803.591694705954;4999.4250661174065;4879;5332.253484512172;5838;5845.444682755132;5857.414258574108;3676.448532720087;4141.316682747343;4141.4409054777525;4157.625813676784;4164.6251837334485;5258.842234732964;5860.882782344329;5873.882522349529;6203.441690247854;6287.779927702509;3872.954302338353;3887.5918028607157;4153.7300075494995;4155.4182414462;4223.036288126036;3511.7892926424497;4093.263212621697;4253.914921701548;4258.5954334338185;4279.507856596531;4567.885802854955;4781.163296423181;4927.975360123248;4944.035912996931;4984.950150498521;5965.224520812267;5986.311574168939;5995.400459953969;5998.760049597967;5998.86021655884;1266.006185144657;1328.3623860546797;1354.6003928841017;1392.1716578635696;1410.22437659287;899.4827973914894;913.7350168451208;915.7545737796592;919.7424721078108;973.9220862330997;5367.570594352443;5477.096279113981;5485.588580856452;5497.835064948058;5522.696251706195;4733.408323959505;5515.531179849758;5763.366029736726;5984.371640977634;6032.758689652364;5106.336176297058;5132.820351287687;5141.76862041209;5154.623721462448;5501.4223506532035;2980.210244285266;3008.729214370673;3138.356636889432;3151.4800057990174;3168.8415579220946;5398.9472052949295;5960.284765828042;6146.754129834757;6328.493720502349;6332.398422149889;4919.827806026772;4992;5100.362454693163;6106.297775755845;6214.223222097238;5662.433756624305;6007.399260074132;6288.213973253343;6329.936700632935;6376.585521941059;4754.548317909793;4904.435989861212;5402.35171779389;6004.519638429003;6014.9097763534455;5022.372203474566;5468.425815289337;5930.492825452773;5964.850878728066;5973.731182096729;5115.488451154854;5136.5377116059735;6078.635281883101;6288.182536270256;6302.621842689453;3702.4631428443263;3769.9434508481845;4066.816993235371;4074.246264441088;4090.2433049885867;5259.89480210386;5831.475167234969;6088.36072212429;6198.1012753149635;6242.438180563771;4878.829240976549;5082.491750824888;5618.353889302783;5944.256967879015;5960.225170727777;5492.395836457907;5887.735051922588;5905.320888097924;5914.556408269483;5959.28488581373;4694.882627934329;5360.973195133999;5538.363088244742;5853.824385268449;5877.23595932526;5208.609354298367;5845.649261044351;5951.910721339097;6014.188084608697;6021.42796434338;5386.461353864583;5832.941670583409;5872.297033860304;5885.558583106199;5911.600829523128 23:44:32 INFO - PROCESS | 1674 | |5;yui.html;651.3942033908469;654.1692051095109;731.9268073192679;751.5903832411335;758.268271118371;14749.262536873153;14964;15116.773248401283;15329.69340613187;15383.07701537907;14086.436542538286;14191.361388737505;14290;14301.998860079799;14332.355044023017;582.4292193650225;880.0407555764216;890.8886389201334;907.1382186922417;913.1234015345276;790.8892755014302;822.4037572759731;864.8486514859906;882.563131250029;883.2624758326805;924.9768755781092;926.8980412154658;928.1971095002841;928.3176865004217;928.642472648032;900.8738776571286;909.1136142261308;910.1035480052143;920.1810388754014;922.2667978956712;672.6031641331589;681.608075356667;685.6434653979952;688.9483288753363;690.6650274616857;12360.320182389965;14705.26473676312;14805.259737013106;14918.2540872957;14962;10774.125766183835;10975.231733778639;12198.573049943298;12794.936025319907;12894.032947528973;8575.699850505265;8925.464472131627;9542;9573.712788616353;9638;3343.378461446221;3480.112571294329;3485.268093700326;3498.7900725956524;3577.069961809948;80998;85187.5740621293;85220.99999999937;86860.95986640437;86989.56505217434;8932.687355942511;9400.670976515788;9420.387674801115;9500.809983800285;9575.377600455948;19951.401457956286;20675.379738607866;20720.79279207219;20731;20787.96060196984;7110.1823290321245;7119.537230080028;7145.464090193256;7186.92813071873;7340.009098771598;3898.7465814721954;3949.8025098744947;3949.861754838567;3963.524377074712;3989.082511022481;2812.85935703214;3397.5583174187195;3403.1151900506047;3415.214500664861;3418.3163367326633;609.0346800321452;610.124471383566;615.5444970721724;620.1039497925544;627.6673363117555;481.8747125747331;518.3831240823408;546.8386825886373;582.7144699097412;584.9356570777211;7173.713051477883;7988.520688758693;8080;8088.514689118671;8244.381671374671;570.0480198069234;580.51236960953;587.9235699359056;595.8867815115115;617.0251003414684;3216.694414030663;3818.9809050955123;3858.382658774639;3873.24471728016;3889.105505733697;91090;92346.07653923509;93025;96140.51929740446;96311;79801.20198798054;80825;81062;81890.59054704689;83984;71308.64345678239;72511;73412.79761607267;73528.63235683787;73728.26271737322;7068.29317068289;7593.8860917087395;7639.197884222077;7670;7677.5777332245025;40869.79565102155;44995.550044499134;45352;45362.546374535836;45364.77317613391;54461;56367.8726425461;56567.43432565621;57474;60160.69919650374;10851.945740271249;11015.83476247841;11034.448277586249;11274.267172633752;11402;10651.147908167482;11574.6527604172;11930.880691192977;12091.274523528617;12250.326232057323;9370.39092458988;11488.54045838157;11549.076073914235;11598.246114002563;11815.172937894265;8594.398392112493;10988.725281868017;11054.281471704313;11145.777084458428;11350.318980860844;11240.156988225752;11341.036011939077;11415.885841141482;11468.598599048993;11643.76712465729;7919.802004949923;8066.7579972600915;9492.430454172496;9514.33399662017;9871.259655526008;9312.34813563044;9977.900220997697;9981.101700846959;9999.15007224365;10009.349392289478 23:44:32 INFO - PROCESS | 1674 | __end_tp_report 23:44:32 INFO - PROCESS | 1674 | __start_cc_report 23:44:32 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,426 23:44:32 INFO - PROCESS | 1674 | __end_cc_report 23:44:32 INFO - PROCESS | 1674 | __startTimestamp1464245072671__endTimestamp 23:44:32 INFO - PROCESS | 1674 | 23:44:32 INFO - PROCESS | 1674 | ------- Summary: start ------- 23:44:32 INFO - PROCESS | 1674 | Number of tests: 6 23:44:32 INFO - PROCESS | 1674 | 23:44:32 INFO - PROCESS | 1674 | [#0] dojo.html Cycles:165 Average:5787.18 Median:6112.60 stddev:684.39 (11.2%) stddev-sans-first:661.27 23:44:32 INFO - PROCESS | 1674 | Values: 3440.6 3519.0 3533.8 3575.6 3578.8 5789.5 5862.8 5908.2 5923.2 5935.6 5739.8 5870.6 5876.6 5908.1 5930.0 4744.1 4841.0 5297.5 5379.0 5397.6 5356.4 5452.5 5472.5 5505.8 5515.8 5226.1 5283.1 5292.8 5308.0 5346.7 5274.4 5307.3 5316.5 5319.5 5324.0 3846.0 3922.5 5316.3 5355.6 5363.4 4605.8 5676.5 5762.5 5769.0 5789.1 6209.8 6211.8 6225.9 6241.4 6242.9 6188.1 6283.0 6292.6 6314.1 6328.8 5199.6 5969.8 5992.3 6019.6 6026.8 6434.6 6490.5 6495.4 6500.3 6506.7 6126.1 6168.1 6233.0 6241.8 6257.3 6196.5 6294.7 6327.4 6334.7 6341.2 6136.6 6183.2 6224.9 6262.5 6277.5 5904.1 6151.5 6154.4 6189.8 6235.7 4914.1 4944.6 4972.1 4994.9 5032.3 4410.2 4430.5 4450.4 4465.9 4521.0 5900.7 5955.5 5962.2 5987.8 6008.2 6220.6 6257.1 6264.6 6264.9 6291.2 5098.9 5431.1 5753.3 5977.7 6035.4 4885.7 5366.7 5452.6 5473.6 5482.3 6516.8 6542.0 6553.6 6580.3 6600.5 6274.7 6284.9 6290.2 6307.0 6313.1 5335.7 5355.9 5699.0 6398.5 6399.2 6175.5 6249.9 6263.1 6266.2 6275.7 5069.7 6188.0 6287.3 6334.6 6350.8 6112.6 6146.7 6183.1 6196.6 6249.8 6250.5 6255.4 6261.3 6270.6 6275.2 6036.2 6043.4 6121.2 6132.9 6212.2 6169.7 6195.5 6196.4 6239.2 6244.6 6119.5 6151.9 6171.7 6172.0 6183.1 23:44:32 INFO - PROCESS | 1674 | 23:44:32 INFO - PROCESS | 1674 | [#1] ext.html Cycles:180 Average:70171.88 Median:37777.12 stddev:158292.75 (419.0%) stddev-sans-first:158650.35 23:44:32 INFO - PROCESS | 1674 | Values: 491.6 502.4 523.9 539.1 552.2 31253.0 34656.0 39756.0 39803.8 39928.4 40133.2 40158.8 41014.6 41091.0 41116.2 8252.3 9325.3 9592.6 9613.3 9622.9 9406.3 9516.4 9519.5 9522.2 9544.1 8775.7 8814.6 9459.6 9595.9 9643.3 9437.9 9529.4 9529.7 9545.6 9569.7 8293.7 9451.4 9467.1 9481.8 9495.1 31460.7 38122.6 38661.0 38686.6 38788.6 2885.2 2959.2 3005.2 3265.2 3309.8 26807.5 27900.0 28166.9 28777.1 28820.6 2551.4 2650.4 2682.7 2696.9 2930.6 497108.0 500283.0 502188.0 504177.5 507401.0 54409.2 63485.0 64490.4 64717.4 64798.4 34519.0 34806.5 35321.0 36636.6 36645.3 16540.5 16665.7 16742.0 16763.8 16791.2 12785.6 12844.0 12904.4 12921.7 12935.6 19409.9 19459.4 19562.9 19596.6 19618.8 6671.6 7830.3 7842.9 7976.8 8088.8 907.8 944.6 968.5 999.1 1039.0 23463.9 24182.8 24526.2 29283.9 29473.0 1035.0 1066.1 1069.3 1093.0 1112.7 14407.5 14942.4 14989.5 15186.5 15808.0 576383.0 691353.0 699803.0 701758.0 706837.0 58930.4 59680.1 59847.4 59851.6 60093.4 1389.7 1412.3 1446.5 1446.7 1448.8 24880.9 27735.4 28642.7 28783.9 29212.4 50188.2 50558.0 50911.0 50914.7 51052.5 575108.0 577881.0 578731.1 581244.0 584546.0 25940.7 26115.5 26318.2 26344.0 26815.9 44850.0 45014.8 45560.0 45914.5 46299.0 28436.7 36902.8 37048.6 37961.8 38220.0 31728.0 36691.6 36829.8 37177.4 37592.4 30212.5 33166.3 36824.8 37546.4 39552.0 29183.1 30957.2 32374.4 32898.6 33152.0 24008.5 24359.3 24600.5 25015.9 25163.9 23:44:32 INFO - PROCESS | 1674 | 23:44:32 INFO - PROCESS | 1674 | [#2] jquery.html Cycles:180 Average:33841.95 Median:13267.65 stddev:94887.05 (715.2%) stddev-sans-first:95119.86 23:44:32 INFO - PROCESS | 1674 | Values: 325.6 377.8 386.4 392.7 400.7 19243.4 19648.2 20328.5 20435.2 20469.0 20236.0 20806.5 21167.4 21320.8 21392.3 5260.8 5836.9 6020.9 6054.4 6061.6 5951.7 5978.3 5996.8 6008.1 6067.5 5570.9 5926.5 5938.9 5981.7 6024.7 5939.9 5994.5 6195.8 6539.4 6755.9 5901.4 5920.4 5927.3 5939.7 5947.8 22426.1 24450.5 25299.5 25889.6 26209.7 1893.0 2064.8 2087.5 2221.9 2246.0 9949.2 9980.0 10060.2 10194.7 10253.2 1759.1 1769.2 1776.2 1800.4 1819.2 100690.0 102166.0 103093.0 119194.0 129225.7 11122.1 11281.9 11319.4 11452.5 11688.9 14389.2 14456.6 14504.8 14523.0 14565.3 6620.5 8324.0 8356.7 8366.9 8472.8 8048.5 8087.1 8103.2 8190.4 8219.3 4594.3 4601.5 4613.3 4617.6 4643.1 1686.0 1939.1 1954.8 1980.7 1986.6 868.6 921.7 927.6 933.7 953.6 19525.0 19698.3 20284.1 20322.8 20349.9 775.5 789.2 798.1 882.0 940.7 7821.0 8204.3 9684.4 9699.6 10658.8 483170.0 523313.4 592511.0 606565.0 607129.0 136014.0 141118.0 143487.6 143898.3 147165.0 878.6 974.5 1029.1 1091.6 1092.6 17837.6 17865.6 17959.5 17995.6 18235.7 36749.0 37986.8 48501.8 52627.5 54348.6 76145.6 76762.2 76800.5 77243.8 77376.6 7945.4 8044.1 8053.2 8093.0 8419.8 10278.9 11820.3 12300.9 12474.2 12709.7 10763.8 10876.9 10890.2 10929.0 11071.3 10562.6 10665.0 10832.9 10942.0 11076.4 11050.8 11214.6 11271.0 11294.3 11432.3 6875.8 7211.2 7258.6 7319.2 8358.5 8305.1 10894.9 11026.1 11192.7 11281.0 23:44:32 INFO - PROCESS | 1674 | 23:44:32 INFO - PROCESS | 1674 | [#3] mootools.html Cycles:180 Average:5679.18 Median:4889.26 stddev:3188.77 (65.2%) stddev-sans-first:3182.73 23:44:32 INFO - PROCESS | 1674 | Values: 1565.3 1595.1 1779.4 1870.5 1908.8 7968.9 8509.0 8547.5 9011.3 9037.2 8632.4 8683.6 8828.1 8839.5 8857.6 2144.5 2265.8 2368.7 2371.7 2397.8 2195.6 2216.7 2364.2 2385.2 2411.5 2375.6 2392.1 2393.6 2416.4 2419.8 2353.9 2363.8 2366.8 2374.5 2401.5 2353.9 2365.2 2381.8 2382.2 2396.1 8812.9 8840.9 8877.3 8936.0 8971.0 5249.4 5369.8 5374.8 5411.8 5415.4 3395.4 3515.5 3543.5 3594.8 3608.1 786.1 939.7 994.5 1014.4 1033.6 11153.6 11489.8 11525.1 11647.5 11736.2 4558.7 4601.8 4637.4 4648.3 4687.9 9142.3 9208.3 9218.6 9228.5 9231.7 4459.9 4596.8 4890.0 5204.7 5278.6 4317.5 4714.8 4845.0 4888.5 4896.7 3784.5 3835.7 3885.7 3935.4 3968.6 1175.2 1184.8 1190.5 1201.8 1208.6 770.4 851.3 909.5 909.7 944.9 4818.0 5636.1 5807.7 5881.5 6088.5 965.4 970.7 1021.7 1035.7 1081.1 3562.1 3884.8 3949.6 4016.2 4039.7 10538.4 10558.6 10737.7 10870.3 10934.0 10591.7 10700.0 10818.0 10844.7 10854.9 8074.3 8214.2 8221.8 8223.3 8272.6 4723.4 5539.6 5713.4 5719.5 5814.1 9559.9 9567.0 9722.0 10051.6 10074.8 9610.5 9971.8 9994.8 10219.0 10227.4 7953.2 8005.2 8237.0 8253.7 8301.0 8396.9 8441.2 8448.3 8462.9 8491.0 7322.2 7482.7 7512.4 7520.4 7562.7 7297.0 7374.4 7383.9 7472.3 7480.0 6908.1 7012.4 7056.9 7063.6 7079.5 4666.9 4821.4 4832.6 4922.2 5121.2 4841.3 4934.1 5010.0 5019.4 5099.4 23:44:32 INFO - PROCESS | 1674 | 23:44:32 INFO - PROCESS | 1674 | [#4] prototype.html Cycles:180 Average:4716.04 Median:5261.70 stddev:1460.89 (27.8%) stddev-sans-first:1426.56 23:44:32 INFO - PROCESS | 1674 | Values: 281.0 284.9 320.5 322.9 326.3 5606.9 5613.2 5642.7 5667.4 5715.1 5344.5 5426.5 5560.3 5588.5 5638.5 3580.8 3778.4 3955.7 3967.2 4217.9 3472.5 3967.9 4033.1 4086.7 4203.6 3693.2 4204.4 4261.4 4280.7 4298.2 3569.8 3995.7 4297.0 4310.7 4321.2 3243.9 3361.4 3482.4 3743.9 3748.5 4677.9 5263.5 5421.2 5455.3 5471.9 4150.8 4174.5 4706.5 4803.6 4999.4 4879.0 5332.3 5838.0 5845.4 5857.4 3676.4 4141.3 4141.4 4157.6 4164.6 5258.8 5860.9 5873.9 6203.4 6287.8 3873.0 3887.6 4153.7 4155.4 4223.0 3511.8 4093.3 4253.9 4258.6 4279.5 4567.9 4781.2 4928.0 4944.0 4985.0 5965.2 5986.3 5995.4 5998.8 5998.9 1266.0 1328.4 1354.6 1392.2 1410.2 899.5 913.7 915.8 919.7 973.9 5367.6 5477.1 5485.6 5497.8 5522.7 4733.4 5515.5 5763.4 5984.4 6032.8 5106.3 5132.8 5141.8 5154.6 5501.4 2980.2 3008.7 3138.4 3151.5 3168.8 5398.9 5960.3 6146.8 6328.5 6332.4 4919.8 4992.0 5100.4 6106.3 6214.2 5662.4 6007.4 6288.2 6329.9 6376.6 4754.5 4904.4 5402.4 6004.5 6014.9 5022.4 5468.4 5930.5 5964.9 5973.7 5115.5 5136.5 6078.6 6288.2 6302.6 3702.5 3769.9 4066.8 4074.2 4090.2 5259.9 5831.5 6088.4 6198.1 6242.4 4878.8 5082.5 5618.4 5944.3 5960.2 5492.4 5887.7 5905.3 5914.6 5959.3 4694.9 5361.0 5538.4 5853.8 5877.2 5208.6 5845.6 5951.9 6014.2 6021.4 5386.5 5832.9 5872.3 5885.6 5911.6 23:44:32 INFO - PROCESS | 1674 | 23:44:32 INFO - PROCESS | 1674 | [#5] yui.html Cycles:180 Average:18001.47 Median:612.83 stddev:25878.85 (4222.8%) stddev-sans-first:25918.66 23:44:32 INFO - PROCESS | 1674 | Values: 651.4 654.2 731.9 751.6 758.3 14749.3 14964.0 15116.8 15329.7 15383.1 14086.4 14191.4 14290.0 14302.0 14332.4 582.4 880.0 890.9 907.1 913.1 790.9 822.4 864.8 882.6 883.3 925.0 926.9 928.2 928.3 928.6 900.9 909.1 910.1 920.2 922.3 672.6 681.6 685.6 688.9 690.7 12360.3 14705.3 14805.3 14918.3 14962.0 10774.1 10975.2 12198.6 12794.9 12894.0 8575.7 8925.5 9542.0 9573.7 9638.0 3343.4 3480.1 3485.3 3498.8 3577.1 80998.0 85187.6 85221.0 86861.0 86989.6 8932.7 9400.7 9420.4 9500.8 9575.4 19951.4 20675.4 20720.8 20731.0 20788.0 7110.2 7119.5 7145.5 7186.9 7340.0 3898.7 3949.8 3949.9 3963.5 3989.1 2812.9 3397.6 3403.1 3415.2 3418.3 609.0 610.1 615.5 620.1 627.7 481.9 518.4 546.8 582.7 584.9 7173.7 7988.5 8080.0 8088.5 8244.4 570.0 580.5 587.9 595.9 617.0 3216.7 3819.0 3858.4 3873.2 3889.1 91090.0 92346.1 93025.0 96140.5 96311.0 79801.2 80825.0 81062.0 81890.6 83984.0 71308.6 72511.0 73412.8 73528.6 73728.3 7068.3 7593.9 7639.2 7670.0 7677.6 40869.8 44995.6 45352.0 45362.5 45364.8 54461.0 56367.9 56567.4 57474.0 60160.7 10851.9 11015.8 11034.4 11274.3 11402.0 10651.1 11574.7 11930.9 12091.3 12250.3 9370.4 11488.5 11549.1 11598.2 11815.2 8594.4 10988.7 11054.3 11145.8 11350.3 11240.2 11341.0 11415.9 11468.6 11643.8 7919.8 8066.8 9492.4 9514.3 9871.3 9312.3 9977.9 9981.1 9999.2 10009.3 23:44:32 INFO - PROCESS | 1674 | -------- Summary: end -------- 23:44:32 INFO - PROCESS | 1674 | 23:44:33 INFO - TEST-INFO | 1674: exit 0 23:44:33 INFO - TEST-OK | dromaeo_css | took 1113537ms 23:44:33 INFO - TEST-START | kraken 23:44:33 INFO - operating with platform_type : mac_ 23:44:33 INFO - Initialising browser for kraken test... 23:44:33 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/tmpVPzAo4/profile http://localhost:49275/getInfo.html) 23:44:36 INFO - PROCESS | 1682 | __metrics Screen width/height:1600/1200 23:44:36 INFO - PROCESS | 1682 | colorDepth:24 23:44:36 INFO - PROCESS | 1682 | Browser inner width/height: 1024/689 23:44:36 INFO - PROCESS | 1682 | __metrics 23:44:36 ERROR - PROCESS | 1682 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 23:44:36 INFO - TEST-INFO | 1682: exit 0 23:44:36 INFO - Browser initialized. 23:44:36 INFO - Running cycle 1/1 for kraken test... 23:44:36 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/tmpVPzAo4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:44:48 INFO - PROCESS | 1684 | RSS: Main: 252104704 23:44:48 INFO - PROCESS | 1684 | 23:44:51 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 23:44:52 INFO - PROCESS | 1684 | RSS: Main: 263946240 23:44:52 INFO - PROCESS | 1684 | 23:44:55 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 23:44:56 INFO - PROCESS | 1684 | RSS: Main: 268595200 23:44:56 INFO - PROCESS | 1684 | 23:44:59 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 23:45:00 INFO - PROCESS | 1684 | RSS: Main: 268877824 23:45:00 INFO - PROCESS | 1684 | 23:45:02 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 23:45:02 INFO - PROCESS | 1684 | RSS: Main: 269524992 23:45:02 INFO - PROCESS | 1684 | 23:45:04 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:45:05 INFO - PROCESS | 1684 | RSS: Main: 270196736 23:45:05 INFO - PROCESS | 1684 | 23:45:08 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 23:45:08 INFO - PROCESS | 1684 | RSS: Main: 270524416 23:45:08 INFO - PROCESS | 1684 | 23:45:11 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 23:45:12 INFO - PROCESS | 1684 | RSS: Main: 270630912 23:45:12 INFO - PROCESS | 1684 | 23:45:15 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 23:45:16 INFO - PROCESS | 1684 | RSS: Main: 270827520 23:45:16 INFO - PROCESS | 1684 | 23:45:17 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:45:18 INFO - PROCESS | 1684 | RSS: Main: 270520320 23:45:18 INFO - PROCESS | 1684 | 23:45:20 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:45:21 INFO - PROCESS | 1684 | RSS: Main: 270430208 23:45:21 INFO - PROCESS | 1684 | 23:45:23 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:45:24 INFO - PROCESS | 1684 | RSS: Main: 270651392 23:45:24 INFO - PROCESS | 1684 | 23:45:26 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:45:27 INFO - PROCESS | 1684 | RSS: Main: 270667776 23:45:27 INFO - PROCESS | 1684 | 23:45:30 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:45:31 INFO - PROCESS | 1684 | RSS: Main: 270614528 23:45:31 INFO - PROCESS | 1684 | 23:45:33 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 23:45:33 INFO - PROCESS | 1684 | RSS: Main: 272240640 23:45:33 INFO - PROCESS | 1684 | 23:45:33 INFO - PROCESS | 1684 | __start_tp_report 23:45:33 INFO - PROCESS | 1684 | _x_x_mozilla_page_load 23:45:33 INFO - PROCESS | 1684 | _x_x_mozilla_page_load_details 23:45:33 INFO - PROCESS | 1684 | |i|pagename|runs| 23:45:33 INFO - PROCESS | 1684 | |0;ai-astar;116;121;166;117;174;173;155;118;116;115 23:45:33 INFO - PROCESS | 1684 | |1;audio-beat-detection;165;124;145;161;119;152;140;120;170;122 23:45:33 INFO - PROCESS | 1684 | |2;audio-dft;199;204;213;278;272;197;205;199;201;198 23:45:33 INFO - PROCESS | 1684 | |3;audio-fft;69;82;73;146;57;57;59;61;133;59 23:45:33 INFO - PROCESS | 1684 | |4;audio-oscillator;69;77;120;72;74;72;113;71;73;110 23:45:33 INFO - PROCESS | 1684 | |5;imaging-gaussian-blur;92;125;89;88;91;86;90;87;90;90 23:45:33 INFO - PROCESS | 1684 | |6;imaging-darkroom;96;96;96;97;119;95;95;104;96;101 23:45:33 INFO - PROCESS | 1684 | |7;imaging-desaturate;148;144;116;145;150;98;155;146;115;91 23:45:33 INFO - PROCESS | 1684 | |8;json-parse-financial;59;61;64;90;89;90;91;97;96;60 23:45:33 INFO - PROCESS | 1684 | |9;json-stringify-tinderbox;69;71;76;70;78;77;73;69;72;74 23:45:33 INFO - PROCESS | 1684 | |10;stanford-crypto-aes;89;89;92;89;94;87;89;92;91;100 23:45:33 INFO - PROCESS | 1684 | |11;stanford-crypto-ccm;159;153;129;150;138;147;149;154;169;144 23:45:33 INFO - PROCESS | 1684 | |12;stanford-crypto-pbkdf2;167;193;230;188;166;232;180;182;229;169 23:45:33 INFO - PROCESS | 1684 | |13;stanford-crypto-sha256-iterative;66;65;70;85;91;87;79;68;66;67 23:45:33 INFO - PROCESS | 1684 | __end_tp_report 23:45:33 INFO - PROCESS | 1684 | __start_cc_report 23:45:33 INFO - PROCESS | 1684 | _x_x_mozilla_cycle_collect,1102 23:45:33 INFO - PROCESS | 1684 | __end_cc_report 23:45:33 INFO - PROCESS | 1684 | __startTimestamp1464245133330__endTimestamp 23:45:33 INFO - PROCESS | 1684 | 23:45:33 INFO - PROCESS | 1684 | ------- Summary: start ------- 23:45:33 INFO - PROCESS | 1684 | Number of tests: 14 23:45:33 INFO - PROCESS | 1684 | 23:45:33 INFO - PROCESS | 1684 | [#0] ai-astar Cycles:10 Average:137.10 Median:138.00 stddev:26.27 (19.0%) stddev-sans-first:26.74 23:45:33 INFO - PROCESS | 1684 | Values: 116.0 121.0 166.0 117.0 174.0 173.0 155.0 118.0 116.0 115.0 23:45:33 INFO - PROCESS | 1684 | 23:45:33 INFO - PROCESS | 1684 | [#1] audio-beat-detection Cycles:10 Average:141.80 Median:148.50 stddev:19.79 (13.3%) stddev-sans-first:19.12 23:45:33 INFO - PROCESS | 1684 | Values: 165.0 124.0 145.0 161.0 119.0 152.0 140.0 120.0 170.0 122.0 23:45:33 INFO - PROCESS | 1684 | 23:45:33 INFO - PROCESS | 1684 | [#2] audio-dft Cycles:10 Average:216.60 Median:204.50 stddev:31.16 (15.2%) stddev-sans-first:32.39 23:45:33 INFO - PROCESS | 1684 | Values: 199.0 204.0 213.0 278.0 272.0 197.0 205.0 199.0 201.0 198.0 23:45:33 INFO - PROCESS | 1684 | 23:45:33 INFO - PROCESS | 1684 | [#3] audio-fft Cycles:10 Average:79.60 Median:60.00 stddev:32.73 (54.5%) stddev-sans-first:34.48 23:45:33 INFO - PROCESS | 1684 | Values: 69.0 82.0 73.0 146.0 57.0 57.0 59.0 61.0 133.0 59.0 23:45:33 INFO - PROCESS | 1684 | 23:45:33 INFO - PROCESS | 1684 | [#4] audio-oscillator Cycles:10 Average:85.10 Median:72.00 stddev:20.42 (28.4%) stddev-sans-first:20.81 23:45:33 INFO - PROCESS | 1684 | Values: 69.0 77.0 120.0 72.0 74.0 72.0 113.0 71.0 73.0 110.0 23:45:33 INFO - PROCESS | 1684 | 23:45:33 INFO - PROCESS | 1684 | [#5] imaging-gaussian-blur Cycles:10 Average:92.80 Median:90.00 stddev:11.46 (12.7%) stddev-sans-first:12.15 23:45:33 INFO - PROCESS | 1684 | Values: 92.0 125.0 89.0 88.0 91.0 86.0 90.0 87.0 90.0 90.0 23:45:33 INFO - PROCESS | 1684 | 23:45:33 INFO - PROCESS | 1684 | [#6] imaging-darkroom Cycles:10 Average:99.50 Median:96.00 stddev:7.44 (7.8%) stddev-sans-first:7.79 23:45:33 INFO - PROCESS | 1684 | Values: 96.0 96.0 96.0 97.0 119.0 95.0 95.0 104.0 96.0 101.0 23:45:33 INFO - PROCESS | 1684 | 23:45:33 INFO - PROCESS | 1684 | [#7] imaging-desaturate Cycles:10 Average:130.80 Median:149.00 stddev:23.54 (15.8%) stddev-sans-first:24.13 23:45:33 INFO - PROCESS | 1684 | Values: 148.0 144.0 116.0 145.0 150.0 98.0 155.0 146.0 115.0 91.0 23:45:33 INFO - PROCESS | 1684 | 23:45:33 INFO - PROCESS | 1684 | [#8] json-parse-financial Cycles:10 Average:79.70 Median:90.00 stddev:16.34 (18.2%) stddev-sans-first:15.52 23:45:33 INFO - PROCESS | 1684 | Values: 59.0 61.0 64.0 90.0 89.0 90.0 91.0 97.0 96.0 60.0 23:45:33 INFO - PROCESS | 1684 | 23:45:33 INFO - PROCESS | 1684 | [#9] json-stringify-tinderbox Cycles:10 Average:72.90 Median:73.50 stddev:3.28 (4.5%) stddev-sans-first:3.16 23:45:33 INFO - PROCESS | 1684 | Values: 69.0 71.0 76.0 70.0 78.0 77.0 73.0 69.0 72.0 74.0 23:45:33 INFO - PROCESS | 1684 | 23:45:33 INFO - PROCESS | 1684 | [#10] stanford-crypto-aes Cycles:10 Average:91.20 Median:90.00 stddev:3.71 (4.1%) stddev-sans-first:3.84 23:45:33 INFO - PROCESS | 1684 | Values: 89.0 89.0 92.0 89.0 94.0 87.0 89.0 92.0 91.0 100.0 23:45:33 INFO - PROCESS | 1684 | 23:45:33 INFO - PROCESS | 1684 | [#11] stanford-crypto-ccm Cycles:10 Average:149.20 Median:151.50 stddev:11.01 (7.3%) stddev-sans-first:11.10 23:45:33 INFO - PROCESS | 1684 | Values: 159.0 153.0 129.0 150.0 138.0 147.0 149.0 154.0 169.0 144.0 23:45:33 INFO - PROCESS | 1684 | 23:45:33 INFO - PROCESS | 1684 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.60 Median:190.50 stddev:26.83 (14.1%) stddev-sans-first:26.67 23:45:33 INFO - PROCESS | 1684 | Values: 167.0 193.0 230.0 188.0 166.0 232.0 180.0 182.0 229.0 169.0 23:45:33 INFO - PROCESS | 1684 | 23:45:33 INFO - PROCESS | 1684 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.40 Median:74.50 stddev:10.07 (13.5%) stddev-sans-first:10.21 23:45:33 INFO - PROCESS | 1684 | Values: 66.0 65.0 70.0 85.0 91.0 87.0 79.0 68.0 66.0 67.0 23:45:33 INFO - PROCESS | 1684 | -------- Summary: end -------- 23:45:33 INFO - PROCESS | 1684 | 23:45:34 INFO - TEST-INFO | 1684: exit 0 23:45:34 INFO - TEST-OK | kraken | took 60849ms 23:45:34 INFO - SUITE-END | took 1174s 23:45:34 INFO - Completed test suite (00:19:34) 23:45:34 INFO - javascript benchmark 23:45:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7147.549814083699, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3440.638732933042, 3519.0322661268146, 3533.823308834559, 3575.6245594212623, 3578.821058947052, 5789.5368370530305, 5862.765489380419, 5908.231929849119, 5923.17075609415, 5935.554833387497, 5739.799107031255, 5870.61840980336, 5876.559258055641, 5908.113782932563, 5929.970350148254, 4744.098621261949, 4840.9757951210195, 5297.523222909937, 5379.0, 5397.62216644835, 5356.38401583819, 5452.509274165324, 5472.50747432731, 5505.779768809243, 5515.779368825242, 5226.05930932432, 5283.101872681654, 5292.761825717852, 5307.973460132714, 5346.652467589594, 5274.446183150752, 5307.336582927134, 5316.494932981399, 5319.468053194688, 5324.041672498949, 3845.9807700961596, 3922.5292964844116, 5316.3354580677415, 5355.6251062425645, 5363.436839131874, 4605.792739326738, 5676.460736230051, 5762.538996880281, 5768.97115514424, 5789.131630255453, 6209.813705588839, 6211.81364559064, 6225.937740622581, 6241.375862413768, 6242.937570624281, 6188.10272510488, 6283.0, 6292.622442653455, 6314.084457753646, 6328.778492752732, 5199.610029247821, 5969.791057313017, 5992.250968628921, 6019.608725432833, 6026.7890623828835, 6434.581752186093, 6490.4807615390655, 6495.350464953467, 6500.349965003462, 6506.739730410731, 6126.120738204466, 6168.136460895478, 6232.971559692691, 6241.812745617639, 6257.311695713468, 6196.504279657616, 6294.65379404128, 6327.3988971047675, 6334.651594162366, 6341.207349081365, 6136.6011209271255, 6183.196184496077, 6224.906626400608, 6262.499000079983, 6277.466415354655, 5904.114382842522, 6151.507879369639, 6154.415330543591, 6189.8452538686, 6235.657038862815, 4914.115459217303, 4944.629152813553, 4972.105021096238, 4994.90010199794, 5032.295478632921, 4410.2282100632265, 4430.512225024153, 4450.421445212167, 4465.910681786346, 4521.005378816655, 5900.734466948998, 5955.493783028404, 5962.22491076166, 5987.820365389045, 6008.188894499274, 6220.564560480723, 6257.1240026395435, 6264.561480696399, 6264.874702505925, 6291.182146320949, 5098.872528186825, 5431.131019036935, 5753.280839895013, 5977.731002104916, 6035.426634469718, 4885.706857588556, 5366.651167674088, 5452.6455780374945, 5473.589480788957, 5482.314710661168, 6516.818077563545, 6542.0, 6553.606783593, 6580.341965803382, 6600.471962243009, 6274.717637706405, 6284.874302514016, 6290.182276304051, 6306.9684651576445, 6313.116163736989, 5335.733213339395, 5355.866103347447, 5698.971505142447, 6398.456131228898, 6399.200099987502, 6175.4532442747095, 6249.906251406142, 6263.060540918898, 6266.185395898504, 6275.717592708431, 5069.746512674278, 6188.0, 6287.339829317856, 6334.619922804646, 6350.841228969312, 6112.602680825732, 6146.678464130234, 6183.072539119168, 6196.597221180609, 6249.812505624838, 6250.499960003098, 6255.437010669061, 6261.3112557617715, 6270.623762574261, 6275.246970363585, 6036.154938308552, 6043.395660433922, 6121.204243448323, 6132.877342453036, 6212.192414986203, 6169.660668663267, 6195.473384762346, 6196.442320191204, 6239.220097487814, 6244.594101383395, 6119.4798442132915, 6151.9384806151365, 6171.691415429121, 6172.012478003498, 6183.072539119168], "value": 5745.285571252442, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [491.6116268148163, 502.4422890591443, 523.8637954131924, 539.1050855579739, 552.207582119658, 31253.0, 34656.0, 39756.0, 39803.800980995125, 39928.40107398388, 40133.197336053265, 40158.799206004005, 41014.58985410153, 41091.0, 41116.17767644645, 8252.339812814991, 9325.300602454809, 9592.616295348213, 9613.327067105305, 9622.855657165148, 9406.341556091076, 9516.429014259133, 9519.476428796414, 9522.238220942343, 9544.141027307542, 8775.736727898142, 8814.64741410346, 9459.574319155654, 9595.904040959605, 9643.324967252294, 9437.858432123523, 9529.380590261646, 9529.666461673844, 9545.570449329796, 9569.712908612753, 8293.709720159766, 9451.432914025181, 9467.147956683932, 9481.762955926088, 9495.097965693249, 31460.685393146003, 38122.61877381218, 38661.0, 38686.613133868865, 38788.612113878786, 2885.1633026422314, 2959.215807810932, 3005.173577266269, 3265.2489927316615, 3309.7848639838335, 26807.46385072307, 27900.0, 28166.85916570404, 28777.136685899455, 28820.567691484644, 2551.4259291659414, 2650.363912660967, 2682.6512553368134, 2696.8786404611837, 2930.6043684102588, 497108.0, 500283.0, 502188.0, 504177.47911260574, 507401.0, 54409.1838622421, 63485.0, 64490.35509644937, 64717.35282647207, 64798.352016480174, 34519.0, 34806.47790283148, 35321.0, 36636.633633663325, 36645.26709465849, 16540.503784886474, 16665.666686666198, 16742.0, 16763.832361676472, 16791.2443940023, 12785.552505662443, 12844.0, 12904.419301131471, 12921.741565168644, 12935.611931642066, 19409.926278169045, 19459.4162175135, 19562.90218548898, 19596.608067838562, 19618.803811961698, 6671.633060181736, 7830.2952734254195, 7842.9215707842195, 7976.760697179094, 8088.757337279891, 907.8184363127401, 944.6127087893931, 968.4867020479157, 999.0658734083655, 1038.9636362727267, 23463.88268058649, 24182.758172418402, 24526.223880300822, 29283.85358073196, 29472.96844610428, 1034.9741256468649, 1066.088494337346, 1069.2675517270695, 1092.9617463388743, 1112.6662001399548, 14407.495737649131, 14942.40230390794, 14989.475368362055, 15186.46847360337, 15807.972481788647, 576383.0, 691353.0, 699803.0, 701758.0, 706837.0, 58930.41069589335, 59680.10479842806, 59847.40152598418, 59851.60593576208, 60093.39906600965, 1389.666480044782, 1412.2867951684334, 1446.5371081253898, 1446.7106578684095, 1448.8478709735537, 24880.875595621907, 27735.445291094467, 28642.713572864006, 28783.856080719463, 29212.415751685272, 50188.247176291654, 50558.0, 50911.0, 50914.74542627263, 51052.48947510626, 575108.0, 577881.0, 578731.1063444824, 581244.0, 584546.0, 25940.740592594586, 26115.477690445703, 26318.21045368642, 26344.0, 26815.865920670272, 44850.0, 45014.77492612516, 45560.0, 45914.540854591025, 46299.0, 28436.715632844236, 36902.8154859224, 37048.629513704516, 37961.81019094887, 38220.0, 31728.0, 36691.63308366882, 36829.815850920575, 37177.44233836549, 37592.43611345887, 30212.5468117974, 33166.33667326592, 36824.81587592045, 37546.436803448516, 39552.0, 29183.124506264845, 30957.226069348446, 32374.35251295008, 32898.62131347976, 33152.0, 24008.51982960296, 24359.269221923372, 24600.507989840462, 25015.87492062528, 25163.87418062898], "value": 19162.892117436786, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.5637445822598, 377.83941824724485, 386.3817891373802, 392.725092435295, 400.7375169264133, 19243.4104530515, 19648.21407143714, 20328.491787705316, 20435.18259269631, 20468.99999999998, 20236.0, 20806.47983800406, 21167.364979050613, 21320.786792132076, 21392.25127120551, 5260.8158714445, 5836.9124463133085, 6020.939790602081, 6054.364291749369, 6061.636301821883, 5951.702414879261, 5978.282606087276, 5996.790112346069, 6008.068749343837, 6067.514598832083, 5570.916436253439, 5926.496247818941, 5938.88122237555, 5981.700914954256, 6024.668643224621, 5939.910901336483, 5994.46049855513, 6195.783147589836, 6539.444147247442, 6755.9324406755795, 5901.439363260483, 5920.407959204088, 5927.318358388754, 5939.70301484924, 5947.762089516415, 22426.102955881746, 24450.510989780283, 25299.494010119877, 25889.611655825178, 26209.73790262092, 1892.9810701892943, 2064.7522297324417, 2087.4676957375923, 2221.8777967211795, 2246.0117548278704, 9949.154321882648, 9979.950100249453, 10060.24548158891, 10194.745131371701, 10253.179745620333, 1759.1468137953082, 1769.2070410061972, 1776.1740790532335, 1800.3788692900928, 1819.1995521970423, 100690.0, 102166.0, 103093.0, 119194.0, 129225.70774292231, 11122.110231181648, 11281.94359028216, 11319.434028298718, 11452.54189832414, 11688.889555492215, 14389.208593527457, 14456.638584035483, 14504.782428263585, 14523.0, 14565.271736413137, 6620.536562440583, 8323.95838020806, 8356.707515236938, 8366.916330836613, 8472.788180295418, 8048.5170889746805, 8087.110417854032, 8103.230193131643, 8190.426670133033, 8219.342452603778, 4594.310853371954, 4601.5168407317415, 4613.331066995334, 4617.561331673553, 4643.071385722869, 1686.0, 1939.1370839976357, 1954.8142926421967, 1980.6632872411724, 1986.5828176082896, 868.6351732272461, 921.7326975177124, 927.638221093774, 933.705882646964, 953.6280850468323, 19525.0, 19698.31055913036, 20284.087216075313, 20322.796772032387, 20349.898250508948, 775.5230533222028, 789.2344425906862, 798.1340245833336, 881.9813115851202, 940.7365937537501, 7820.960895195488, 8204.261616454429, 9684.370515916444, 9699.563519641633, 10658.840117398246, 483170.0, 523313.3834330804, 592511.0, 606565.0, 607129.0, 136014.0, 141118.0, 143487.5651243495, 143898.2805085968, 147165.0, 878.6468837989553, 974.5370948799264, 1029.1406675426103, 1091.6397588795678, 1092.595739576362, 17837.554061148574, 17865.553361166076, 17959.461216163538, 17995.640087198444, 18235.726464103314, 36749.0, 37986.810065949496, 48501.75749121232, 52627.473725263786, 54348.64128396664, 76145.61927190328, 76762.23237767551, 76800.46399071875, 77243.84134238103, 77376.6131169363, 7945.404094692805, 8044.074931382966, 8053.194680532134, 8093.028836539653, 8419.789505262417, 10278.948605256926, 11820.290782553075, 12300.938495307466, 12474.18917770342, 12709.682257943625, 10763.838542422027, 10876.945615271872, 10890.183236257153, 10929.0, 11071.280366776457, 10562.630307939186, 10665.040146386862, 10832.945835270773, 10942.0, 11076.390798505838, 11050.834237486604, 11214.607488737855, 11271.0, 11294.322340659586, 11432.256903301259, 6875.7937261882225, 7211.2428195038765, 7258.564486130849, 7319.194888562361, 8358.45670031446, 8305.086440491421, 10894.891051089387, 11026.062784663394, 11192.720181995515, 11281.0], "value": 9350.539606818686, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1565.3347327385861, 1595.0987691954044, 1779.3950056980625, 1870.494966359084, 1908.7995760445144, 7968.920310796891, 8508.957455212723, 8547.487150770958, 9011.324150688692, 9037.18665320121, 8632.39573229874, 8683.609237584307, 8828.07305232951, 8839.513826739527, 8857.601407936641, 2144.4638840289927, 2265.796078352948, 2368.7275963264274, 2371.703537057868, 2397.760223977597, 2195.6157672407344, 2216.7007453993665, 2364.207990323244, 2385.1651921827397, 2411.4574220800355, 2375.58427275227, 2392.102961389479, 2393.5930891748358, 2416.4079800448912, 2419.7538267792015, 2353.9293821185393, 2363.775441333071, 2366.822488313375, 2374.4538756086113, 2401.4716762312437, 2353.917612883558, 2365.160368069345, 2381.833271670984, 2382.225776622587, 2396.0775101586014, 8812.911870881273, 8840.911590884138, 8877.33419993503, 8936.0, 8971.0, 5249.396319423277, 5369.785208591691, 5374.838754837361, 5411.756470958816, 5415.350157981067, 3395.3888300105973, 3515.490253913194, 3543.4861945018088, 3594.8202589870402, 3608.0799396154075, 786.1156199275815, 939.746268507506, 994.472929347447, 1014.4268488304158, 1033.62272770439, 11153.609623663133, 11489.770204595945, 11525.135614828921, 11647.534098636044, 11736.178467507192, 4558.680892337571, 4601.769911504478, 4637.443506779141, 4648.279516674921, 4687.929681054787, 9142.268618510503, 9208.309376796633, 9218.58516366765, 9228.538573071319, 9231.723048308562, 4459.9331010034875, 4596.839110631112, 4889.975550122226, 5204.661696989683, 5278.630495865253, 4317.460317460317, 4714.811407543729, 4844.975775121173, 4888.535589119028, 4896.706197628154, 3784.545854497423, 3835.7314987950576, 3885.6502914737807, 3935.4293627423863, 3968.6031396860085, 1175.1773758369177, 1184.8341232227494, 1190.4999900042003, 1201.7536405036947, 1208.6011616166643, 770.3529035610114, 851.2594043182347, 909.4725059465494, 909.6952520905571, 944.9227880216558, 4817.975910120497, 5636.0982242841765, 5807.738651760681, 5881.500796755047, 6088.482478989247, 965.3725078698761, 970.6942313171328, 1021.7037059252882, 1035.6582327831798, 1081.0810810810906, 3562.109472631842, 3884.8251828667776, 3949.624785645359, 4016.1566071124807, 4039.6768258539246, 10538.420386878643, 10558.630447934285, 10737.731556711145, 10870.347779133119, 10934.015938565568, 10591.735206619896, 10700.0, 10818.026377625894, 10844.728881778019, 10854.945725271324, 8074.273315401642, 8214.219649133323, 8221.835563288701, 8223.259906608433, 8272.586370681562, 4723.409573803275, 5539.639923404966, 5713.400092990176, 5719.456651618089, 5814.127880817911, 9559.904400955902, 9567.0, 9721.951390243003, 10051.597936082475, 10074.798504030025, 9610.471424071744, 9971.800563988825, 9994.800103997733, 10219.0, 10227.386356818615, 7953.204679532, 8005.199480051948, 8237.011558613005, 8253.711120111007, 8301.0, 8396.916030839859, 8441.15588441151, 8448.324134069137, 8462.873056904275, 8490.957545212234, 7322.231165727735, 7482.738104166546, 7512.436567257369, 7520.435967302365, 7562.659680314289, 7296.96351518239, 7374.446916481178, 7383.926160738324, 7472.327490525879, 7480.027596412431, 6908.1019467470915, 7012.439004879496, 7056.894146587702, 7063.611501367269, 7079.469039821931, 4666.92999605013, 4821.421429428351, 4832.589229915497, 4922.212446008764, 5121.206213036985, 4841.273808928548, 4934.062528119646, 5009.974950125226, 5019.422766381766, 5099.413567439644], "value": 4558.5152936956765, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [281.0472498230997, 284.9358894248793, 320.49042023183137, 322.9375355081781, 326.29845831462336, 5606.887862242757, 5613.186088017235, 5642.7178641067885, 5667.376588575254, 5715.142728590714, 5344.465553444663, 5426.538744206747, 5560.332760068797, 5588.497035266825, 5638.492535671789, 3580.785152890822, 3778.4143457763953, 3955.7428767130186, 3967.2065586882595, 4217.873463796076, 3472.531208286887, 3967.8809635710977, 4033.0925541753018, 4086.734362266458, 4203.642690371322, 3693.1874987502706, 4204.390363397306, 4261.424707664472, 4280.657547396217, 4298.161858437606, 3569.7501174917766, 3995.7402768819934, 4297.001894119249, 4310.719803212781, 4321.222180007598, 3243.8540265687866, 3361.3781450431748, 3482.4253998090285, 3743.9438408423894, 3748.475213470116, 4677.853925788204, 5263.499967503081, 5421.150982802215, 5455.345358556959, 5471.890562188773, 4150.792460376969, 4174.478190226222, 4706.482286948433, 4803.591694705954, 4999.4250661174065, 4879.0, 5332.253484512172, 5838.0, 5845.444682755132, 5857.414258574108, 3676.448532720087, 4141.316682747343, 4141.4409054777525, 4157.625813676784, 4164.6251837334485, 5258.842234732964, 5860.882782344329, 5873.882522349529, 6203.441690247854, 6287.779927702509, 3872.954302338353, 3887.5918028607157, 4153.7300075494995, 4155.4182414462, 4223.036288126036, 3511.7892926424497, 4093.263212621697, 4253.914921701548, 4258.5954334338185, 4279.507856596531, 4567.885802854955, 4781.163296423181, 4927.975360123248, 4944.035912996931, 4984.950150498521, 5965.224520812267, 5986.311574168939, 5995.400459953969, 5998.760049597967, 5998.86021655884, 1266.006185144657, 1328.3623860546797, 1354.6003928841017, 1392.1716578635696, 1410.22437659287, 899.4827973914894, 913.7350168451208, 915.7545737796592, 919.7424721078108, 973.9220862330997, 5367.570594352443, 5477.096279113981, 5485.588580856452, 5497.835064948058, 5522.696251706195, 4733.408323959505, 5515.531179849758, 5763.366029736726, 5984.371640977634, 6032.758689652364, 5106.336176297058, 5132.820351287687, 5141.76862041209, 5154.623721462448, 5501.4223506532035, 2980.210244285266, 3008.729214370673, 3138.356636889432, 3151.4800057990174, 3168.8415579220946, 5398.9472052949295, 5960.284765828042, 6146.754129834757, 6328.493720502349, 6332.398422149889, 4919.827806026772, 4992.0, 5100.362454693163, 6106.297775755845, 6214.223222097238, 5662.433756624305, 6007.399260074132, 6288.213973253343, 6329.936700632935, 6376.585521941059, 4754.548317909793, 4904.435989861212, 5402.35171779389, 6004.519638429003, 6014.9097763534455, 5022.372203474566, 5468.425815289337, 5930.492825452773, 5964.850878728066, 5973.731182096729, 5115.488451154854, 5136.5377116059735, 6078.635281883101, 6288.182536270256, 6302.621842689453, 3702.4631428443263, 3769.9434508481845, 4066.816993235371, 4074.246264441088, 4090.2433049885867, 5259.89480210386, 5831.475167234969, 6088.36072212429, 6198.1012753149635, 6242.438180563771, 4878.829240976549, 5082.491750824888, 5618.353889302783, 5944.256967879015, 5960.225170727777, 5492.395836457907, 5887.735051922588, 5905.320888097924, 5914.556408269483, 5959.28488581373, 4694.882627934329, 5360.973195133999, 5538.363088244742, 5853.824385268449, 5877.23595932526, 5208.609354298367, 5845.649261044351, 5951.910721339097, 6014.188084608697, 6021.42796434338, 5386.461353864583, 5832.941670583409, 5872.297033860304, 5885.558583106199, 5911.600829523128], "value": 4247.813602423326, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [651.3942033908469, 654.1692051095109, 731.9268073192679, 751.5903832411335, 758.268271118371, 14749.262536873153, 14964.0, 15116.773248401283, 15329.69340613187, 15383.07701537907, 14086.436542538286, 14191.361388737505, 14290.0, 14301.998860079799, 14332.355044023017, 582.4292193650225, 880.0407555764216, 890.8886389201334, 907.1382186922417, 913.1234015345276, 790.8892755014302, 822.4037572759731, 864.8486514859906, 882.563131250029, 883.2624758326805, 924.9768755781092, 926.8980412154658, 928.1971095002841, 928.3176865004217, 928.642472648032, 900.8738776571286, 909.1136142261308, 910.1035480052143, 920.1810388754014, 922.2667978956712, 672.6031641331589, 681.608075356667, 685.6434653979952, 688.9483288753363, 690.6650274616857, 12360.320182389965, 14705.26473676312, 14805.259737013106, 14918.2540872957, 14962.0, 10774.125766183835, 10975.231733778639, 12198.573049943298, 12794.936025319907, 12894.032947528973, 8575.699850505265, 8925.464472131627, 9542.0, 9573.712788616353, 9638.0, 3343.378461446221, 3480.112571294329, 3485.268093700326, 3498.7900725956524, 3577.069961809948, 80998.0, 85187.5740621293, 85220.99999999937, 86860.95986640437, 86989.56505217434, 8932.687355942511, 9400.670976515788, 9420.387674801115, 9500.809983800285, 9575.377600455948, 19951.401457956286, 20675.379738607866, 20720.79279207219, 20731.0, 20787.96060196984, 7110.1823290321245, 7119.537230080028, 7145.464090193256, 7186.92813071873, 7340.009098771598, 3898.7465814721954, 3949.8025098744947, 3949.861754838567, 3963.524377074712, 3989.082511022481, 2812.85935703214, 3397.5583174187195, 3403.1151900506047, 3415.214500664861, 3418.3163367326633, 609.0346800321452, 610.124471383566, 615.5444970721724, 620.1039497925544, 627.6673363117555, 481.8747125747331, 518.3831240823408, 546.8386825886373, 582.7144699097412, 584.9356570777211, 7173.713051477883, 7988.520688758693, 8080.0, 8088.514689118671, 8244.381671374671, 570.0480198069234, 580.51236960953, 587.9235699359056, 595.8867815115115, 617.0251003414684, 3216.694414030663, 3818.9809050955123, 3858.382658774639, 3873.24471728016, 3889.105505733697, 91090.0, 92346.07653923509, 93025.0, 96140.51929740446, 96311.0, 79801.20198798054, 80825.0, 81062.0, 81890.59054704689, 83984.0, 71308.64345678239, 72511.0, 73412.79761607267, 73528.63235683787, 73728.26271737322, 7068.29317068289, 7593.8860917087395, 7639.197884222077, 7670.0, 7677.5777332245025, 40869.79565102155, 44995.550044499134, 45352.0, 45362.546374535836, 45364.77317613391, 54461.0, 56367.8726425461, 56567.43432565621, 57474.0, 60160.69919650374, 10851.945740271249, 11015.83476247841, 11034.448277586249, 11274.267172633752, 11402.0, 10651.147908167482, 11574.6527604172, 11930.880691192977, 12091.274523528617, 12250.326232057323, 9370.39092458988, 11488.54045838157, 11549.076073914235, 11598.246114002563, 11815.172937894265, 8594.398392112493, 10988.725281868017, 11054.281471704313, 11145.777084458428, 11350.318980860844, 11240.156988225752, 11341.036011939077, 11415.885841141482, 11468.598599048993, 11643.76712465729, 7919.802004949923, 8066.7579972600915, 9492.430454172496, 9514.33399662017, 9871.259655526008, 9312.34813563044, 9977.900220997697, 9981.101700846959, 9999.15007224365, 10009.349392289478], "value": 6688.093884837912, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1644.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 121.0, 166.0, 117.0, 174.0, 173.0, 155.0, 118.0, 116.0, 115.0], "value": 137.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 124.0, 145.0, 161.0, 119.0, 152.0, 140.0, 120.0, 170.0, 122.0], "value": 141.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 204.0, 213.0, 278.0, 272.0, 197.0, 205.0, 199.0, 201.0, 198.0], "value": 216.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 82.0, 73.0, 146.0, 57.0, 57.0, 59.0, 61.0, 133.0, 59.0], "value": 79.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 77.0, 120.0, 72.0, 74.0, 72.0, 113.0, 71.0, 73.0, 110.0], "value": 85.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 125.0, 89.0, 88.0, 91.0, 86.0, 90.0, 87.0, 90.0, 90.0], "value": 92.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 97.0, 119.0, 95.0, 95.0, 104.0, 96.0, 101.0], "value": 99.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 144.0, 116.0, 145.0, 150.0, 98.0, 155.0, 146.0, 115.0, 91.0], "value": 130.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 64.0, 90.0, 89.0, 90.0, 91.0, 97.0, 96.0, 60.0], "value": 79.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 76.0, 70.0, 78.0, 77.0, 73.0, 69.0, 72.0, 74.0], "value": 72.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 92.0, 89.0, 94.0, 87.0, 89.0, 92.0, 91.0, 100.0], "value": 91.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 153.0, 129.0, 150.0, 138.0, 147.0, 149.0, 154.0, 169.0, 144.0], "value": 149.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 193.0, 230.0, 188.0, 166.0, 232.0, 180.0, 182.0, 229.0, 169.0], "value": 193.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 70.0, 85.0, 91.0, 87.0, 79.0, 68.0, 66.0, 67.0], "value": 74.4, "unit": "score"}]}]} 23:45:34 INFO - Return code: 0 23:45:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:45:34 ERROR - # TBPL SUCCESS # 23:45:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:45:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:45:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:45:34 INFO - 2016-05-25 23:45:34.640 screenresolution[1689:12079] starting screenresolution argv=screenresolution get 23:45:34 INFO - 2016-05-25 23:45:34.642 screenresolution[1689:12079] Display 0: 1600x1200x32@60 23:45:34 INFO - 2016-05-25 23:45:34.648 screenresolution[1690:12082] starting screenresolution argv=screenresolution list 23:45:34 INFO - Available Modes on Display 0 23:45:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:45:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:45:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:45:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:45:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:45:34 INFO - Intel Iris: 23:45:34 INFO - Chipset Model: Intel Iris 23:45:34 INFO - Type: GPU 23:45:34 INFO - Bus: Built-In 23:45:34 INFO - VRAM (Dynamic, Max): 1536 MB 23:45:34 INFO - Vendor: Intel (0x8086) 23:45:34 INFO - Device ID: 0x0a2e 23:45:34 INFO - Revision ID: 0x0009 23:45:34 INFO - Displays: 23:45:34 INFO - Display: 23:45:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:45:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:45:34 INFO - Display Serial Number: 1600x1200 60 23:45:34 INFO - Main Display: Yes 23:45:34 INFO - Mirror: Off 23:45:34 INFO - Online: Yes 23:45:34 INFO - Rotation: Supported 23:45:34 INFO - Return code: 0 23:45:34 INFO - Running post-action listener: _resource_record_post_action 23:45:34 INFO - ##### 23:45:34 INFO - ##### Finished run-tests step (success) 23:45:34 INFO - ##### 23:45:34 INFO - Running post-run listener: _resource_record_post_run 23:45:34 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 32243200; Write bytes: 697576960; Read time: 321; Write time: 1958 23:45:34 INFO - TinderboxPrint: CPU usage
54.3% 23:45:34 INFO - TinderboxPrint: I/O read bytes / time
32,243,200 / 321 23:45:34 INFO - TinderboxPrint: I/O write bytes / time
697,576,960 / 1,958 23:45:34 INFO - TinderboxPrint: CPU idle
2,212.4 (45.7%) 23:45:34 INFO - TinderboxPrint: CPU system
972.0 (20.1%) 23:45:34 INFO - TinderboxPrint: CPU user
1,657.2 (34.2%) 23:45:34 INFO - TinderboxPrint: Swap in / out
425,283,584 / 0 23:45:34 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 393314816; Write bytes: 388012032; Read time: 29748; Write time: 744 23:45:34 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 30453248; Write bytes: 296359424; Read time: 302; Write time: 1180 23:45:35 INFO - Running post-run listener: _upload_blobber_files 23:45:35 INFO - Blob upload gear active. 23:45:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:45:35 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 23:45:35 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'] 23:45:35 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 23:45:35 INFO - (blobuploader) - INFO - Open directory for files ... 23:45:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:45:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:45:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:45:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:45:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:45:36 INFO - (blobuploader) - INFO - Done attempting. 23:45:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:45:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:45:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:45:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:45:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:45:37 INFO - (blobuploader) - INFO - Done attempting. 23:45:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:45:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:45:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:45:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:45:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:45:40 INFO - (blobuploader) - INFO - Done attempting. 23:45:40 INFO - (blobuploader) - INFO - Iteration through files over. 23:45:40 INFO - Return code: 0 23:45:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:45:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:45:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d713d9558bfb1a4de107a546dfd882019d797de5ada2842038ba47009bd67d42bb679768642281f603b68391c626429017616a5107229591136618f888bc11dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a35d5a3d5789beea7e61c8509623c691ae0d252da7d05743a20f5e61af7ccbbc5dac634483de9d50f6f6af3927a3216c4b0ac58f3cfc6ed9b1bd65fbd6d64e0a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2d7b6a041c2ec8c0742ecd1c3f28cdcfa2013673b43da8200588802832e86172501c9f8c6013e402ab0f9628f13344478a0a78075bb9c3600f4901bdde482f8e"} 23:45:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:45:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:45:40 INFO - Contents: 23:45:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d713d9558bfb1a4de107a546dfd882019d797de5ada2842038ba47009bd67d42bb679768642281f603b68391c626429017616a5107229591136618f888bc11dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a35d5a3d5789beea7e61c8509623c691ae0d252da7d05743a20f5e61af7ccbbc5dac634483de9d50f6f6af3927a3216c4b0ac58f3cfc6ed9b1bd65fbd6d64e0a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2d7b6a041c2ec8c0742ecd1c3f28cdcfa2013673b43da8200588802832e86172501c9f8c6013e402ab0f9628f13344478a0a78075bb9c3600f4901bdde482f8e"} 23:45:40 INFO - Running post-run listener: copy_logs_to_upload_dir 23:45:40 INFO - Copying logs to upload dir... 23:45:40 INFO - mkdir: /builds/slave/test/build/upload/logs 23:45:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.733485 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-05-25 23:45:40.692456) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 23:45:40.695965) ========= 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.lQq1M8Clxe/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.Wl9SPVdJWv/Listeners TMPDIR=/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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/d713d9558bfb1a4de107a546dfd882019d797de5ada2842038ba47009bd67d42bb679768642281f603b68391c626429017616a5107229591136618f888bc11dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a35d5a3d5789beea7e61c8509623c691ae0d252da7d05743a20f5e61af7ccbbc5dac634483de9d50f6f6af3927a3216c4b0ac58f3cfc6ed9b1bd65fbd6d64e0a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2d7b6a041c2ec8c0742ecd1c3f28cdcfa2013673b43da8200588802832e86172501c9f8c6013e402ab0f9628f13344478a0a78075bb9c3600f4901bdde482f8e"} build_url:https://queue.taskcluster.net/v1/task/R7anaQXgTwKgFY0a0bDjjA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010887 build_url: 'https://queue.taskcluster.net/v1/task/R7anaQXgTwKgFY0a0bDjjA/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/d713d9558bfb1a4de107a546dfd882019d797de5ada2842038ba47009bd67d42bb679768642281f603b68391c626429017616a5107229591136618f888bc11dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a35d5a3d5789beea7e61c8509623c691ae0d252da7d05743a20f5e61af7ccbbc5dac634483de9d50f6f6af3927a3216c4b0ac58f3cfc6ed9b1bd65fbd6d64e0a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2d7b6a041c2ec8c0742ecd1c3f28cdcfa2013673b43da8200588802832e86172501c9f8c6013e402ab0f9628f13344478a0a78075bb9c3600f4901bdde482f8e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 23:45:40.726014) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 23:45:40.726335) ========= 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.lQq1M8Clxe/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.Wl9SPVdJWv/Listeners TMPDIR=/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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.004449 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 23:45:40.776249) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 23:45:40.776779) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 23:45:40.777267) ========= ========= Total master_lag: 0.35 =========