builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0103 starttime: 1457056778.45 results: success (0) buildid: 20160303170525 builduid: c8c05616def7415aafb51268e5571e0c revision: 6b7cac27bb8397f223af0ea20950f657328fbb4b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-03 17:59:38.449519) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-03 17:59:38.450325) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-03 17:59:38.450619) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1Q40tFGngv/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.TEFBDJg8Mu/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 /builds/slave/test program finished with exit code 0 elapsedTime=0.005532 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-03 17:59:38.478040) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-03 17:59:38.478697) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-03 17:59:38.496408) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 17:59:38.497094) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1Q40tFGngv/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.TEFBDJg8Mu/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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.005586 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 17:59:38.552563) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-03 17:59:38.553376) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-03 17:59:38.553877) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 17:59:38.554154) ========= 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.1Q40tFGngv/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.TEFBDJg8Mu/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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-03-03 17:59:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 38.3M=0s 2016-03-03 17:59:38 (38.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.235001 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 17:59:38.809602) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 17:59:38.810392) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1Q40tFGngv/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.TEFBDJg8Mu/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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.025340 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 17:59:38.863207) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 17:59:38.864012) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6b7cac27bb8397f223af0ea20950f657328fbb4b --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 6b7cac27bb8397f223af0ea20950f657328fbb4b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1Q40tFGngv/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.TEFBDJg8Mu/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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-03-03 17:59:38,935 truncating revision to first 12 chars 2016-03-03 17:59:38,935 Setting DEBUG logging. 2016-03-03 17:59:38,936 attempt 1/10 2016-03-03 17:59:38,936 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6b7cac27bb83?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-03 17:59:39,536 unpacking tar archive at: fx-team-6b7cac27bb83/testing/mozharness/ program finished with exit code 0 elapsedTime=0.853259 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 17:59:39.734195) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-03 17:59:39.734611) ========= echo 6b7cac27bb8397f223af0ea20950f657328fbb4b in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'6b7cac27bb8397f223af0ea20950f657328fbb4b'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1Q40tFGngv/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.TEFBDJg8Mu/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 6b7cac27bb8397f223af0ea20950f657328fbb4b program finished with exit code 0 elapsedTime=0.005292 script_repo_revision: '6b7cac27bb8397f223af0ea20950f657328fbb4b' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-03 17:59:39.790996) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-03 17:59:39.791364) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-03 17:59:39.810773) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-03-03 17:59:39.811171) ========= /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.1Q40tFGngv/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.TEFBDJg8Mu/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 17:59:39 INFO - MultiFileLogger online at 20160303 17:59:39 in /builds/slave/test 17:59:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:59:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:59:39 INFO - {'append_to_log': False, 17:59:39 INFO - 'base_work_dir': '/builds/slave/test', 17:59:39 INFO - 'blob_upload_branch': 'Fx-Team', 17:59:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:59:39 INFO - 'branch': 'Fx-Team', 17:59:39 INFO - 'buildbot_json_path': 'buildprops.json', 17:59:39 INFO - 'config_files': ('talos/mac_config.py',), 17:59:39 INFO - 'default_actions': ('clobber', 17:59:39 INFO - 'read-buildbot-config', 17:59:39 INFO - 'download-and-extract', 17:59:39 INFO - 'populate-webroot', 17:59:39 INFO - 'create-virtualenv', 17:59:39 INFO - 'install', 17:59:39 INFO - 'run-tests'), 17:59:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:59:39 INFO - 'download_minidump_stackwalk': True, 17:59:39 INFO - 'download_symbols': 'ondemand', 17:59:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:59:39 INFO - 'tooltool.py': '/tools/tooltool.py', 17:59:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:59:39 INFO - '/tools/misc-python/virtualenv.py')}, 17:59:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:59:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:59:39 INFO - 'installer_path': 'installer.exe', 17:59:39 INFO - 'log_level': 'info', 17:59:39 INFO - 'log_name': 'talos', 17:59:39 INFO - 'log_to_console': True, 17:59:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:59:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:59:39 INFO - 'opt_config_files': (), 17:59:39 INFO - 'pip_index': False, 17:59:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:59:39 INFO - 'cmd': ('bash', 17:59:39 INFO - '-c', 17:59:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:59:39 INFO - 'enabled': True, 17:59:39 INFO - 'halt_on_failure': False, 17:59:39 INFO - 'name': 'check_screen_resolution'},), 17:59:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:59:39 INFO - 'cmd': ('bash', 17:59:39 INFO - '-c', 17:59:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:59:39 INFO - 'enabled': True, 17:59:39 INFO - 'halt_on_failure': False, 17:59:39 INFO - 'name': 'check_screen_resolution'},), 17:59:39 INFO - 'run_cmd_checks_enabled': True, 17:59:39 INFO - 'sps_profile': False, 17:59:39 INFO - 'sps_profile_interval': 0, 17:59:39 INFO - 'suite': 'dromaeojs-e10s', 17:59:39 INFO - 'system_bits': '32', 17:59:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:59:39 INFO - 'title': 't-yosemite-r7-0103', 17:59:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:59:39 INFO - 'use_talos_json': True, 17:59:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:59:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:59:39 INFO - 'work_dir': 'build'} 17:59:39 INFO - ##### 17:59:39 INFO - ##### Running clobber step. 17:59:39 INFO - ##### 17:59:39 INFO - Running pre-action listener: _resource_record_pre_action 17:59:39 INFO - Running main action method: clobber 17:59:39 INFO - rmtree: /builds/slave/test/build 17:59:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:59:41 INFO - Running post-action listener: _resource_record_post_action 17:59:41 INFO - ##### 17:59:41 INFO - ##### Running read-buildbot-config step. 17:59:41 INFO - ##### 17:59:41 INFO - Running pre-action listener: _resource_record_pre_action 17:59:41 INFO - Running main action method: read_buildbot_config 17:59:41 INFO - Using buildbot properties: 17:59:41 INFO - { 17:59:41 INFO - "project": "", 17:59:41 INFO - "product": "firefox", 17:59:41 INFO - "script_repo_revision": "production", 17:59:41 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 17:59:41 INFO - "repository": "", 17:59:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 17:59:41 INFO - "buildid": "20160303170525", 17:59:41 INFO - "pgo_build": "False", 17:59:41 INFO - "basedir": "/builds/slave/test", 17:59:41 INFO - "buildnumber": 491, 17:59:41 INFO - "slavename": "t-yosemite-r7-0103", 17:59:41 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 17:59:41 INFO - "platform": "yosemite_r7", 17:59:41 INFO - "scheduler": "tests-fx-team-macosx64-talos", 17:59:41 INFO - "branch": "fx-team", 17:59:41 INFO - "repo_path": "integration/fx-team", 17:59:41 INFO - "revision": "6b7cac27bb8397f223af0ea20950f657328fbb4b", 17:59:41 INFO - "stage_platform": "macosx64", 17:59:41 INFO - "builduid": "c8c05616def7415aafb51268e5571e0c", 17:59:41 INFO - "slavebuilddir": "test" 17:59:41 INFO - } 17:59:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/LQr2uUsSQrim0ghTqQMKTg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 17:59:41 INFO - Running post-action listener: _resource_record_post_action 17:59:41 INFO - ##### 17:59:41 INFO - ##### Running download-and-extract step. 17:59:41 INFO - ##### 17:59:41 INFO - Running pre-action listener: _resource_record_pre_action 17:59:41 INFO - Running main action method: download_and_extract 17:59:41 INFO - mkdir: /builds/slave/test/build/tests 17:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:59:41 INFO - https://queue.taskcluster.net/v1/task/LQr2uUsSQrim0ghTqQMKTg/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 17:59:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQr2uUsSQrim0ghTqQMKTg/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 17:59:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQr2uUsSQrim0ghTqQMKTg/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 17:59:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQr2uUsSQrim0ghTqQMKTg/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 17:59:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQr2uUsSQrim0ghTqQMKTg/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json'}, attempt #1 17:59:42 INFO - Downloaded 1277 bytes. 17:59:42 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 17:59:42 INFO - Using the following test package requirements: 17:59:42 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 17:59:42 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:59:42 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 17:59:42 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:59:42 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 17:59:42 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:59:42 INFO - u'jsshell-mac.zip'], 17:59:42 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:59:42 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 17:59:42 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 17:59:42 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:59:42 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 17:59:42 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:59:42 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 17:59:42 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:59:42 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 17:59:42 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 17:59:42 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:59:42 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 17:59:42 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:59:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:59:42 INFO - https://queue.taskcluster.net/v1/task/LQr2uUsSQrim0ghTqQMKTg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:59:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQr2uUsSQrim0ghTqQMKTg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 17:59:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQr2uUsSQrim0ghTqQMKTg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 17:59:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQr2uUsSQrim0ghTqQMKTg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 17:59:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQr2uUsSQrim0ghTqQMKTg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:59:43 INFO - Downloaded 17855051 bytes. 17:59:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:59:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 17:59:47 INFO - Return code: 0 17:59:47 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 17:59:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:59:47 INFO - https://queue.taskcluster.net/v1/task/LQr2uUsSQrim0ghTqQMKTg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:59:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQr2uUsSQrim0ghTqQMKTg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 17:59:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQr2uUsSQrim0ghTqQMKTg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 17:59:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQr2uUsSQrim0ghTqQMKTg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 17:59:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQr2uUsSQrim0ghTqQMKTg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:59:48 INFO - Downloaded 17855051 bytes. 17:59:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:59:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 17:59:51 INFO - Return code: 0 17:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:59:51 INFO - https://queue.taskcluster.net/v1/task/LQr2uUsSQrim0ghTqQMKTg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 17:59:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQr2uUsSQrim0ghTqQMKTg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 17:59:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQr2uUsSQrim0ghTqQMKTg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 17:59:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQr2uUsSQrim0ghTqQMKTg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 17:59:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQr2uUsSQrim0ghTqQMKTg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:59:52 INFO - Downloaded 10808282 bytes. 17:59:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:59:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 17:59:52 INFO - Return code: 0 17:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:59:52 INFO - https://queue.taskcluster.net/v1/task/LQr2uUsSQrim0ghTqQMKTg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 17:59:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQr2uUsSQrim0ghTqQMKTg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 17:59:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQr2uUsSQrim0ghTqQMKTg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 17:59:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQr2uUsSQrim0ghTqQMKTg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 17:59:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQr2uUsSQrim0ghTqQMKTg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 17:59:55 INFO - Downloaded 110957452 bytes. 17:59:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LQr2uUsSQrim0ghTqQMKTg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 17:59:55 INFO - mkdir: /builds/slave/test/properties 17:59:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:59:55 INFO - Writing to file /builds/slave/test/properties/build_url 17:59:55 INFO - Contents: 17:59:55 INFO - build_url:https://queue.taskcluster.net/v1/task/LQr2uUsSQrim0ghTqQMKTg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 17:59:56 INFO - Running post-action listener: _resource_record_post_action 17:59:56 INFO - Running post-action listener: set_extra_try_arguments 17:59:56 INFO - ##### 17:59:56 INFO - ##### Running populate-webroot step. 17:59:56 INFO - ##### 17:59:56 INFO - Running pre-action listener: _resource_record_pre_action 17:59:56 INFO - Running main action method: populate_webroot 17:59:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:59:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:59:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:59:56 INFO - '--tppagecycles', 17:59:56 INFO - '7'], 17:59:56 INFO - 'tests': ['tsvgm']}}, 17:59:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:59:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:59:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:59:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 17:59:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:59:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:59:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:59:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:59:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:59:56 INFO - 'talos_options': ['--e10s'], 17:59:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:59:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:59:56 INFO - 'tests': ['damp', 'tps']}, 17:59:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:59:56 INFO - 'talos_options': ['--e10s'], 17:59:56 INFO - 'tests': ['damp', 'tps']}, 17:59:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:59:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:59:56 INFO - 'other': {'tests': ['a11yr', 17:59:56 INFO - 'ts_paint', 17:59:56 INFO - 'tpaint', 17:59:56 INFO - 'sessionrestore', 17:59:56 INFO - 'sessionrestore_no_auto_restore']}, 17:59:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:59:56 INFO - 'tests': ['a11yr', 17:59:56 INFO - 'ts_paint', 17:59:56 INFO - 'tpaint', 17:59:56 INFO - 'sessionrestore', 17:59:56 INFO - 'sessionrestore_no_auto_restore']}, 17:59:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:59:56 INFO - 'tests': ['a11yr', 17:59:56 INFO - 'ts_paint', 17:59:56 INFO - 'tpaint', 17:59:56 INFO - 'sessionrestore', 17:59:56 INFO - 'sessionrestore_no_auto_restore']}, 17:59:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:59:56 INFO - 'tests': ['a11yr', 17:59:56 INFO - 'ts_paint', 17:59:56 INFO - 'tpaint', 17:59:56 INFO - 'sessionrestore', 17:59:56 INFO - 'sessionrestore_no_auto_restore']}, 17:59:56 INFO - 'other_l64': {'tests': ['a11yr', 17:59:56 INFO - 'ts_paint', 17:59:56 INFO - 'tpaint', 17:59:56 INFO - 'sessionrestore', 17:59:56 INFO - 'sessionrestore_no_auto_restore']}, 17:59:56 INFO - 'other_nol64': {'tests': ['a11yr', 17:59:56 INFO - 'ts_paint', 17:59:56 INFO - 'tpaint', 17:59:56 INFO - 'sessionrestore', 17:59:56 INFO - 'sessionrestore_no_auto_restore']}, 17:59:56 INFO - 'svgr': {'tests': ['tsvgx', 17:59:56 INFO - 'tsvgr_opacity', 17:59:56 INFO - 'tart', 17:59:56 INFO - 'tscrollx', 17:59:56 INFO - 'cart']}, 17:59:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:59:56 INFO - 'tests': ['tsvgx', 17:59:56 INFO - 'tsvgr_opacity', 17:59:56 INFO - 'tart', 17:59:56 INFO - 'tscrollx', 17:59:56 INFO - 'cart']}, 17:59:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:59:56 INFO - 'tests': ['tp5o']}, 17:59:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:59:56 INFO - 'talos_options': ['--e10s'], 17:59:56 INFO - 'tests': ['tp5o']}, 17:59:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:59:56 INFO - 'talos_options': ['--xperf_path', 17:59:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:59:56 INFO - 'tests': ['tp5n']}, 17:59:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:59:56 INFO - 'talos_options': ['--e10s', 17:59:56 INFO - '--xperf_path', 17:59:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:59:56 INFO - 'tests': ['tp5n']}}, 17:59:56 INFO - 'talos.zip': {'path': '', 17:59:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:59:56 INFO - Running post-action listener: _resource_record_post_action 17:59:56 INFO - ##### 17:59:56 INFO - ##### Running create-virtualenv step. 17:59:56 INFO - ##### 17:59:56 INFO - Running pre-action listener: _resource_record_pre_action 17:59:56 INFO - Running main action method: create_virtualenv 17:59:56 INFO - Creating virtualenv /builds/slave/test/build/venv 17:59:56 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:59:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:59:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:59:56 INFO - Using real prefix '/tools/python27' 17:59:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:59:57 INFO - Installing distribute.............................................................................................................................................................................................done. 18:00:00 INFO - Installing pip.................done. 18:00:00 INFO - Return code: 0 18:00:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:00:00 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')]} 18:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:00 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')]} 18:00:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:00 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 0x107dfda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e044c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbf3c6dbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ca1d30>, '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 0x107ac5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c98b20>, '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.1Q40tFGngv/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.TEFBDJg8Mu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 18:00:00 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 18:00:00 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 18:00:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1Q40tFGngv/Render', 18:00:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:00:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:00:00 INFO - 'HOME': '/Users/cltbld', 18:00:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:00:00 INFO - 'LOGNAME': 'cltbld', 18:00:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:00 INFO - 'MOZ_NO_REMOTE': '1', 18:00:00 INFO - 'NO_EM_RESTART': '1', 18:00:00 INFO - 'PAGER': '/bin/cat', 18:00:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:00:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:00 INFO - 'PWD': '/builds/slave/test', 18:00:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:00:00 INFO - 'SHELL': '/bin/bash', 18:00:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TEFBDJg8Mu/Listeners', 18:00:00 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 18:00:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:00:00 INFO - 'USER': 'cltbld', 18:00:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:00:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:00:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:00 INFO - 'XPC_FLAGS': '0x0', 18:00:00 INFO - 'XPC_SERVICE_NAME': '0', 18:00:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:00:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:00 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 18:00:00 INFO - Cleaning up... 18:00:00 INFO - Return code: 0 18:00:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:00:00 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')]} 18:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:00 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')]} 18:00:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:00 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107dfda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e044c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbf3c6dbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ca1d30>, '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 0x107ac5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c98b20>, '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.1Q40tFGngv/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.TEFBDJg8Mu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 18:00:00 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>=0.7.1'] in /builds/slave/test/build 18:00:00 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>=0.7.1 18:00:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1Q40tFGngv/Render', 18:00:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:00:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:00:00 INFO - 'HOME': '/Users/cltbld', 18:00:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:00:00 INFO - 'LOGNAME': 'cltbld', 18:00:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:00 INFO - 'MOZ_NO_REMOTE': '1', 18:00:00 INFO - 'NO_EM_RESTART': '1', 18:00:00 INFO - 'PAGER': '/bin/cat', 18:00:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:00:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:00 INFO - 'PWD': '/builds/slave/test', 18:00:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:00:00 INFO - 'SHELL': '/bin/bash', 18:00:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TEFBDJg8Mu/Listeners', 18:00:00 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 18:00:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:00:00 INFO - 'USER': 'cltbld', 18:00:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:00:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:00:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:00 INFO - 'XPC_FLAGS': '0x0', 18:00:00 INFO - 'XPC_SERVICE_NAME': '0', 18:00:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:00:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:00 INFO - Downloading/unpacking psutil>=0.7.1 18:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:00:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:00:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:00:03 INFO - Installing collected packages: psutil 18:00:03 INFO - Running setup.py install for psutil 18:00:03 INFO - building 'psutil._psutil_osx' extension 18:00:03 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 18:00:04 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 18:00:04 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 18:00:04 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 18:00:04 INFO - building 'psutil._psutil_posix' extension 18:00:04 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 18:00:04 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:00:04 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:00:04 INFO - ^ 18:00:04 INFO - 1 warning generated. 18:00:04 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 18:00:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:00:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:00:04 INFO - Successfully installed psutil 18:00:04 INFO - Cleaning up... 18:00:04 INFO - Return code: 0 18:00:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:04 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107dfda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e044c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbf3c6dbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ca1d30>, '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 0x107ac5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c98b20>, '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.1Q40tFGngv/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.TEFBDJg8Mu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 18:00:04 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.0.0'] in /builds/slave/test/build 18:00:04 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.0.0 18:00:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1Q40tFGngv/Render', 18:00:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:00:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:00:04 INFO - 'HOME': '/Users/cltbld', 18:00:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:00:04 INFO - 'LOGNAME': 'cltbld', 18:00:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:04 INFO - 'MOZ_NO_REMOTE': '1', 18:00:04 INFO - 'NO_EM_RESTART': '1', 18:00:04 INFO - 'PAGER': '/bin/cat', 18:00:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:00:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:04 INFO - 'PWD': '/builds/slave/test', 18:00:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:00:04 INFO - 'SHELL': '/bin/bash', 18:00:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TEFBDJg8Mu/Listeners', 18:00:04 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 18:00:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:00:04 INFO - 'USER': 'cltbld', 18:00:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:00:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:00:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:04 INFO - 'XPC_FLAGS': '0x0', 18:00:04 INFO - 'XPC_SERVICE_NAME': '0', 18:00:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:00:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:00:05 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 18:00:05 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 18:00:05 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 18:00:05 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 18:00:05 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 18:00:05 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 18:00:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:00:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:00:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:00:07 INFO - Installing collected packages: mozsystemmonitor 18:00:07 INFO - Running setup.py install for mozsystemmonitor 18:00:07 INFO - Successfully installed mozsystemmonitor 18:00:07 INFO - Cleaning up... 18:00:07 INFO - Return code: 0 18:00:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:00:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107dfda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e044c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbf3c6dbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ca1d30>, '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 0x107ac5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c98b20>, '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.1Q40tFGngv/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.TEFBDJg8Mu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 18:00:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:00:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:00:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1Q40tFGngv/Render', 18:00:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:00:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:00:07 INFO - 'HOME': '/Users/cltbld', 18:00:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:00:07 INFO - 'LOGNAME': 'cltbld', 18:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:07 INFO - 'MOZ_NO_REMOTE': '1', 18:00:07 INFO - 'NO_EM_RESTART': '1', 18:00:07 INFO - 'PAGER': '/bin/cat', 18:00:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:07 INFO - 'PWD': '/builds/slave/test', 18:00:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:00:07 INFO - 'SHELL': '/bin/bash', 18:00:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TEFBDJg8Mu/Listeners', 18:00:07 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 18:00:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:00:07 INFO - 'USER': 'cltbld', 18:00:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:00:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:07 INFO - 'XPC_FLAGS': '0x0', 18:00:07 INFO - 'XPC_SERVICE_NAME': '0', 18:00:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:00:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:08 INFO - Downloading/unpacking blobuploader==1.2.4 18:00:08 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 18:00:08 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 18:00:08 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 18:00:08 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 18:00:08 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 18:00:08 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 18:00:10 INFO - Downloading blobuploader-1.2.4.tar.gz 18:00:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:00:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:00:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:11 INFO - Downloading docopt-0.6.1.tar.gz 18:00:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:00:11 INFO - Installing collected packages: blobuploader, requests, docopt 18:00:11 INFO - Running setup.py install for blobuploader 18:00:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:00:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:00:11 INFO - Running setup.py install for requests 18:00:12 INFO - Running setup.py install for docopt 18:00:12 INFO - Successfully installed blobuploader requests docopt 18:00:12 INFO - Cleaning up... 18:00:12 INFO - Return code: 0 18:00:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:00:12 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')]} 18:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:12 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')]} 18:00:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:12 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 0x107dfda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e044c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbf3c6dbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ca1d30>, '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 0x107ac5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c98b20>, '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.1Q40tFGngv/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.TEFBDJg8Mu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 18:00:12 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 18:00:12 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 18:00:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1Q40tFGngv/Render', 18:00:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:00:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:00:12 INFO - 'HOME': '/Users/cltbld', 18:00:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:00:12 INFO - 'LOGNAME': 'cltbld', 18:00:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:12 INFO - 'MOZ_NO_REMOTE': '1', 18:00:12 INFO - 'NO_EM_RESTART': '1', 18:00:12 INFO - 'PAGER': '/bin/cat', 18:00:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:00:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:12 INFO - 'PWD': '/builds/slave/test', 18:00:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:00:12 INFO - 'SHELL': '/bin/bash', 18:00:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TEFBDJg8Mu/Listeners', 18:00:12 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 18:00:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:00:12 INFO - 'USER': 'cltbld', 18:00:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:00:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:00:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:12 INFO - 'XPC_FLAGS': '0x0', 18:00:12 INFO - 'XPC_SERVICE_NAME': '0', 18:00:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:00:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:00:12 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-uqDE4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:00:12 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-tJE1fR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:00:12 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-OLfBgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:00:13 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-LTxo7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:00:13 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-JYbFEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:00:13 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-NuHBMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:00:13 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-p7Uls_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:00:13 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-Z3rd1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:00:13 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-LbCb5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:00:13 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-O6yo7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:00:13 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-rRxT1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:00:13 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-smbuyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:00:13 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-aesktP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:00:14 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-S9p2dg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:00:14 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-6SiO5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:00:14 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-P0PQfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:00:14 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-T_lBet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:00:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:00:14 INFO - Running setup.py install for manifestparser 18:00:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:00:14 INFO - Running setup.py install for mozcrash 18:00:14 INFO - Running setup.py install for mozdebug 18:00:14 INFO - Running setup.py install for mozdevice 18:00:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:00:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:00:15 INFO - Running setup.py install for mozfile 18:00:15 INFO - Running setup.py install for mozhttpd 18:00:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:00:15 INFO - Running setup.py install for mozinfo 18:00:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:00:15 INFO - Running setup.py install for mozInstall 18:00:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:00:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:00:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:00:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:00:15 INFO - Running setup.py install for mozleak 18:00:15 INFO - Running setup.py install for mozlog 18:00:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:00:15 INFO - Running setup.py install for moznetwork 18:00:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:00:16 INFO - Running setup.py install for mozprocess 18:00:16 INFO - Running setup.py install for mozprofile 18:00:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:00:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:00:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:00:16 INFO - Running setup.py install for mozrunner 18:00:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:00:16 INFO - Running setup.py install for mozscreenshot 18:00:16 INFO - Running setup.py install for moztest 18:00:16 INFO - Running setup.py install for mozversion 18:00:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:00:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:00:17 INFO - Cleaning up... 18:00:17 INFO - Return code: 0 18:00:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:00:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:17 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 0x107dfda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e044c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbf3c6dbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ca1d30>, '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 0x107ac5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c98b20>, '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.1Q40tFGngv/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.TEFBDJg8Mu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 18:00:17 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 18:00:17 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 18:00:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1Q40tFGngv/Render', 18:00:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:00:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:00:17 INFO - 'HOME': '/Users/cltbld', 18:00:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:00:17 INFO - 'LOGNAME': 'cltbld', 18:00:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:17 INFO - 'MOZ_NO_REMOTE': '1', 18:00:17 INFO - 'NO_EM_RESTART': '1', 18:00:17 INFO - 'PAGER': '/bin/cat', 18:00:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:00:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:17 INFO - 'PWD': '/builds/slave/test', 18:00:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:00:17 INFO - 'SHELL': '/bin/bash', 18:00:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TEFBDJg8Mu/Listeners', 18:00:17 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 18:00:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:00:17 INFO - 'USER': 'cltbld', 18:00:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:00:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:00:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:17 INFO - 'XPC_FLAGS': '0x0', 18:00:17 INFO - 'XPC_SERVICE_NAME': '0', 18:00:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:00:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:00:17 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-9Obc9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:00:17 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)) 18:00:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:00:17 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-Wv85Lv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:00:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 18:00:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:00:17 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-l0sOqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:00:17 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)) 18:00:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:00:17 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-sf4zC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:00:17 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)) 18:00:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:00:17 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-0oK9pA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:00:17 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)) 18:00:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:00:17 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-xaJYei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:00:17 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)) 18:00:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:00:17 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-B8jDAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:00:18 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)) 18:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:00:18 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-scyiLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:00:18 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)) 18:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:00:18 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-TqAOAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:00:18 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)) 18:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:00:18 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-HlbHQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:00:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 18:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:00:18 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-K3Bwm6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:00:18 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)) 18:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:00:18 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-rOLHP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:00:18 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)) 18:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:00:18 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-IudMBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:00:18 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)) 18:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:00:18 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-oxr6Oy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:00:18 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)) 18:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:00:18 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-7KMitF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:00:18 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)) 18:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:00:18 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-AXihiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:00:18 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)) 18:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:00:18 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-RsWk2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:00:19 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)) 18:00:19 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:00:19 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:00:19 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)) 18:00:19 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)) 18:00:19 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)) 18:00:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:00: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 18:00: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 18:00: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 18:00: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 18:00: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 18:00: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 18:00:21 INFO - Downloading blessings-1.6.tar.gz 18:00:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:00:21 INFO - Installing collected packages: blessings 18:00:21 INFO - Running setup.py install for blessings 18:00:21 INFO - Successfully installed blessings 18:00:21 INFO - Cleaning up... 18:00:21 INFO - Return code: 0 18:00:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:00:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:00:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:00:22 INFO - Reading from file tmpfile_stdout 18:00:22 INFO - Current package versions: 18:00:22 INFO - blessings == 1.6 18:00:22 INFO - blobuploader == 1.2.4 18:00:22 INFO - docopt == 0.6.1 18:00:22 INFO - manifestparser == 1.1 18:00:22 INFO - mozInstall == 1.12 18:00:22 INFO - mozcrash == 0.16 18:00:22 INFO - mozdebug == 0.1 18:00:22 INFO - mozdevice == 0.48 18:00:22 INFO - mozfile == 1.2 18:00:22 INFO - mozhttpd == 0.7 18:00:22 INFO - mozinfo == 0.9 18:00:22 INFO - mozleak == 0.1 18:00:22 INFO - mozlog == 3.1 18:00:22 INFO - moznetwork == 0.27 18:00:22 INFO - mozprocess == 0.22 18:00:22 INFO - mozprofile == 0.28 18:00:22 INFO - mozrunner == 6.11 18:00:22 INFO - mozscreenshot == 0.1 18:00:22 INFO - mozsystemmonitor == 0.0 18:00:22 INFO - moztest == 0.7 18:00:22 INFO - mozversion == 1.4 18:00:22 INFO - psutil == 3.1.1 18:00:22 INFO - requests == 1.2.3 18:00:22 INFO - wsgiref == 0.1.2 18:00:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:00:22 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')]} 18:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:22 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')]} 18:00:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:22 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 0x107dfda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e044c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbf3c6dbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ca1d30>, '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 0x107ac5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c98b20>, '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.1Q40tFGngv/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.TEFBDJg8Mu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 18:00:22 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 18:00:22 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 18:00:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1Q40tFGngv/Render', 18:00:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:00:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:00:22 INFO - 'HOME': '/Users/cltbld', 18:00:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:00:22 INFO - 'LOGNAME': 'cltbld', 18:00:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:22 INFO - 'MOZ_NO_REMOTE': '1', 18:00:22 INFO - 'NO_EM_RESTART': '1', 18:00:22 INFO - 'PAGER': '/bin/cat', 18:00:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:00:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:22 INFO - 'PWD': '/builds/slave/test', 18:00:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:00:22 INFO - 'SHELL': '/bin/bash', 18:00:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TEFBDJg8Mu/Listeners', 18:00:22 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 18:00:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:00:22 INFO - 'USER': 'cltbld', 18:00:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:00:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:00:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:22 INFO - 'XPC_FLAGS': '0x0', 18:00:22 INFO - 'XPC_SERVICE_NAME': '0', 18:00:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:00:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:22 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)) 18:00:22 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)) 18:00:22 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)) 18:00:22 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)) 18:00:22 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)) 18:00:22 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)) 18:00:22 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)) 18:00:22 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)) 18:00:22 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)) 18:00:22 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)) 18:00:22 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)) 18:00:22 INFO - Cleaning up... 18:00:22 INFO - Return code: 0 18:00:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:00:22 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')]} 18:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:22 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')]} 18:00:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:22 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 0x107dfda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e044c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbf3c6dbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ca1d30>, '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 0x107ac5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c98b20>, '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.1Q40tFGngv/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.TEFBDJg8Mu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 18:00:22 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 18:00:22 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 18:00:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1Q40tFGngv/Render', 18:00:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:00:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:00:22 INFO - 'HOME': '/Users/cltbld', 18:00:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:00:22 INFO - 'LOGNAME': 'cltbld', 18:00:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:22 INFO - 'MOZ_NO_REMOTE': '1', 18:00:22 INFO - 'NO_EM_RESTART': '1', 18:00:22 INFO - 'PAGER': '/bin/cat', 18:00:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:00:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:22 INFO - 'PWD': '/builds/slave/test', 18:00:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:00:22 INFO - 'SHELL': '/bin/bash', 18:00:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TEFBDJg8Mu/Listeners', 18:00:22 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 18:00:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:00:22 INFO - 'USER': 'cltbld', 18:00:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:00:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:00:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:22 INFO - 'XPC_FLAGS': '0x0', 18:00:22 INFO - 'XPC_SERVICE_NAME': '0', 18:00:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:00:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:22 INFO - Downloading/unpacking jsonschema 18:00: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 18:00: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 18:00: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 18:00: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 18:00: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 18:00: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 18:00:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:00:24 INFO - Downloading/unpacking functools32 (from jsonschema) 18:00:24 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 18:00:24 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 18:00:24 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 18:00:24 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 18:00:24 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 18:00:24 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 18:00:25 INFO - Downloading functools32-3.2.3-2.tar.gz 18:00:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:00:25 INFO - warning: no files found matching '*.txt' 18:00:25 INFO - no previously-included directories found matching 'build' 18:00:25 INFO - no previously-included directories found matching 'dist' 18:00:25 INFO - no previously-included directories found matching '.git*' 18:00:25 INFO - Installing collected packages: jsonschema, functools32 18:00:25 INFO - Running setup.py install for functools32 18:00:25 INFO - warning: no files found matching '*.txt' 18:00:25 INFO - no previously-included directories found matching 'build' 18:00:25 INFO - no previously-included directories found matching 'dist' 18:00:25 INFO - no previously-included directories found matching '.git*' 18:00:25 INFO - Successfully installed jsonschema functools32 18:00:25 INFO - Cleaning up... 18:00:25 INFO - Return code: 0 18:00:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:00:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107dfda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e044c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbf3c6dbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ca1d30>, '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 0x107ac5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c98b20>, '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.1Q40tFGngv/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.TEFBDJg8Mu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 18:00:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 18:00:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 18:00:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1Q40tFGngv/Render', 18:00:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:00:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:00:25 INFO - 'HOME': '/Users/cltbld', 18:00:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:00:25 INFO - 'LOGNAME': 'cltbld', 18:00:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:25 INFO - 'MOZ_NO_REMOTE': '1', 18:00:25 INFO - 'NO_EM_RESTART': '1', 18:00:25 INFO - 'PAGER': '/bin/cat', 18:00:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:00:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:25 INFO - 'PWD': '/builds/slave/test', 18:00:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:00:25 INFO - 'SHELL': '/bin/bash', 18:00:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TEFBDJg8Mu/Listeners', 18:00:25 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 18:00:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:00:25 INFO - 'USER': 'cltbld', 18:00:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:00:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:00:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:25 INFO - 'XPC_FLAGS': '0x0', 18:00:25 INFO - 'XPC_SERVICE_NAME': '0', 18:00:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:00:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:25 INFO - Downloading/unpacking flake8 18:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:00:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:00:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:00:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:00:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:00:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:00:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:00:29 INFO - no previously-included directories found matching 'docs/_build' 18:00:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:00:29 INFO - Running setup.py install for pep8 18:00:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:00:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:00:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:00:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:00:29 INFO - no previously-included directories found matching 'docs/_build' 18:00:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:00:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:00:29 INFO - Cleaning up... 18:00:29 INFO - Return code: 0 18:00:29 INFO - Running post-action listener: _resource_record_post_action 18:00:29 INFO - Running post-action listener: _start_resource_monitoring 18:00:29 INFO - Starting resource monitoring. 18:00:29 INFO - ##### 18:00:29 INFO - ##### Running install step. 18:00:29 INFO - ##### 18:00:29 INFO - Running pre-action listener: _resource_record_pre_action 18:00:29 INFO - Running main action method: install 18:00:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:00:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:00:30 INFO - Reading from file tmpfile_stdout 18:00:30 INFO - Detecting whether we're running mozinstall >=1.0... 18:00:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:00:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:00:30 INFO - Reading from file tmpfile_stdout 18:00:30 INFO - Output received: 18:00:30 INFO - Usage: mozinstall [options] installer 18:00:30 INFO - Options: 18:00:30 INFO - -h, --help show this help message and exit 18:00:30 INFO - -d DEST, --destination=DEST 18:00:30 INFO - Directory to install application into. [default: 18:00:30 INFO - "/builds/slave/test"] 18:00:30 INFO - --app=APP Application being installed. [default: firefox] 18:00:30 INFO - mkdir: /builds/slave/test/build/application 18:00:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:00:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 18:01:03 INFO - Reading from file tmpfile_stdout 18:01:03 INFO - Output received: 18:01:03 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:01:03 INFO - Running post-action listener: _resource_record_post_action 18:01:03 INFO - ##### 18:01:03 INFO - ##### Running run-tests step. 18:01:03 INFO - ##### 18:01:03 INFO - Running pre-action listener: _resource_record_pre_action 18:01:03 INFO - Running main action method: run_tests 18:01:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:01:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:01:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:01:03 INFO - 2016-03-03 18:01:03.759 screenresolution[1645:7528] starting screenresolution argv=screenresolution get 18:01:03 INFO - 2016-03-03 18:01:03.762 screenresolution[1645:7528] Display 0: 1600x1200x32@60 18:01:03 INFO - 2016-03-03 18:01:03.769 screenresolution[1646:7531] starting screenresolution argv=screenresolution list 18:01:03 INFO - Available Modes on Display 0 18:01:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:01:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:01:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:01:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:01:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:01:03 INFO - Intel Iris: 18:01:03 INFO - Chipset Model: Intel Iris 18:01:03 INFO - Type: GPU 18:01:03 INFO - Bus: Built-In 18:01:03 INFO - VRAM (Dynamic, Max): 1536 MB 18:01:03 INFO - Vendor: Intel (0x8086) 18:01:03 INFO - Device ID: 0x0a2e 18:01:03 INFO - Revision ID: 0x0009 18:01:04 INFO - Displays: 18:01:04 INFO - Display: 18:01:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:01:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:01:04 INFO - Display Serial Number: 1600x1200 60 18:01:04 INFO - Main Display: Yes 18:01:04 INFO - Mirror: Off 18:01:04 INFO - Online: Yes 18:01:04 INFO - Rotation: Supported 18:01:04 INFO - Return code: 0 18:01:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:01:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:01:04 INFO - Python 2.7.3 18:01:04 INFO - Return code: 0 18:01:04 INFO - grabbing minidump binary from tooltool 18:01:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:01:04 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ca1d30>, '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 0x107ac5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c98b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:01:04 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 18:01:04 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 18:01:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:01:04 INFO - Return code: 0 18:01:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:01:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:01:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:01:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:01:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:01:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:01:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:01:05 INFO - Return code: 0 18:01:05 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/LQr2uUsSQrim0ghTqQMKTg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0103', '--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 18:01:05 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/LQr2uUsSQrim0ghTqQMKTg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0103 --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 18:01:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1Q40tFGngv/Render', 18:01:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:01:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:01:05 INFO - 'HOME': '/Users/cltbld', 18:01:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:01:05 INFO - 'LOGNAME': 'cltbld', 18:01:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:01:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:01:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:01:05 INFO - 'MOZ_NO_REMOTE': '1', 18:01:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:01:05 INFO - 'NO_EM_RESTART': '1', 18:01:05 INFO - 'PAGER': '/bin/cat', 18:01:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:01:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:01:05 INFO - 'PWD': '/builds/slave/test', 18:01:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:01:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:01:05 INFO - 'SHELL': '/bin/bash', 18:01:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TEFBDJg8Mu/Listeners', 18:01:05 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 18:01:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:01:05 INFO - 'USER': 'cltbld', 18:01:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:01:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:01:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:01:05 INFO - 'XPC_FLAGS': '0x0', 18:01:05 INFO - 'XPC_SERVICE_NAME': '0', 18:01:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:01:05 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/LQr2uUsSQrim0ghTqQMKTg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0103', '--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 18:01:05 INFO - mozversion application_buildid: 20160303170525 18:01:05 INFO - mozversion application_changeset: 6b7cac27bb8397f223af0ea20950f657328fbb4b 18:01:05 INFO - mozversion application_display_name: Nightly 18:01:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:01:05 INFO - mozversion application_name: Firefox 18:01:05 INFO - mozversion application_remotingname: firefox 18:01:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:01:05 INFO - mozversion application_vendor: Mozilla 18:01:05 INFO - mozversion application_version: 47.0a1 18:01:05 INFO - mozversion platform_buildid: 20160303170525 18:01:05 INFO - mozversion platform_changeset: 6b7cac27bb8397f223af0ea20950f657328fbb4b 18:01:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:01:05 INFO - mozversion platform_version: 47.0a1 18:01:05 INFO - using testdate: 1457056865 18:01:05 INFO - actual date: 1457056865 18:01:05 INFO - starting webserver on 'localhost:49271' 18:01:05 INFO - SUITE-START | Running 2 tests 18:01:05 INFO - TEST-START | dromaeo_css 18:01:05 INFO - operating with platform_type : mac_ 18:01:05 INFO - Initialising browser for dromaeo_css test... 18:01:06 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/tmpOQ3HEW/profile http://localhost:49271/getInfo.html) 18:01:08 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 18:01:08 INFO - PROCESS | 1664 | colorDepth:24 18:01:08 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 18:01:08 INFO - PROCESS | 1664 | __metrics 18:01:09 ERROR - PROCESS | 1664 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 18:01:09 INFO - TEST-INFO | 1664: exit 0 18:01:09 INFO - Browser initialized. 18:01:09 INFO - Running cycle 1/1 for dromaeo_css test... 18:01:09 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/tmpOQ3HEW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:01:21 INFO - PROCESS | 1668 | RSS: Main: 253755392 18:01:21 INFO - PROCESS | 1668 | 18:02:11 INFO - PROCESS | 1668 | 1457056931385 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] 18:04:21 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 18:04:23 INFO - PROCESS | 1668 | RSS: Main: 268517376 18:04:23 INFO - PROCESS | 1668 | 18:07:25 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 18:07:25 INFO - PROCESS | 1668 | RSS: Main: 280367104 18:07:25 INFO - PROCESS | 1668 | 18:10:27 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 18:10:28 INFO - PROCESS | 1668 | RSS: Main: 282591232 18:10:28 INFO - PROCESS | 1668 | 18:13:29 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 18:13:30 INFO - PROCESS | 1668 | RSS: Main: 283824128 18:13:30 INFO - PROCESS | 1668 | 18:16:32 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 18:16:33 INFO - PROCESS | 1668 | RSS: Main: 287621120 18:16:33 INFO - PROCESS | 1668 | 18:19:35 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 18:19:36 INFO - PROCESS | 1668 | RSS: Main: 288428032 18:19:36 INFO - PROCESS | 1668 | 18:19:36 INFO - PROCESS | 1668 | __start_tp_report 18:19:36 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 18:19:36 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 18:19:36 INFO - PROCESS | 1668 | |i|pagename|runs| 18:19:36 INFO - PROCESS | 1668 | |0;dojo.html;3284.62226843913;3510.4032314506517;3534.2048039191186;3554.5023696682483;3585.4084076127433;5637.9436205637985;5674.914876276859;5695.145728140781;5725.112607545827;5743.3682294947575;4589.724616523011;5590.636608620437;5763.769449222036;5928.932792097421;5951.642901425917;5180.352455943007;5199.376074871011;5265.289185959885;5271.051210782058;5280.102382594949;5311.267773927596;5348.277982472375;5351.117065684177;5365.597580181482;5376.462353764612;5106.208537676666;5112.769925353368;5203.178887389384;5301.3373328333955;5336.17289320156;5220.060389129955;5228.660137091077;5232.084385232569;5245.082110630625;5262.289590905217;4343.348497725335;5193.766280517386;5201.713905735183;5237.580993520547;5243.161094224905;4734.810607575693;5607.495325420732;5674.546036317126;5688.658680479184;5769.163471296681;6270.216222972129;6275.341089185616;6303.117563541108;6323.462505687022;6324.956382196932;6153.569250152491;6279.6860156992425;6280.425025739471;6302.590331628476;6319.684015799192;5812.953668339697;5902.911456328158;5919.55603329752;5922.674252916045;5943.613665111797;6288;6308.495320374359;6340.904886426707;6357.523185761086;6357.682115894279;6112.847178820565;6128.142060111588;6192.225971753531;6222;6238.625682458976;5282.366116066097;6114.510272098727;6268.028455589391;6303.149074874925;6315.210598675166;5381.165919282517;6045.625111680288;6101.694915254219;6140.078988151813;6203.906941395882;5902.557308201902;6129.48104857405;6307.495400368051;6308;6326.177596912464;4848.660593758403;4911.386076740408;4946.604271658259;4961.553460188528;4998;3865.555461121951;4401.163778882003;4439.667024973075;4452.866414007585;4453.888652783707;5592.916106258409;5803.129530570448;5816.098504731774;5860.208871802252;5869.618474799125;6218.973869311603;6237.937620623827;6265.498760099181;6268.561200715997;6351.809445716636;5901.76392944286;5942.64344139353;5947.791827286024;5961.165436838846;5974.253218347707;4037.414574886625;5279.155335146358;5398.352197736297;5418.187271909245;5509.283793106871;6359.523035772336;6425.710843012076;6448.774292899726;6461.999999999906;6462.224533056064;6222.968885155546;6274.968625156845;6284.183056202664;6293.087502312231;6302.558820882494;4910.803567857389;6215.844603884939;6291.874162516816;6345.968270158804;6390.265119511129;6170.938290617037;6233.127362169209;6270.655113968775;6271.404216599416;6291.245050593958;6274.6548939808745;6274.811755647338;6283.151774510383;6303.527235457451;6370.235571731422;5021.977366295987;5961.463468287875;6024.096385542029;6118.4668989547035;6130.417610327012;6127.647695153045;6134.926457743815;6162.445379915829;6170.290416602148;6178.969105154625;5975.312839023568;5990.610610310316;6081.300650425258;6096.75612975476;6101.2068431105445;6073.423024812636;6142.1304578115505;6171.228596425447;6216.937830621817;6244.750209991549;5868.354481007171;5931.228940237914;5941.91087133702;5989.850253743692;6005.549583781147 18:19:36 INFO - PROCESS | 1668 | |1;ext.html;436.98183233066936;493.4867737552945;527.2907938822283;552.8059391713896;599.5563283170454;28939.131826045224;37154.62845371546;37183.44224836623;37238.441423378674;37240.441393379086;38021.33850630457;38464.80767596158;38510.61489385105;38600.420993685046;38601.42097868534;9285.071492850711;9445.81108377832;9509.80980380392;9511.429314241133;9534.856977145313;8013.278804907557;9517.333786634937;9545.71132897057;9565.186959108483;9596.952015239915;9454.669086581971;9477;9510.28672849539;9513.714588562354;9576.569054392534;9506;9526.095020972996;9568.95215523918;9572.32993690442;9581.856272155923;9492.145706886344;9563.617455301779;9568.138867501959;9599;9602.423854568748;36396.090097747765;36551.4517282241;36781.08047298812;36864.078398039994;36870.89387318385;3219.025290221747;3359.8779314162166;3403.5745531808525;3441.3633477806434;3620.746547741659;27987.880484780788;28207.153785386265;28309.57535636967;28342.433151337063;28379.432411351656;2692.380752426933;2743.903963361293;2747.2994386431333;2815.225812901448;2878.6401699787525;490265;509206.4539677315;509740;515866;517121;60503.69748151319;61226;61596;61983;62408;65198.67400662966;65664;68979.3102068983;69620;70781.23046923868;15833.366665333488;16358.427455039016;16521.83478165203;16527;16554.751678724828;10541.894581054245;12435.875641243652;12580.685482862818;12601.747965040648;12630;20226.595468090556;20283.695744563844;20590.691139632916;20635.69046464304;20650.277240296517;8250.968628921384;9167.679131230376;9289.674861379819;9494.857577136348;9523;941.7975135345933;969.6945462179391;1016.4307987527009;1043.5669197283194;1075.1828610256105;28836.279093022844;29124.980625678;29199.41601167965;29260.853695731385;29585.852070739507;869.4652788535132;1055.2824079625775;1057.5399701130034;1083.4257843343041;1117.6479408986143;14403.495877644442;14649.414023439156;14799.038062525902;14944.925275373553;15013.624659383602;508589;511882;512509;514862;516437;55751.442485574626;55952.44047559554;56315.43684563102;56577.43422565804;56798;1390.6592884743302;1418.907770994882;1439.100562148657;1447.370393878645;1583.3033465275473;28619.713802861705;28835.83304786471;28902.277443064093;28912.132636020953;29202.269943251587;46633;46939.76530117328;46955.53044469511;47072.29391559198;47483.28775068308;470486;475164;476887;477756;479568;32262.19344516406;32903.506447402826;33298.5005224917;42177.36733949055;43111.137777244905;40740.59259407368;41672.58327416687;41881.581184187766;41991.740247792615;42094;34452.82773586116;34886.30227395488;35130;35698.929032129075;35793.92618221458;34008.65991340055;34318.48522272118;34492.82753586216;34590.96227113191;34979.82510087433;30256.54615180818;33918.8304058488;37238.44142337813;37904.810475947445;38057.238855223295;29163.416731664824;31072.689273107884;31164.532532011584;31297.061088167393;31300.37399252048;23700.52598948046;23987.160449384188;24044.038238470966;24409.145679901118;24451.144209952567 18:19:36 INFO - PROCESS | 1668 | |2;jquery.html;316.44621911654605;349.3118556443805;357.10188874979434;362.34234863722344;365.2639930539961;18963;19415.902920485394;20004.399868003948;20297.594048119066;20312.89843550782;18815;19243.615127697438;19660.820350778962;19853.702194467096;19860.106295216712;5048.469910659373;5304.177852432879;5979.581429299951;5983.880322393571;5984.790532331369;4234.026173979971;5887.411258874121;6252.124702541648;6530.314316996718;6549.148610680605;6466.159399278087;6473.769983703105;6476.579022363531;6484.383983521558;6488.059231411443;5478.369987451434;5749.252597162384;5751;5758.79844205455;5767.163761254616;5224.73876306187;5418.810341638064;5496.780128794843;5501.037318469252;5508.4491550845;11485.712857178554;11945.865142811419;12594.37028148589;12722.427490762939;12840.293783841886;2053.147943603403;2080.937571872846;2245.4733163913747;2266.2068276103396;2761.406297646016;9378.812423751555;9499.572519236652;9564.473953932531;9729.562169702309;9876.35803672759;1709.4102534625533;1711.4181178399404;1720.587059105818;1722.0872937343229;1731.471901070173;100047.96642350311;105603.47198264036;105922;107507.38738918923;108327.45836270768;8982;11084.279521831055;11150.386728729998;11346.546138154546;11444.656660300205;13468.595942121752;13474.258915759532;13607.455701771818;13609.455621775018;13681.589552313446;8238.711645092393;8351.749447516584;8434.620442079999;8536.70121545743;8571.785705357415;8555.914440855511;8559.186877246651;8569.78575535604;8660.653573857102;8703.303735701129;4374.62815660666;4380.496242932039;4385.978070109629;4433.578810013044;4444.622207112432;1735.739639054152;1806.530302121458;1829.954251143732;1832.58766777474;1868.7103498957683;779.8497216605462;824.4929368438367;856.648774002656;916.7937214126769;919.4850883505259;15542;16831.831681683027;17022.914885425493;19374.90312548428;19610.901945490183;720.6360787802231;817.3012074676067;964.2093483343731;972.4311277902365;1005.6580762540772;7693.384529237647;10967.95804398581;10975.615853445091;11018.228723989405;11126.833097503544;644197;648063;664984.7003059912;667696;669369;116112;116931.41534292274;118844;118984.40507797405;121680;1000.3447741729179;1006.993006993007;1021.9576032446863;1022.948852557384;1026.8357062870055;14358.210298433687;17458.912705436393;18096.72854907151;18262.17820198121;18289.99405032736;33966.83016584901;51081.74459127829;52704.736476317375;52736.73631631817;53921.460785391646;74625;74680;76095.61952190426;76469;76553.61723191348;7992.720254791287;8012.919870801217;8100.83798324042;8306.377021723274;8310.168983101641;10997.835032474679;12035.939820301193;12372.4432400544;12865.678358041125;13217.537386191438;10792.730181745519;11053.889461105286;11358.488868000795;11367.658970230907;11378.487968041623;9479.194268487256;10352.275340726077;10562.31344962575;10744.140468762324;11385.089192864385;11079;11286.774264514828;11406;11428.314301141958;11474.827877581676;7901.723439679584;7943.4836735612;7965.721199757981;7976.680932762857;8187.058488273925;10358.326708763907;11235.045021173291;11438.199326047097;11639.301641901513;11739.471723772622 18:19:36 INFO - PROCESS | 1668 | |3;mootools.html;1466.1276540458427;1522.6574020845312;1742.9215685294162;1873.4473330367532;1882.6893562562177;7699.345555627764;8355.749327520183;8388.958055209723;8615.56922153893;8638.438501497407;8384.161583841613;8409.075001749803;8513.361497887652;8516.61675224615;8563.61463734132;2423.030787684927;2431.878406079689;2443.315871555967;2451.460678650694;2461.237016524874;2404.483036147228;2407.879606019701;2442.792362649177;2448.865312407817;2455.1407007547305;2436.3543660929868;2445.3397582652674;2463.876806159694;2469.234537293436;2471.851688898663;2376.3583832365166;2385.355953892448;2389.0443822470975;2389.6773935518745;2405.7113146422366;2377.108584280895;2422.079609748302;2439.878006099688;2447.6083826587837;2448.6571879936823;7881.842363152762;7965.64154613038;8584.098669639661;8623.525706086162;8629.22336989674;5211.583073354161;5212.192110222922;5241.449647786965;5322.281491998608;5337.5196232338885;3449.7757645752945;3533.6466353364717;3563.518924945125;3583.2654305867495;3627;1033.1166852341214;1036.6475398364591;1040.47976011994;1041.8645576075137;1042.8904964978644;11437.714057148638;11498.827517587326;11514.366709830956;11558.133140014532;11584.884151158465;4758.35255875071;4819.614430845524;4820.71075735457;4820.831270905572;4843.055604157155;9886.703398898044;9895.455749933679;9907.653232136985;9910.702678919644;9929.50352482373;4587.197240482902;5247.212918062245;5259.552938000236;5273.472652734773;5361.08861493547;4352.934705979413;4730.881727956828;4838.661293709407;4843;4861.27080937855;3853.7880416576795;3860.652541271299;3901.141748815256;3945.881623551298;3947.8618248361167;1272.5546058879318;1297.4291311822767;1305.9608211753662;1312.8621494743106;1334.292824802856;1086.4241951765578;1097.7036200225893;1104.867415910096;1344.4151793969654;1356.1727346318737;7995.040595128622;7997.640106195236;8016.278534931884;8184.058833234254;8233.300169485661;1179.675589212956;1195.5277665322149;1195.9774392894124;1210.8244304575787;1233.6422437493206;5669.809340038638;5719.428057194247;6181.690915454209;6289.150964619717;6295.464885484694;10126.392416455037;10447.05976462122;10450.11174050199;10515.3690778552;10545.156387489136;10039.849402258971;10297.485125743682;10332.431716255678;10387.169026477864;10506.789864202674;8100.270975612106;8201.71294004707;8202.138775428493;8213.753587392388;8215.219554142346;7664.693412263447;7684.423668224794;7727.150013498623;7746.225377462209;7748.728794492165;9196.35625506208;9312;9368.063193680577;9490.525473726424;9677.516124193902;9232.492212928353;9303.348765586345;9380.906190938276;9799.11807937289;9819.9018009819;5975.611585246945;6623.503237257129;7098.112735908012;7290.599017054113;7395.630218489162;8032.116467188722;8045.275925166529;8071.273585377344;8077.232662897015;8077.434579579373;7029.648517573998;7115;7124.5725256484775;7171.175314838861;7248.710051597877;6977.197622273504;7029.3673569379;7070.328318809705;7109;7140.678669459783;7467.477276590586;7560;7584.5070070445245;7618.466707330434;7646.617669116411;6860.279670634512;6875.5530890491955;6879.828004299732;6900.585964842126;6907.6891539879825;6936.930630693629;6939.479539034492;7005.474589405713;7023.051887995055;7060.152781666233 18:19:36 INFO - PROCESS | 1668 | |4;prototype.html;282.36749680715195;328.95230191622215;334.99497507537376;336.4079220571793;337.4263751622242;6824.863502729942;6891.517593768438;6940.791776246708;6962.373386395224;6995.685194166262;5424.538914192289;6850.69171887265;6870;6876.277990810968;6892.896606550906;4767.475577686451;4867.732274724889;4962.230854217602;4980.576650984671;5023.2465130230485;4954.578860796837;4970.080535100999;4984.37695288089;4992.550670439659;4994.1260279451135;4937.456879743226;4939.185034469308;4943.579795717368;4943.802247910079;4951.158303088484;4200.873973780792;4942.431620363668;4956.479569645189;4963.454020057773;5004.224345226477;3674.8346324415465;4028.879133625996;4084.407760874686;4244.129953359554;4277.828886844553;6367.8408039798915;6555.6066636002;6559.180102487189;6600.471962243009;6622.6357550334715;4747.786349614241;5929.080992446177;5955.970220148914;6007.459328660441;6019.668918209497;5586.910552442276;7244.2393548677155;7282;7282.563046217244;7300.196978332379;4772.164871147535;4786.090642777861;4810.663253572251;4813.229883218703;4814.7351895645725;7749;7763;7777.650005749698;7786.649600767979;7815.96092019542;4718.22920780347;4838.467768545457;4920.114379411741;4923.335349727812;4938.8271410501175;4126.814293356806;4955.72743499111;4989.027139707795;4993.526909561688;5003.849884503471;5925.34821169671;5928.555358348055;5935.139404786281;5942.910856337158;5964.075568286922;7324.816879578053;7330.450216233698;7344.742933997284;7360.96319518399;7365.15300740411;1719.234940451512;1733;1741.4166254304696;1741.669082874275;1742.5469377961822;1086.1310951238977;1142.6457798082622;1149.2472430557998;1157.6816375496637;1162.4885050577889;6834.726610935507;6852.486063545254;6860.6912688929115;6881.036654868322;6885.277045910208;7609.543427394374;7610.771676849703;7614.390848732199;7615.809604759815;7641.541507509456;6620.073189753439;6763.898541521881;6928.965355173192;6968.268331825187;6989.615571143534;3844.2888065707934;4028.113814960704;4067.877963661095;4068.5321188063754;4069.3895915612893;6942.236354001056;7998.320142787812;8047.557384343801;8060.717874874351;8061.6372263248295;7696.4227682924;7932.246436588515;7950.920490795133;7965.522068675898;7969.601519923981;6525.738970441224;8084.353251739847;8097.757067287991;8117.472364296302;8183.672653093929;7701.6919323228685;7734.729284475242;7747.457677962489;7752.14726380109;7763.922360776546;7595;7604;7609.695612175451;7611.3910887130005;7627.847443050997;7815.921840781747;8002.479838810459;8091.190880912097;8151.5109093454585;8189.099199088215;4747;4762.261849413347;4791.616670666269;4802;4825.131476334153;7712.575808330371;7715.57564333967;7728;7736.961315193613;7766.844663106819;5272.2882410874045;5897.233359663216;6764.830879228059;7426.257374262531;7440.218777028334;6554.57395269325;6666.666666666551;7325.670344834602;7399.704011839466;7488.288612581796;7202.819929501804;7246.456515761233;7263.564186148848;7266;7272.781816545512;5981.910271346021;7417.962910185414;7433.8141546461775;7434.107907051189;7449.776506704808;7258;7264.309890560388;7285.817854553678;7291;7309.378702810321 18:19:36 INFO - PROCESS | 1668 | |5;yui.html;651.3616655677439;675.1493118670475;684.2439104789211;735.7645553422904;760.1562265884869;14514.564563063099;14559.781603275946;14745;14810;14823;13444.462221511129;13996;14001;14009.299535023234;14015.229162396065;724.6992498113277;861.8104017116225;874.6107981948036;884.5842454046604;910.8497097978826;888.9599968001455;903.268352634365;910.6266430763388;910.7905181808188;911.9270458363314;887.973360799177;913.0595486648763;953.8092381523688;957.7414098193484;959.8416261316875;909.5088652127843;938.4041133879967;941.1153515695293;949.1220620925616;949.5110018340525;653.2063542795479;654.2508827392609;693.386353077525;704.2710794327897;709.3296834491408;10755.462226888703;12201.633950981484;12379.876201238052;14294;14853.034552754145;10473.738156546147;12643.74712505754;12863.871361286361;12897.806532902014;12976.15654982423;9738.452699158139;9964.95017524915;9990.250731195118;9992.600295988152;10258.640947566873;3346.8828590999196;3411.1642647551507;3504.684578387957;3510.1400156961454;3515.455104458813;50097.74951125257;51694;54231.91536169294;78521.21478785196;79041.60479197567;9379.099256668134;9479.383840050512;9482.715518534455;9609.711708648612;9686.273529485317;21522.78477215239;21826.253899688305;21852.562948740935;21863.016164272645;21903.780962190172;7353.154387245429;7522.924770752223;7555.584442855696;7573.053368328959;7582.734604288823;4023.959760402417;4057.857974970862;4065.837366505307;4075.7146999709735;4086.1827634473225;3193.4890417533084;3272.181954511372;3278.7868788528667;3298;3329.5505106810756;600.3156401701976;611.2878496551557;612.8529153003248;618.4773866083152;625.7497001199556;459.04518601309195;481.3453702963966;484.871509050102;549.4779959038929;561.8988582055188;7495.887561686579;7619.542827430261;7659.693612255559;7665.348445382094;7747.225277472207;513.5120341943278;516;534.8128155145668;552.2103392149265;586.0359708279941;3628.600853906068;3632.4551317302617;3658.560972683295;3697.3529632314776;3704.666580007812;74310.25689743033;77393.61303193448;78678.21321786824;79049.20950790419;79446;69237.61524769576;69373.65313173503;69902.30097698957;70181.64909175523;70280;59930.700346497986;61173.776524469264;61736.69131654313;61931.380686193464;62884;7182.820429489305;7227.638618068971;7280.67236974348;7295.051643286339;7470.850582988419;36448.27103457863;42133;44254.77872610616;46156.53843461522;46562.76718616385;60848.69575652093;60874;61848;62023.6898815503;62130.0680489784;9132.954335228282;9222.170004699608;9222.907770922473;9277.16505514507;9368.81262374735;9486.905130948602;9773.9022609773;9988.41908018672;10103.343282686601;10509.211809114195;9399.953000234955;9514.619415223313;9536.761580960254;9650.806983860142;9679.419234845931;9423.38747981379;9494.762630934005;9546.761330966781;9558.187554057982;9781;9354.391964522285;9366.110219529133;9458.29062820305;9464.621415143318;9505.524723763645;8000;8000.559969201517;8151.877721834058;8325.95837020811;8388.790280243044;8128.14654461273;8188.549629770419;8206.507609543447;8256.967879015123;8394.916050839414 18:19:36 INFO - PROCESS | 1668 | __end_tp_report 18:19:36 INFO - PROCESS | 1668 | __start_cc_report 18:19:36 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,358 18:19:36 INFO - PROCESS | 1668 | __end_cc_report 18:19:36 INFO - PROCESS | 1668 | __startTimestamp1457057976015__endTimestamp 18:19:36 INFO - PROCESS | 1668 | 18:19:36 INFO - PROCESS | 1668 | ------- Summary: start ------- 18:19:36 INFO - PROCESS | 1668 | Number of tests: 6 18:19:36 INFO - PROCESS | 1668 | 18:19:36 INFO - PROCESS | 1668 | [#0] dojo.html Cycles:165 Average:5738.80 Median:5961.46 stddev:677.89 (11.4%) stddev-sans-first:652.06 18:19:36 INFO - PROCESS | 1668 | Values: 3284.6 3510.4 3534.2 3554.5 3585.4 5637.9 5674.9 5695.1 5725.1 5743.4 4589.7 5590.6 5763.8 5928.9 5951.6 5180.4 5199.4 5265.3 5271.1 5280.1 5311.3 5348.3 5351.1 5365.6 5376.5 5106.2 5112.8 5203.2 5301.3 5336.2 5220.1 5228.7 5232.1 5245.1 5262.3 4343.3 5193.8 5201.7 5237.6 5243.2 4734.8 5607.5 5674.5 5688.7 5769.2 6270.2 6275.3 6303.1 6323.5 6325.0 6153.6 6279.7 6280.4 6302.6 6319.7 5813.0 5902.9 5919.6 5922.7 5943.6 6288.0 6308.5 6340.9 6357.5 6357.7 6112.8 6128.1 6192.2 6222.0 6238.6 5282.4 6114.5 6268.0 6303.1 6315.2 5381.2 6045.6 6101.7 6140.1 6203.9 5902.6 6129.5 6307.5 6308.0 6326.2 4848.7 4911.4 4946.6 4961.6 4998.0 3865.6 4401.2 4439.7 4452.9 4453.9 5592.9 5803.1 5816.1 5860.2 5869.6 6219.0 6237.9 6265.5 6268.6 6351.8 5901.8 5942.6 5947.8 5961.2 5974.3 4037.4 5279.2 5398.4 5418.2 5509.3 6359.5 6425.7 6448.8 6462.0 6462.2 6223.0 6275.0 6284.2 6293.1 6302.6 4910.8 6215.8 6291.9 6346.0 6390.3 6170.9 6233.1 6270.7 6271.4 6291.2 6274.7 6274.8 6283.2 6303.5 6370.2 5022.0 5961.5 6024.1 6118.5 6130.4 6127.6 6134.9 6162.4 6170.3 6179.0 5975.3 5990.6 6081.3 6096.8 6101.2 6073.4 6142.1 6171.2 6216.9 6244.8 5868.4 5931.2 5941.9 5989.9 6005.5 18:19:36 INFO - PROCESS | 1668 | 18:19:36 INFO - PROCESS | 1668 | [#1] ext.html Cycles:180 Average:63780.79 Median:37238.44 stddev:132874.99 (356.8%) stddev-sans-first:133162.63 18:19:36 INFO - PROCESS | 1668 | Values: 437.0 493.5 527.3 552.8 599.6 28939.1 37154.6 37183.4 37238.4 37240.4 38021.3 38464.8 38510.6 38600.4 38601.4 9285.1 9445.8 9509.8 9511.4 9534.9 8013.3 9517.3 9545.7 9565.2 9597.0 9454.7 9477.0 9510.3 9513.7 9576.6 9506.0 9526.1 9569.0 9572.3 9581.9 9492.1 9563.6 9568.1 9599.0 9602.4 36396.1 36551.5 36781.1 36864.1 36870.9 3219.0 3359.9 3403.6 3441.4 3620.7 27987.9 28207.2 28309.6 28342.4 28379.4 2692.4 2743.9 2747.3 2815.2 2878.6 490265.0 509206.5 509740.0 515866.0 517121.0 60503.7 61226.0 61596.0 61983.0 62408.0 65198.7 65664.0 68979.3 69620.0 70781.2 15833.4 16358.4 16521.8 16527.0 16554.8 10541.9 12435.9 12580.7 12601.7 12630.0 20226.6 20283.7 20590.7 20635.7 20650.3 8251.0 9167.7 9289.7 9494.9 9523.0 941.8 969.7 1016.4 1043.6 1075.2 28836.3 29125.0 29199.4 29260.9 29585.9 869.5 1055.3 1057.5 1083.4 1117.6 14403.5 14649.4 14799.0 14944.9 15013.6 508589.0 511882.0 512509.0 514862.0 516437.0 55751.4 55952.4 56315.4 56577.4 56798.0 1390.7 1418.9 1439.1 1447.4 1583.3 28619.7 28835.8 28902.3 28912.1 29202.3 46633.0 46939.8 46955.5 47072.3 47483.3 470486.0 475164.0 476887.0 477756.0 479568.0 32262.2 32903.5 33298.5 42177.4 43111.1 40740.6 41672.6 41881.6 41991.7 42094.0 34452.8 34886.3 35130.0 35698.9 35793.9 34008.7 34318.5 34492.8 34591.0 34979.8 30256.5 33918.8 37238.4 37904.8 38057.2 29163.4 31072.7 31164.5 31297.1 31300.4 23700.5 23987.2 24044.0 24409.1 24451.1 18:19:36 INFO - PROCESS | 1668 | 18:19:36 INFO - PROCESS | 1668 | [#2] jquery.html Cycles:180 Average:35294.87 Median:2255.84 stddev:109070.52 (4835.0%) stddev-sans-first:109344.87 18:19:36 INFO - PROCESS | 1668 | Values: 316.4 349.3 357.1 362.3 365.3 18963.0 19415.9 20004.4 20297.6 20312.9 18815.0 19243.6 19660.8 19853.7 19860.1 5048.5 5304.2 5979.6 5983.9 5984.8 4234.0 5887.4 6252.1 6530.3 6549.1 6466.2 6473.8 6476.6 6484.4 6488.1 5478.4 5749.3 5751.0 5758.8 5767.2 5224.7 5418.8 5496.8 5501.0 5508.4 11485.7 11945.9 12594.4 12722.4 12840.3 2053.1 2080.9 2245.5 2266.2 2761.4 9378.8 9499.6 9564.5 9729.6 9876.4 1709.4 1711.4 1720.6 1722.1 1731.5 100048.0 105603.5 105922.0 107507.4 108327.5 8982.0 11084.3 11150.4 11346.5 11444.7 13468.6 13474.3 13607.5 13609.5 13681.6 8238.7 8351.7 8434.6 8536.7 8571.8 8555.9 8559.2 8569.8 8660.7 8703.3 4374.6 4380.5 4386.0 4433.6 4444.6 1735.7 1806.5 1830.0 1832.6 1868.7 779.8 824.5 856.6 916.8 919.5 15542.0 16831.8 17022.9 19374.9 19610.9 720.6 817.3 964.2 972.4 1005.7 7693.4 10968.0 10975.6 11018.2 11126.8 644197.0 648063.0 664984.7 667696.0 669369.0 116112.0 116931.4 118844.0 118984.4 121680.0 1000.3 1007.0 1022.0 1022.9 1026.8 14358.2 17458.9 18096.7 18262.2 18290.0 33966.8 51081.7 52704.7 52736.7 53921.5 74625.0 74680.0 76095.6 76469.0 76553.6 7992.7 8012.9 8100.8 8306.4 8310.2 10997.8 12035.9 12372.4 12865.7 13217.5 10792.7 11053.9 11358.5 11367.7 11378.5 9479.2 10352.3 10562.3 10744.1 11385.1 11079.0 11286.8 11406.0 11428.3 11474.8 7901.7 7943.5 7965.7 7976.7 8187.1 10358.3 11235.0 11438.2 11639.3 11739.5 18:19:36 INFO - PROCESS | 1668 | 18:19:36 INFO - PROCESS | 1668 | [#3] mootools.html Cycles:180 Average:5911.86 Median:5266.51 stddev:3076.82 (58.4%) stddev-sans-first:3067.30 18:19:36 INFO - PROCESS | 1668 | Values: 1466.1 1522.7 1742.9 1873.4 1882.7 7699.3 8355.7 8389.0 8615.6 8638.4 8384.2 8409.1 8513.4 8516.6 8563.6 2423.0 2431.9 2443.3 2451.5 2461.2 2404.5 2407.9 2442.8 2448.9 2455.1 2436.4 2445.3 2463.9 2469.2 2471.9 2376.4 2385.4 2389.0 2389.7 2405.7 2377.1 2422.1 2439.9 2447.6 2448.7 7881.8 7965.6 8584.1 8623.5 8629.2 5211.6 5212.2 5241.4 5322.3 5337.5 3449.8 3533.6 3563.5 3583.3 3627.0 1033.1 1036.6 1040.5 1041.9 1042.9 11437.7 11498.8 11514.4 11558.1 11584.9 4758.4 4819.6 4820.7 4820.8 4843.1 9886.7 9895.5 9907.7 9910.7 9929.5 4587.2 5247.2 5259.6 5273.5 5361.1 4352.9 4730.9 4838.7 4843.0 4861.3 3853.8 3860.7 3901.1 3945.9 3947.9 1272.6 1297.4 1306.0 1312.9 1334.3 1086.4 1097.7 1104.9 1344.4 1356.2 7995.0 7997.6 8016.3 8184.1 8233.3 1179.7 1195.5 1196.0 1210.8 1233.6 5669.8 5719.4 6181.7 6289.2 6295.5 10126.4 10447.1 10450.1 10515.4 10545.2 10039.8 10297.5 10332.4 10387.2 10506.8 8100.3 8201.7 8202.1 8213.8 8215.2 7664.7 7684.4 7727.2 7746.2 7748.7 9196.4 9312.0 9368.1 9490.5 9677.5 9232.5 9303.3 9380.9 9799.1 9819.9 5975.6 6623.5 7098.1 7290.6 7395.6 8032.1 8045.3 8071.3 8077.2 8077.4 7029.6 7115.0 7124.6 7171.2 7248.7 6977.2 7029.4 7070.3 7109.0 7140.7 7467.5 7560.0 7584.5 7618.5 7646.6 6860.3 6875.6 6879.8 6900.6 6907.7 6936.9 6939.5 7005.5 7023.1 7060.2 18:19:36 INFO - PROCESS | 1668 | 18:19:36 INFO - PROCESS | 1668 | [#4] prototype.html Cycles:180 Average:5980.47 Median:6794.85 stddev:1947.50 (28.7%) stddev-sans-first:1905.42 18:19:36 INFO - PROCESS | 1668 | Values: 282.4 329.0 335.0 336.4 337.4 6824.9 6891.5 6940.8 6962.4 6995.7 5424.5 6850.7 6870.0 6876.3 6892.9 4767.5 4867.7 4962.2 4980.6 5023.2 4954.6 4970.1 4984.4 4992.6 4994.1 4937.5 4939.2 4943.6 4943.8 4951.2 4200.9 4942.4 4956.5 4963.5 5004.2 3674.8 4028.9 4084.4 4244.1 4277.8 6367.8 6555.6 6559.2 6600.5 6622.6 4747.8 5929.1 5956.0 6007.5 6019.7 5586.9 7244.2 7282.0 7282.6 7300.2 4772.2 4786.1 4810.7 4813.2 4814.7 7749.0 7763.0 7777.7 7786.6 7816.0 4718.2 4838.5 4920.1 4923.3 4938.8 4126.8 4955.7 4989.0 4993.5 5003.8 5925.3 5928.6 5935.1 5942.9 5964.1 7324.8 7330.5 7344.7 7361.0 7365.2 1719.2 1733.0 1741.4 1741.7 1742.5 1086.1 1142.6 1149.2 1157.7 1162.5 6834.7 6852.5 6860.7 6881.0 6885.3 7609.5 7610.8 7614.4 7615.8 7641.5 6620.1 6763.9 6929.0 6968.3 6989.6 3844.3 4028.1 4067.9 4068.5 4069.4 6942.2 7998.3 8047.6 8060.7 8061.6 7696.4 7932.2 7950.9 7965.5 7969.6 6525.7 8084.4 8097.8 8117.5 8183.7 7701.7 7734.7 7747.5 7752.1 7763.9 7595.0 7604.0 7609.7 7611.4 7627.8 7815.9 8002.5 8091.2 8151.5 8189.1 4747.0 4762.3 4791.6 4802.0 4825.1 7712.6 7715.6 7728.0 7737.0 7766.8 5272.3 5897.2 6764.8 7426.3 7440.2 6554.6 6666.7 7325.7 7399.7 7488.3 7202.8 7246.5 7263.6 7266.0 7272.8 5981.9 7418.0 7433.8 7434.1 7449.8 7258.0 7264.3 7285.8 7291.0 7309.4 18:19:36 INFO - PROCESS | 1668 | 18:19:36 INFO - PROCESS | 1668 | [#5] yui.html Cycles:180 Average:16094.12 Median:70230.82 stddev:22025.89 (31.4%) stddev-sans-first:22057.15 18:19:36 INFO - PROCESS | 1668 | Values: 651.4 675.1 684.2 735.8 760.2 14514.6 14559.8 14745.0 14810.0 14823.0 13444.5 13996.0 14001.0 14009.3 14015.2 724.7 861.8 874.6 884.6 910.8 889.0 903.3 910.6 910.8 911.9 888.0 913.1 953.8 957.7 959.8 909.5 938.4 941.1 949.1 949.5 653.2 654.3 693.4 704.3 709.3 10755.5 12201.6 12379.9 14294.0 14853.0 10473.7 12643.7 12863.9 12897.8 12976.2 9738.5 9965.0 9990.3 9992.6 10258.6 3346.9 3411.2 3504.7 3510.1 3515.5 50097.7 51694.0 54231.9 78521.2 79041.6 9379.1 9479.4 9482.7 9609.7 9686.3 21522.8 21826.3 21852.6 21863.0 21903.8 7353.2 7522.9 7555.6 7573.1 7582.7 4024.0 4057.9 4065.8 4075.7 4086.2 3193.5 3272.2 3278.8 3298.0 3329.6 600.3 611.3 612.9 618.5 625.7 459.0 481.3 484.9 549.5 561.9 7495.9 7619.5 7659.7 7665.3 7747.2 513.5 516.0 534.8 552.2 586.0 3628.6 3632.5 3658.6 3697.4 3704.7 74310.3 77393.6 78678.2 79049.2 79446.0 69237.6 69373.7 69902.3 70181.6 70280.0 59930.7 61173.8 61736.7 61931.4 62884.0 7182.8 7227.6 7280.7 7295.1 7470.9 36448.3 42133.0 44254.8 46156.5 46562.8 60848.7 60874.0 61848.0 62023.7 62130.1 9133.0 9222.2 9222.9 9277.2 9368.8 9486.9 9773.9 9988.4 10103.3 10509.2 9400.0 9514.6 9536.8 9650.8 9679.4 9423.4 9494.8 9546.8 9558.2 9781.0 9354.4 9366.1 9458.3 9464.6 9505.5 8000.0 8000.6 8151.9 8326.0 8388.8 8128.1 8188.5 8206.5 8257.0 8394.9 18:19:36 INFO - PROCESS | 1668 | -------- Summary: end -------- 18:19:36 INFO - PROCESS | 1668 | 18:19:36 INFO - TEST-INFO | 1668: exit 0 18:19:36 INFO - TEST-OK | dromaeo_css | took 1110570ms 18:19:36 INFO - TEST-START | kraken 18:19:36 INFO - operating with platform_type : mac_ 18:19:36 INFO - Initialising browser for kraken test... 18:19:36 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/tmpvafQ0d/profile http://localhost:49271/getInfo.html) 18:19:39 INFO - PROCESS | 1680 | __metrics Screen width/height:1600/1200 18:19:39 INFO - PROCESS | 1680 | colorDepth:24 18:19:39 INFO - PROCESS | 1680 | Browser inner width/height: 1024/689 18:19:39 INFO - PROCESS | 1680 | __metrics 18:19:39 ERROR - PROCESS | 1680 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 18:19:39 INFO - TEST-INFO | 1680: exit 0 18:19:39 INFO - Browser initialized. 18:19:39 INFO - Running cycle 1/1 for kraken test... 18:19:39 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/tmpvafQ0d/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:19:51 INFO - PROCESS | 1683 | RSS: Main: 255492096 18:19:51 INFO - PROCESS | 1683 | 18:19:54 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 18:19:55 INFO - PROCESS | 1683 | RSS: Main: 268177408 18:19:55 INFO - PROCESS | 1683 | 18:19:57 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 18:19:58 INFO - PROCESS | 1683 | RSS: Main: 276844544 18:19:58 INFO - PROCESS | 1683 | 18:20:01 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 18:20:02 INFO - PROCESS | 1683 | RSS: Main: 281182208 18:20:02 INFO - PROCESS | 1683 | 18:20:04 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 18:20:04 INFO - PROCESS | 1683 | RSS: Main: 280940544 18:20:04 INFO - PROCESS | 1683 | 18:20:06 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:20:07 INFO - PROCESS | 1683 | RSS: Main: 281677824 18:20:07 INFO - PROCESS | 1683 | 18:20:10 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 18:20:10 INFO - PROCESS | 1683 | RSS: Main: 283930624 18:20:10 INFO - PROCESS | 1683 | 18:20:13 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 18:20:14 INFO - PROCESS | 1683 | RSS: Main: 283267072 18:20:14 INFO - PROCESS | 1683 | 18:20:17 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 18:20:18 INFO - PROCESS | 1683 | RSS: Main: 283566080 18:20:18 INFO - PROCESS | 1683 | 18:20:19 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:20:20 INFO - PROCESS | 1683 | RSS: Main: 283955200 18:20:20 INFO - PROCESS | 1683 | 18:20:22 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:20:22 INFO - PROCESS | 1683 | RSS: Main: 282001408 18:20:22 INFO - PROCESS | 1683 | 18:20:25 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:20:25 INFO - PROCESS | 1683 | RSS: Main: 282324992 18:20:25 INFO - PROCESS | 1683 | 18:20:28 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:20:28 INFO - PROCESS | 1683 | RSS: Main: 282390528 18:20:28 INFO - PROCESS | 1683 | 18:20:31 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:20:31 INFO - PROCESS | 1683 | RSS: Main: 284282880 18:20:31 INFO - PROCESS | 1683 | 18:20:33 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 18:20:34 INFO - PROCESS | 1683 | RSS: Main: 285929472 18:20:34 INFO - PROCESS | 1683 | 18:20:34 INFO - PROCESS | 1683 | __start_tp_report 18:20:34 INFO - PROCESS | 1683 | _x_x_mozilla_page_load 18:20:34 INFO - PROCESS | 1683 | _x_x_mozilla_page_load_details 18:20:34 INFO - PROCESS | 1683 | |i|pagename|runs| 18:20:34 INFO - PROCESS | 1683 | |0;ai-astar;114;106;115;113;117;135;169;167;113;114 18:20:34 INFO - PROCESS | 1683 | |1;audio-beat-detection;159;118;148;154;121;143;138;123;160;129 18:20:34 INFO - PROCESS | 1683 | |2;audio-dft;190;227;266;209;217;199;201;199;200;199 18:20:34 INFO - PROCESS | 1683 | |3;audio-fft;70;70;70;115;55;54;60;58;84;56 18:20:34 INFO - PROCESS | 1683 | |4;audio-oscillator;83;80;122;78;82;82;115;77;83;111 18:20:34 INFO - PROCESS | 1683 | |5;imaging-gaussian-blur;91;86;88;86;89;85;89;86;88;114 18:20:34 INFO - PROCESS | 1683 | |6;imaging-darkroom;138;149;93;95;109;88;91;95;150;149 18:20:34 INFO - PROCESS | 1683 | |7;imaging-desaturate;87;93;113;143;142;99;91;91;92;90 18:20:34 INFO - PROCESS | 1683 | |8;json-parse-financial;55;57;60;74;85;85;71;88;58;54 18:20:34 INFO - PROCESS | 1683 | |9;json-stringify-tinderbox;66;66;91;106;67;94;104;99;90;70 18:20:34 INFO - PROCESS | 1683 | |10;stanford-crypto-aes;88;86;83;85;85;86;85;87;83;87 18:20:34 INFO - PROCESS | 1683 | |11;stanford-crypto-ccm;134;134;139;122;136;136;137;125;138;139 18:20:34 INFO - PROCESS | 1683 | |12;stanford-crypto-pbkdf2;143;142;142;141;136;130;140;139;143;140 18:20:34 INFO - PROCESS | 1683 | |13;stanford-crypto-sha256-iterative;67;75;86;98;104;65;59;96;96;93 18:20:34 INFO - PROCESS | 1683 | __end_tp_report 18:20:34 INFO - PROCESS | 1683 | __start_cc_report 18:20:34 INFO - PROCESS | 1683 | _x_x_mozilla_cycle_collect,904 18:20:34 INFO - PROCESS | 1683 | __end_cc_report 18:20:34 INFO - PROCESS | 1683 | __startTimestamp1457058034096__endTimestamp 18:20:34 INFO - PROCESS | 1683 | 18:20:34 INFO - PROCESS | 1683 | ------- Summary: start ------- 18:20:34 INFO - PROCESS | 1683 | Number of tests: 14 18:20:34 INFO - PROCESS | 1683 | 18:20:34 INFO - PROCESS | 1683 | [#0] ai-astar Cycles:10 Average:126.30 Median:116.00 stddev:23.19 (20.0%) stddev-sans-first:24.16 18:20:34 INFO - PROCESS | 1683 | Values: 114.0 106.0 115.0 113.0 117.0 135.0 169.0 167.0 113.0 114.0 18:20:34 INFO - PROCESS | 1683 | 18:20:34 INFO - PROCESS | 1683 | [#1] audio-beat-detection Cycles:10 Average:139.30 Median:145.50 stddev:15.93 (10.9%) stddev-sans-first:15.22 18:20:34 INFO - PROCESS | 1683 | Values: 159.0 118.0 148.0 154.0 121.0 143.0 138.0 123.0 160.0 129.0 18:20:34 INFO - PROCESS | 1683 | 18:20:34 INFO - PROCESS | 1683 | [#2] audio-dft Cycles:10 Average:210.70 Median:205.00 stddev:22.15 (10.8%) stddev-sans-first:22.19 18:20:34 INFO - PROCESS | 1683 | Values: 190.0 227.0 266.0 209.0 217.0 199.0 201.0 199.0 200.0 199.0 18:20:34 INFO - PROCESS | 1683 | 18:20:34 INFO - PROCESS | 1683 | [#3] audio-fft Cycles:10 Average:69.20 Median:65.00 stddev:18.67 (28.7%) stddev-sans-first:19.80 18:20:34 INFO - PROCESS | 1683 | Values: 70.0 70.0 70.0 115.0 55.0 54.0 60.0 58.0 84.0 56.0 18:20:34 INFO - PROCESS | 1683 | 18:20:34 INFO - PROCESS | 1683 | [#4] audio-oscillator Cycles:10 Average:91.30 Median:81.00 stddev:17.36 (21.4%) stddev-sans-first:18.15 18:20:34 INFO - PROCESS | 1683 | Values: 83.0 80.0 122.0 78.0 82.0 82.0 115.0 77.0 83.0 111.0 18:20:34 INFO - PROCESS | 1683 | 18:20:34 INFO - PROCESS | 1683 | [#5] imaging-gaussian-blur Cycles:10 Average:90.20 Median:88.00 stddev:8.56 (9.7%) stddev-sans-first:9.08 18:20:34 INFO - PROCESS | 1683 | Values: 91.0 86.0 88.0 86.0 89.0 85.0 89.0 86.0 88.0 114.0 18:20:34 INFO - PROCESS | 1683 | 18:20:34 INFO - PROCESS | 1683 | [#6] imaging-darkroom Cycles:10 Average:115.70 Median:89.50 stddev:27.26 (30.5%) stddev-sans-first:27.69 18:20:34 INFO - PROCESS | 1683 | Values: 138.0 149.0 93.0 95.0 109.0 88.0 91.0 95.0 150.0 149.0 18:20:34 INFO - PROCESS | 1683 | 18:20:34 INFO - PROCESS | 1683 | [#7] imaging-desaturate Cycles:10 Average:104.10 Median:91.00 stddev:21.50 (23.6%) stddev-sans-first:21.89 18:20:34 INFO - PROCESS | 1683 | Values: 87.0 93.0 113.0 143.0 142.0 99.0 91.0 91.0 92.0 90.0 18:20:34 INFO - PROCESS | 1683 | 18:20:34 INFO - PROCESS | 1683 | [#8] json-parse-financial Cycles:10 Average:68.70 Median:72.50 stddev:13.61 (18.8%) stddev-sans-first:13.51 18:20:34 INFO - PROCESS | 1683 | Values: 55.0 57.0 60.0 74.0 85.0 85.0 71.0 88.0 58.0 54.0 18:20:34 INFO - PROCESS | 1683 | 18:20:34 INFO - PROCESS | 1683 | [#9] json-stringify-tinderbox Cycles:10 Average:85.30 Median:80.00 stddev:16.36 (20.5%) stddev-sans-first:15.80 18:20:34 INFO - PROCESS | 1683 | Values: 66.0 66.0 91.0 106.0 67.0 94.0 104.0 99.0 90.0 70.0 18:20:34 INFO - PROCESS | 1683 | 18:20:34 INFO - PROCESS | 1683 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:86.00 stddev:1.65 (1.9%) stddev-sans-first:1.48 18:20:34 INFO - PROCESS | 1683 | Values: 88.0 86.0 83.0 85.0 85.0 86.0 85.0 87.0 83.0 87.0 18:20:34 INFO - PROCESS | 1683 | 18:20:34 INFO - PROCESS | 1683 | [#11] stanford-crypto-ccm Cycles:10 Average:134.00 Median:136.50 stddev:5.85 (4.3%) stddev-sans-first:6.20 18:20:34 INFO - PROCESS | 1683 | Values: 134.0 134.0 139.0 122.0 136.0 136.0 137.0 125.0 138.0 139.0 18:20:34 INFO - PROCESS | 1683 | 18:20:34 INFO - PROCESS | 1683 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.60 Median:141.50 stddev:3.98 (2.8%) stddev-sans-first:4.02 18:20:34 INFO - PROCESS | 1683 | Values: 143.0 142.0 142.0 141.0 136.0 130.0 140.0 139.0 143.0 140.0 18:20:34 INFO - PROCESS | 1683 | 18:20:34 INFO - PROCESS | 1683 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:83.90 Median:89.50 stddev:16.07 (18.0%) stddev-sans-first:15.84 18:20:34 INFO - PROCESS | 1683 | Values: 67.0 75.0 86.0 98.0 104.0 65.0 59.0 96.0 96.0 93.0 18:20:34 INFO - PROCESS | 1683 | -------- Summary: end -------- 18:20:34 INFO - PROCESS | 1683 | 18:20:34 INFO - TEST-INFO | 1683: exit 0 18:20:34 INFO - TEST-OK | kraken | took 58292ms 18:20:34 INFO - SUITE-END | took 1168s 18:20:35 INFO - Completed test suite (00:19:29) 18:20:35 INFO - Working with test: dromaeo_css 18:20:35 INFO - Generating results file: dromaeo_css 18:20:35 INFO - Working with test: kraken 18:20:35 INFO - Generating results file: kraken 18:20:35 INFO - javascript benchmark 18:20:35 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:20:35 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 18:20:35 INFO - process_Request line: dromaeo_css 7409.20 graph.html#tests=[[72,64,61]] 18:20:35 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:20:35 INFO - process_Request line: kraken 1543.80 graph.html#tests=[[232,64,61]] 18:20:35 INFO - RETURN: dromaeo_css: 7409.20 18:20:35 INFO - RETURN: kraken: 1543.80 18:20:35 INFO - javascript benchmark 18:20:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3284.62226843913, 3510.4032314506517, 3534.2048039191186, 3554.5023696682483, 3585.4084076127433, 5637.9436205637985, 5674.914876276859, 5695.145728140781, 5725.112607545827, 5743.3682294947575, 4589.724616523011, 5590.636608620437, 5763.769449222036, 5928.932792097421, 5951.642901425917, 5180.352455943007, 5199.376074871011, 5265.289185959885, 5271.051210782058, 5280.102382594949, 5311.267773927596, 5348.277982472375, 5351.117065684177, 5365.597580181482, 5376.462353764612, 5106.208537676666, 5112.769925353368, 5203.178887389384, 5301.3373328333955, 5336.17289320156, 5220.060389129955, 5228.660137091077, 5232.084385232569, 5245.082110630625, 5262.289590905217, 4343.348497725335, 5193.766280517386, 5201.713905735183, 5237.580993520547, 5243.161094224905, 4734.810607575693, 5607.495325420732, 5674.546036317126, 5688.658680479184, 5769.163471296681, 6270.216222972129, 6275.341089185616, 6303.117563541108, 6323.462505687022, 6324.956382196932, 6153.569250152491, 6279.6860156992425, 6280.425025739471, 6302.590331628476, 6319.684015799192, 5812.953668339697, 5902.911456328158, 5919.55603329752, 5922.674252916045, 5943.613665111797, 6288.0, 6308.495320374359, 6340.904886426707, 6357.523185761086, 6357.682115894279, 6112.847178820565, 6128.142060111588, 6192.225971753531, 6222.0, 6238.625682458976, 5282.366116066097, 6114.510272098727, 6268.028455589391, 6303.149074874925, 6315.210598675166, 5381.165919282517, 6045.625111680288, 6101.694915254219, 6140.078988151813, 6203.906941395882, 5902.557308201902, 6129.48104857405, 6307.495400368051, 6308.0, 6326.177596912464, 4848.660593758403, 4911.386076740408, 4946.604271658259, 4961.553460188528, 4998.0, 3865.555461121951, 4401.163778882003, 4439.667024973075, 4452.866414007585, 4453.888652783707, 5592.916106258409, 5803.129530570448, 5816.098504731774, 5860.208871802252, 5869.618474799125, 6218.973869311603, 6237.937620623827, 6265.498760099181, 6268.561200715997, 6351.809445716636, 5901.76392944286, 5942.64344139353, 5947.791827286024, 5961.165436838846, 5974.253218347707, 4037.414574886625, 5279.155335146358, 5398.352197736297, 5418.187271909245, 5509.283793106871, 6359.523035772336, 6425.710843012076, 6448.774292899726, 6461.999999999906, 6462.224533056064, 6222.968885155546, 6274.968625156845, 6284.183056202664, 6293.087502312231, 6302.558820882494, 4910.803567857389, 6215.844603884939, 6291.874162516816, 6345.968270158804, 6390.265119511129, 6170.938290617037, 6233.127362169209, 6270.655113968775, 6271.404216599416, 6291.245050593958, 6274.6548939808745, 6274.811755647338, 6283.151774510383, 6303.527235457451, 6370.235571731422, 5021.977366295987, 5961.463468287875, 6024.096385542029, 6118.4668989547035, 6130.417610327012, 6127.647695153045, 6134.926457743815, 6162.445379915829, 6170.290416602148, 6178.969105154625, 5975.312839023568, 5990.610610310316, 6081.300650425258, 6096.75612975476, 6101.2068431105445, 6073.423024812636, 6142.1304578115505, 6171.228596425447, 6216.937830621817, 6244.750209991549, 5868.354481007171, 5931.228940237914, 5941.91087133702, 5989.850253743692, 6005.549583781147], "unit": "score", "name": "dojo.html", "value": 5697.666320025097}, {"lowerIsBetter": false, "replicates": [436.98183233066936, 493.4867737552945, 527.2907938822283, 552.8059391713896, 599.5563283170454, 28939.131826045224, 37154.62845371546, 37183.44224836623, 37238.441423378674, 37240.441393379086, 38021.33850630457, 38464.80767596158, 38510.61489385105, 38600.420993685046, 38601.42097868534, 9285.071492850711, 9445.81108377832, 9509.80980380392, 9511.429314241133, 9534.856977145313, 8013.278804907557, 9517.333786634937, 9545.71132897057, 9565.186959108483, 9596.952015239915, 9454.669086581971, 9477.0, 9510.28672849539, 9513.714588562354, 9576.569054392534, 9506.0, 9526.095020972996, 9568.95215523918, 9572.32993690442, 9581.856272155923, 9492.145706886344, 9563.617455301779, 9568.138867501959, 9599.0, 9602.423854568748, 36396.090097747765, 36551.4517282241, 36781.08047298812, 36864.078398039994, 36870.89387318385, 3219.025290221747, 3359.8779314162166, 3403.5745531808525, 3441.3633477806434, 3620.746547741659, 27987.880484780788, 28207.153785386265, 28309.57535636967, 28342.433151337063, 28379.432411351656, 2692.380752426933, 2743.903963361293, 2747.2994386431333, 2815.225812901448, 2878.6401699787525, 490265.0, 509206.4539677315, 509740.0, 515866.0, 517121.0, 60503.69748151319, 61226.0, 61596.0, 61983.0, 62408.0, 65198.67400662966, 65664.0, 68979.3102068983, 69620.0, 70781.23046923868, 15833.366665333488, 16358.427455039016, 16521.83478165203, 16527.0, 16554.751678724828, 10541.894581054245, 12435.875641243652, 12580.685482862818, 12601.747965040648, 12630.0, 20226.595468090556, 20283.695744563844, 20590.691139632916, 20635.69046464304, 20650.277240296517, 8250.968628921384, 9167.679131230376, 9289.674861379819, 9494.857577136348, 9523.0, 941.7975135345933, 969.6945462179391, 1016.4307987527009, 1043.5669197283194, 1075.1828610256105, 28836.279093022844, 29124.980625678, 29199.41601167965, 29260.853695731385, 29585.852070739507, 869.4652788535132, 1055.2824079625775, 1057.5399701130034, 1083.4257843343041, 1117.6479408986143, 14403.495877644442, 14649.414023439156, 14799.038062525902, 14944.925275373553, 15013.624659383602, 508589.0, 511882.0, 512509.0, 514862.0, 516437.0, 55751.442485574626, 55952.44047559554, 56315.43684563102, 56577.43422565804, 56798.0, 1390.6592884743302, 1418.907770994882, 1439.100562148657, 1447.370393878645, 1583.3033465275473, 28619.713802861705, 28835.83304786471, 28902.277443064093, 28912.132636020953, 29202.269943251587, 46633.0, 46939.76530117328, 46955.53044469511, 47072.29391559198, 47483.28775068308, 470486.0, 475164.0, 476887.0, 477756.0, 479568.0, 32262.19344516406, 32903.506447402826, 33298.5005224917, 42177.36733949055, 43111.137777244905, 40740.59259407368, 41672.58327416687, 41881.581184187766, 41991.740247792615, 42094.0, 34452.82773586116, 34886.30227395488, 35130.0, 35698.929032129075, 35793.92618221458, 34008.65991340055, 34318.48522272118, 34492.82753586216, 34590.96227113191, 34979.82510087433, 30256.54615180818, 33918.8304058488, 37238.44142337813, 37904.810475947445, 38057.238855223295, 29163.416731664824, 31072.689273107884, 31164.532532011584, 31297.061088167393, 31300.37399252048, 23700.52598948046, 23987.160449384188, 24044.038238470966, 24409.145679901118, 24451.144209952567], "unit": "score", "name": "ext.html", "value": 19454.918048855907}, {"lowerIsBetter": false, "replicates": [316.44621911654605, 349.3118556443805, 357.10188874979434, 362.34234863722344, 365.2639930539961, 18963.0, 19415.902920485394, 20004.399868003948, 20297.594048119066, 20312.89843550782, 18815.0, 19243.615127697438, 19660.820350778962, 19853.702194467096, 19860.106295216712, 5048.469910659373, 5304.177852432879, 5979.581429299951, 5983.880322393571, 5984.790532331369, 4234.026173979971, 5887.411258874121, 6252.124702541648, 6530.314316996718, 6549.148610680605, 6466.159399278087, 6473.769983703105, 6476.579022363531, 6484.383983521558, 6488.059231411443, 5478.369987451434, 5749.252597162384, 5751.0, 5758.79844205455, 5767.163761254616, 5224.73876306187, 5418.810341638064, 5496.780128794843, 5501.037318469252, 5508.4491550845, 11485.712857178554, 11945.865142811419, 12594.37028148589, 12722.427490762939, 12840.293783841886, 2053.147943603403, 2080.937571872846, 2245.4733163913747, 2266.2068276103396, 2761.406297646016, 9378.812423751555, 9499.572519236652, 9564.473953932531, 9729.562169702309, 9876.35803672759, 1709.4102534625533, 1711.4181178399404, 1720.587059105818, 1722.0872937343229, 1731.471901070173, 100047.96642350311, 105603.47198264036, 105922.0, 107507.38738918923, 108327.45836270768, 8982.0, 11084.279521831055, 11150.386728729998, 11346.546138154546, 11444.656660300205, 13468.595942121752, 13474.258915759532, 13607.455701771818, 13609.455621775018, 13681.589552313446, 8238.711645092393, 8351.749447516584, 8434.620442079999, 8536.70121545743, 8571.785705357415, 8555.914440855511, 8559.186877246651, 8569.78575535604, 8660.653573857102, 8703.303735701129, 4374.62815660666, 4380.496242932039, 4385.978070109629, 4433.578810013044, 4444.622207112432, 1735.739639054152, 1806.530302121458, 1829.954251143732, 1832.58766777474, 1868.7103498957683, 779.8497216605462, 824.4929368438367, 856.648774002656, 916.7937214126769, 919.4850883505259, 15542.0, 16831.831681683027, 17022.914885425493, 19374.90312548428, 19610.901945490183, 720.6360787802231, 817.3012074676067, 964.2093483343731, 972.4311277902365, 1005.6580762540772, 7693.384529237647, 10967.95804398581, 10975.615853445091, 11018.228723989405, 11126.833097503544, 644197.0, 648063.0, 664984.7003059912, 667696.0, 669369.0, 116112.0, 116931.41534292274, 118844.0, 118984.40507797405, 121680.0, 1000.3447741729179, 1006.993006993007, 1021.9576032446863, 1022.948852557384, 1026.8357062870055, 14358.210298433687, 17458.912705436393, 18096.72854907151, 18262.17820198121, 18289.99405032736, 33966.83016584901, 51081.74459127829, 52704.736476317375, 52736.73631631817, 53921.460785391646, 74625.0, 74680.0, 76095.61952190426, 76469.0, 76553.61723191348, 7992.720254791287, 8012.919870801217, 8100.83798324042, 8306.377021723274, 8310.168983101641, 10997.835032474679, 12035.939820301193, 12372.4432400544, 12865.678358041125, 13217.537386191438, 10792.730181745519, 11053.889461105286, 11358.488868000795, 11367.658970230907, 11378.487968041623, 9479.194268487256, 10352.275340726077, 10562.31344962575, 10744.140468762324, 11385.089192864385, 11079.0, 11286.774264514828, 11406.0, 11428.314301141958, 11474.827877581676, 7901.723439679584, 7943.4836735612, 7965.721199757981, 7976.680932762857, 8187.058488273925, 10358.326708763907, 11235.045021173291, 11438.199326047097, 11639.301641901513, 11739.471723772622], "unit": "score", "name": "jquery.html", "value": 9092.633732528318}, {"lowerIsBetter": false, "replicates": [1466.1276540458427, 1522.6574020845312, 1742.9215685294162, 1873.4473330367532, 1882.6893562562177, 7699.345555627764, 8355.749327520183, 8388.958055209723, 8615.56922153893, 8638.438501497407, 8384.161583841613, 8409.075001749803, 8513.361497887652, 8516.61675224615, 8563.61463734132, 2423.030787684927, 2431.878406079689, 2443.315871555967, 2451.460678650694, 2461.237016524874, 2404.483036147228, 2407.879606019701, 2442.792362649177, 2448.865312407817, 2455.1407007547305, 2436.3543660929868, 2445.3397582652674, 2463.876806159694, 2469.234537293436, 2471.851688898663, 2376.3583832365166, 2385.355953892448, 2389.0443822470975, 2389.6773935518745, 2405.7113146422366, 2377.108584280895, 2422.079609748302, 2439.878006099688, 2447.6083826587837, 2448.6571879936823, 7881.842363152762, 7965.64154613038, 8584.098669639661, 8623.525706086162, 8629.22336989674, 5211.583073354161, 5212.192110222922, 5241.449647786965, 5322.281491998608, 5337.5196232338885, 3449.7757645752945, 3533.6466353364717, 3563.518924945125, 3583.2654305867495, 3627.0, 1033.1166852341214, 1036.6475398364591, 1040.47976011994, 1041.8645576075137, 1042.8904964978644, 11437.714057148638, 11498.827517587326, 11514.366709830956, 11558.133140014532, 11584.884151158465, 4758.35255875071, 4819.614430845524, 4820.71075735457, 4820.831270905572, 4843.055604157155, 9886.703398898044, 9895.455749933679, 9907.653232136985, 9910.702678919644, 9929.50352482373, 4587.197240482902, 5247.212918062245, 5259.552938000236, 5273.472652734773, 5361.08861493547, 4352.934705979413, 4730.881727956828, 4838.661293709407, 4843.0, 4861.27080937855, 3853.7880416576795, 3860.652541271299, 3901.141748815256, 3945.881623551298, 3947.8618248361167, 1272.5546058879318, 1297.4291311822767, 1305.9608211753662, 1312.8621494743106, 1334.292824802856, 1086.4241951765578, 1097.7036200225893, 1104.867415910096, 1344.4151793969654, 1356.1727346318737, 7995.040595128622, 7997.640106195236, 8016.278534931884, 8184.058833234254, 8233.300169485661, 1179.675589212956, 1195.5277665322149, 1195.9774392894124, 1210.8244304575787, 1233.6422437493206, 5669.809340038638, 5719.428057194247, 6181.690915454209, 6289.150964619717, 6295.464885484694, 10126.392416455037, 10447.05976462122, 10450.11174050199, 10515.3690778552, 10545.156387489136, 10039.849402258971, 10297.485125743682, 10332.431716255678, 10387.169026477864, 10506.789864202674, 8100.270975612106, 8201.71294004707, 8202.138775428493, 8213.753587392388, 8215.219554142346, 7664.693412263447, 7684.423668224794, 7727.150013498623, 7746.225377462209, 7748.728794492165, 9196.35625506208, 9312.0, 9368.063193680577, 9490.525473726424, 9677.516124193902, 9232.492212928353, 9303.348765586345, 9380.906190938276, 9799.11807937289, 9819.9018009819, 5975.611585246945, 6623.503237257129, 7098.112735908012, 7290.599017054113, 7395.630218489162, 8032.116467188722, 8045.275925166529, 8071.273585377344, 8077.232662897015, 8077.434579579373, 7029.648517573998, 7115.0, 7124.5725256484775, 7171.175314838861, 7248.710051597877, 6977.197622273504, 7029.3673569379, 7070.328318809705, 7109.0, 7140.678669459783, 7467.477276590586, 7560.0, 7584.5070070445245, 7618.466707330434, 7646.617669116411, 6860.279670634512, 6875.5530890491955, 6879.828004299732, 6900.585964842126, 6907.6891539879825, 6936.930630693629, 6939.479539034492, 7005.474589405713, 7023.051887995055, 7060.152781666233], "unit": "score", "name": "mootools.html", "value": 4850.362572566566}, {"lowerIsBetter": false, "replicates": [282.36749680715195, 328.95230191622215, 334.99497507537376, 336.4079220571793, 337.4263751622242, 6824.863502729942, 6891.517593768438, 6940.791776246708, 6962.373386395224, 6995.685194166262, 5424.538914192289, 6850.69171887265, 6870.0, 6876.277990810968, 6892.896606550906, 4767.475577686451, 4867.732274724889, 4962.230854217602, 4980.576650984671, 5023.2465130230485, 4954.578860796837, 4970.080535100999, 4984.37695288089, 4992.550670439659, 4994.1260279451135, 4937.456879743226, 4939.185034469308, 4943.579795717368, 4943.802247910079, 4951.158303088484, 4200.873973780792, 4942.431620363668, 4956.479569645189, 4963.454020057773, 5004.224345226477, 3674.8346324415465, 4028.879133625996, 4084.407760874686, 4244.129953359554, 4277.828886844553, 6367.8408039798915, 6555.6066636002, 6559.180102487189, 6600.471962243009, 6622.6357550334715, 4747.786349614241, 5929.080992446177, 5955.970220148914, 6007.459328660441, 6019.668918209497, 5586.910552442276, 7244.2393548677155, 7282.0, 7282.563046217244, 7300.196978332379, 4772.164871147535, 4786.090642777861, 4810.663253572251, 4813.229883218703, 4814.7351895645725, 7749.0, 7763.0, 7777.650005749698, 7786.649600767979, 7815.96092019542, 4718.22920780347, 4838.467768545457, 4920.114379411741, 4923.335349727812, 4938.8271410501175, 4126.814293356806, 4955.72743499111, 4989.027139707795, 4993.526909561688, 5003.849884503471, 5925.34821169671, 5928.555358348055, 5935.139404786281, 5942.910856337158, 5964.075568286922, 7324.816879578053, 7330.450216233698, 7344.742933997284, 7360.96319518399, 7365.15300740411, 1719.234940451512, 1733.0, 1741.4166254304696, 1741.669082874275, 1742.5469377961822, 1086.1310951238977, 1142.6457798082622, 1149.2472430557998, 1157.6816375496637, 1162.4885050577889, 6834.726610935507, 6852.486063545254, 6860.6912688929115, 6881.036654868322, 6885.277045910208, 7609.543427394374, 7610.771676849703, 7614.390848732199, 7615.809604759815, 7641.541507509456, 6620.073189753439, 6763.898541521881, 6928.965355173192, 6968.268331825187, 6989.615571143534, 3844.2888065707934, 4028.113814960704, 4067.877963661095, 4068.5321188063754, 4069.3895915612893, 6942.236354001056, 7998.320142787812, 8047.557384343801, 8060.717874874351, 8061.6372263248295, 7696.4227682924, 7932.246436588515, 7950.920490795133, 7965.522068675898, 7969.601519923981, 6525.738970441224, 8084.353251739847, 8097.757067287991, 8117.472364296302, 8183.672653093929, 7701.6919323228685, 7734.729284475242, 7747.457677962489, 7752.14726380109, 7763.922360776546, 7595.0, 7604.0, 7609.695612175451, 7611.3910887130005, 7627.847443050997, 7815.921840781747, 8002.479838810459, 8091.190880912097, 8151.5109093454585, 8189.099199088215, 4747.0, 4762.261849413347, 4791.616670666269, 4802.0, 4825.131476334153, 7712.575808330371, 7715.57564333967, 7728.0, 7736.961315193613, 7766.844663106819, 5272.2882410874045, 5897.233359663216, 6764.830879228059, 7426.257374262531, 7440.218777028334, 6554.57395269325, 6666.666666666551, 7325.670344834602, 7399.704011839466, 7488.288612581796, 7202.819929501804, 7246.456515761233, 7263.564186148848, 7266.0, 7272.781816545512, 5981.910271346021, 7417.962910185414, 7433.8141546461775, 7434.107907051189, 7449.776506704808, 7258.0, 7264.309890560388, 7285.817854553678, 7291.0, 7309.378702810321], "unit": "score", "name": "prototype.html", "value": 5331.815447821567}, {"lowerIsBetter": false, "replicates": [651.3616655677439, 675.1493118670475, 684.2439104789211, 735.7645553422904, 760.1562265884869, 14514.564563063099, 14559.781603275946, 14745.0, 14810.0, 14823.0, 13444.462221511129, 13996.0, 14001.0, 14009.299535023234, 14015.229162396065, 724.6992498113277, 861.8104017116225, 874.6107981948036, 884.5842454046604, 910.8497097978826, 888.9599968001455, 903.268352634365, 910.6266430763388, 910.7905181808188, 911.9270458363314, 887.973360799177, 913.0595486648763, 953.8092381523688, 957.7414098193484, 959.8416261316875, 909.5088652127843, 938.4041133879967, 941.1153515695293, 949.1220620925616, 949.5110018340525, 653.2063542795479, 654.2508827392609, 693.386353077525, 704.2710794327897, 709.3296834491408, 10755.462226888703, 12201.633950981484, 12379.876201238052, 14294.0, 14853.034552754145, 10473.738156546147, 12643.74712505754, 12863.871361286361, 12897.806532902014, 12976.15654982423, 9738.452699158139, 9964.95017524915, 9990.250731195118, 9992.600295988152, 10258.640947566873, 3346.8828590999196, 3411.1642647551507, 3504.684578387957, 3510.1400156961454, 3515.455104458813, 50097.74951125257, 51694.0, 54231.91536169294, 78521.21478785196, 79041.60479197567, 9379.099256668134, 9479.383840050512, 9482.715518534455, 9609.711708648612, 9686.273529485317, 21522.78477215239, 21826.253899688305, 21852.562948740935, 21863.016164272645, 21903.780962190172, 7353.154387245429, 7522.924770752223, 7555.584442855696, 7573.053368328959, 7582.734604288823, 4023.959760402417, 4057.857974970862, 4065.837366505307, 4075.7146999709735, 4086.1827634473225, 3193.4890417533084, 3272.181954511372, 3278.7868788528667, 3298.0, 3329.5505106810756, 600.3156401701976, 611.2878496551557, 612.8529153003248, 618.4773866083152, 625.7497001199556, 459.04518601309195, 481.3453702963966, 484.871509050102, 549.4779959038929, 561.8988582055188, 7495.887561686579, 7619.542827430261, 7659.693612255559, 7665.348445382094, 7747.225277472207, 513.5120341943278, 516.0, 534.8128155145668, 552.2103392149265, 586.0359708279941, 3628.600853906068, 3632.4551317302617, 3658.560972683295, 3697.3529632314776, 3704.666580007812, 74310.25689743033, 77393.61303193448, 78678.21321786824, 79049.20950790419, 79446.0, 69237.61524769576, 69373.65313173503, 69902.30097698957, 70181.64909175523, 70280.0, 59930.700346497986, 61173.776524469264, 61736.69131654313, 61931.380686193464, 62884.0, 7182.820429489305, 7227.638618068971, 7280.67236974348, 7295.051643286339, 7470.850582988419, 36448.27103457863, 42133.0, 44254.77872610616, 46156.53843461522, 46562.76718616385, 60848.69575652093, 60874.0, 61848.0, 62023.6898815503, 62130.0680489784, 9132.954335228282, 9222.170004699608, 9222.907770922473, 9277.16505514507, 9368.81262374735, 9486.905130948602, 9773.9022609773, 9988.41908018672, 10103.343282686601, 10509.211809114195, 9399.953000234955, 9514.619415223313, 9536.761580960254, 9650.806983860142, 9679.419234845931, 9423.38747981379, 9494.762630934005, 9546.761330966781, 9558.187554057982, 9781.0, 9354.391964522285, 9366.110219529133, 9458.29062820305, 9464.621415143318, 9505.524723763645, 8000.0, 8000.559969201517, 8151.877721834058, 8325.95837020811, 8388.790280243044, 8128.14654461273, 8188.549629770419, 8206.507609543447, 8256.967879015123, 8394.916050839414], "unit": "score", "name": "yui.html", "value": 6346.431158757966}], "name": "dromaeo_css", "value": 7409.203194772244}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 106.0, 115.0, 113.0, 117.0, 135.0, 169.0, 167.0, 113.0, 114.0], "unit": "score", "name": "ai-astar", "value": 126.3}, {"lowerIsBetter": true, "replicates": [159.0, 118.0, 148.0, 154.0, 121.0, 143.0, 138.0, 123.0, 160.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 139.3}, {"lowerIsBetter": true, "replicates": [190.0, 227.0, 266.0, 209.0, 217.0, 199.0, 201.0, 199.0, 200.0, 199.0], "unit": "score", "name": "audio-dft", "value": 210.7}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 70.0, 115.0, 55.0, 54.0, 60.0, 58.0, 84.0, 56.0], "unit": "score", "name": "audio-fft", "value": 69.2}, {"lowerIsBetter": true, "replicates": [83.0, 80.0, 122.0, 78.0, 82.0, 82.0, 115.0, 77.0, 83.0, 111.0], "unit": "score", "name": "audio-oscillator", "value": 91.3}, {"lowerIsBetter": true, "replicates": [91.0, 86.0, 88.0, 86.0, 89.0, 85.0, 89.0, 86.0, 88.0, 114.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 90.2}, {"lowerIsBetter": true, "replicates": [138.0, 149.0, 93.0, 95.0, 109.0, 88.0, 91.0, 95.0, 150.0, 149.0], "unit": "score", "name": "imaging-darkroom", "value": 115.7}, {"lowerIsBetter": true, "replicates": [87.0, 93.0, 113.0, 143.0, 142.0, 99.0, 91.0, 91.0, 92.0, 90.0], "unit": "score", "name": "imaging-desaturate", "value": 104.1}, {"lowerIsBetter": true, "replicates": [55.0, 57.0, 60.0, 74.0, 85.0, 85.0, 71.0, 88.0, 58.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 68.7}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 91.0, 106.0, 67.0, 94.0, 104.0, 99.0, 90.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 85.3}, {"lowerIsBetter": true, "replicates": [88.0, 86.0, 83.0, 85.0, 85.0, 86.0, 85.0, 87.0, 83.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.5}, {"lowerIsBetter": true, "replicates": [134.0, 134.0, 139.0, 122.0, 136.0, 136.0, 137.0, 125.0, 138.0, 139.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 134.0}, {"lowerIsBetter": true, "replicates": [143.0, 142.0, 142.0, 141.0, 136.0, 130.0, 140.0, 139.0, 143.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.6}, {"lowerIsBetter": true, "replicates": [67.0, 75.0, 86.0, 98.0, 104.0, 65.0, 59.0, 96.0, 96.0, 93.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 83.9}], "name": "kraken", "value": 1543.8000000000002}]} 18:20:35 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1543.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7409.20"}}} 18:20:35 INFO - Return code: 0 18:20:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:20:35 ERROR - # TBPL SUCCESS # 18:20:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:20:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:20:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:20:35 INFO - 2016-03-03 18:20:35.800 screenresolution[1688:10627] starting screenresolution argv=screenresolution get 18:20:35 INFO - 2016-03-03 18:20:35.802 screenresolution[1688:10627] Display 0: 1600x1200x32@60 18:20:35 INFO - 2016-03-03 18:20:35.808 screenresolution[1689:10630] starting screenresolution argv=screenresolution list 18:20:35 INFO - Available Modes on Display 0 18:20:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:20:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:20:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:20:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:20:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:20:36 INFO - Intel Iris: 18:20:36 INFO - Chipset Model: Intel Iris 18:20:36 INFO - Type: GPU 18:20:36 INFO - Bus: Built-In 18:20:36 INFO - VRAM (Dynamic, Max): 1536 MB 18:20:36 INFO - Vendor: Intel (0x8086) 18:20:36 INFO - Device ID: 0x0a2e 18:20:36 INFO - Revision ID: 0x0009 18:20:36 INFO - Displays: 18:20:36 INFO - Display: 18:20:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:20:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:20:36 INFO - Display Serial Number: 1600x1200 60 18:20:36 INFO - Main Display: Yes 18:20:36 INFO - Mirror: Off 18:20:36 INFO - Online: Yes 18:20:36 INFO - Rotation: Supported 18:20:36 INFO - Return code: 0 18:20:36 INFO - Running post-action listener: _resource_record_post_action 18:20:36 INFO - Running post-run listener: _resource_record_post_run 18:20:37 INFO - Total resource usage - Wall time: 1205s; CPU: 54.0%; Read bytes: 39462400; Write bytes: 707071488; Read time: 432; Write time: 2143 18:20:37 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 381846016; Write bytes: 376048640; Read time: 28565; Write time: 679 18:20:37 INFO - run-tests - Wall time: 1172s; CPU: 54.0%; Read bytes: 38508032; Write bytes: 303485440; Read time: 417; Write time: 1413 18:20:37 INFO - Running post-run listener: _upload_blobber_files 18:20:37 INFO - Blob upload gear active. 18:20:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:20:37 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 18:20:37 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'] 18:20:37 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 18:20:37 INFO - (blobuploader) - INFO - Open directory for files ... 18:20:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:20:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:20:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:20:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:20:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:20:38 INFO - (blobuploader) - INFO - Done attempting. 18:20:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:20:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:20:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:20:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:20:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:20:39 INFO - (blobuploader) - INFO - Done attempting. 18:20:39 INFO - (blobuploader) - INFO - Iteration through files over. 18:20:39 INFO - Return code: 0 18:20:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:20:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:20:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/648b1145d28ced2b1cd9c6025c7908c2887b6b0f734d7bb25a433122f3701c3f892ba8688515d6e557f5bd34f00dbc22b6fe60adc4d7e4e5fcccb3d753e19cf9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f10adee196af8bb188222e3ea303e2a66e99c461221dc352da3f201c3f24e91508430b19b27ee7362374d1f053da37d515fa4ea226466664aea97be8bb724682"} 18:20:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:20:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:20:39 INFO - Contents: 18:20:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/648b1145d28ced2b1cd9c6025c7908c2887b6b0f734d7bb25a433122f3701c3f892ba8688515d6e557f5bd34f00dbc22b6fe60adc4d7e4e5fcccb3d753e19cf9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f10adee196af8bb188222e3ea303e2a66e99c461221dc352da3f201c3f24e91508430b19b27ee7362374d1f053da37d515fa4ea226466664aea97be8bb724682"} 18:20:39 INFO - Running post-run listener: copy_logs_to_upload_dir 18:20:39 INFO - Copying logs to upload dir... 18:20:39 INFO - mkdir: /builds/slave/test/build/upload/logs 18:20:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.983046 ========= master_lag: 2.79 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-03-03 18:20:42.588657) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-03 18:20:42.593291) ========= 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.1Q40tFGngv/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.TEFBDJg8Mu/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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/648b1145d28ced2b1cd9c6025c7908c2887b6b0f734d7bb25a433122f3701c3f892ba8688515d6e557f5bd34f00dbc22b6fe60adc4d7e4e5fcccb3d753e19cf9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f10adee196af8bb188222e3ea303e2a66e99c461221dc352da3f201c3f24e91508430b19b27ee7362374d1f053da37d515fa4ea226466664aea97be8bb724682"} build_url:https://queue.taskcluster.net/v1/task/LQr2uUsSQrim0ghTqQMKTg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011024 build_url: 'https://queue.taskcluster.net/v1/task/LQr2uUsSQrim0ghTqQMKTg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/648b1145d28ced2b1cd9c6025c7908c2887b6b0f734d7bb25a433122f3701c3f892ba8688515d6e557f5bd34f00dbc22b6fe60adc4d7e4e5fcccb3d753e19cf9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f10adee196af8bb188222e3ea303e2a66e99c461221dc352da3f201c3f24e91508430b19b27ee7362374d1f053da37d515fa4ea226466664aea97be8bb724682"}' ========= master_lag: 0.60 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-03 18:20:43.203925) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 18:20:43.204248) ========= 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.1Q40tFGngv/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.TEFBDJg8Mu/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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.005091 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 18:20:43.225076) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-03 18:20:43.225375) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-03 18:20:43.225749) ========= ========= Total master_lag: 3.60 =========