builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0139 starttime: 1455797648.18 results: success (0) buildid: 20160218023126 builduid: 265ec1307b114be4928e5f93de15cea5 revision: a3458328b296fd1361c817b8c9e1d1e5bfdd64bb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-18 04:14:08.184635) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-18 04:14:08.185035) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-18 04:14:08.185365) ========= 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.dz9n4T9kV6/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.EooUH41KSd/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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.005537 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-18 04:14:08.216227) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-18 04:14:08.216554) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-18 04:14:08.233112) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 04:14:08.233530) ========= 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.dz9n4T9kV6/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.EooUH41KSd/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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.005650 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 04:14:08.282492) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-18 04:14:08.282949) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-18 04:14:08.283520) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 04:14:08.283985) ========= 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.dz9n4T9kV6/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.EooUH41KSd/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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-02-18 04:14:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 48.4M=0s 2016-02-18 04:14:08 (48.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.487320 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 04:14:08.790318) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 04:14:08.790678) ========= 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.dz9n4T9kV6/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.EooUH41KSd/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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.026181 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 04:14:08.839949) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 04:14:08.843373) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a3458328b296fd1361c817b8c9e1d1e5bfdd64bb --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 a3458328b296fd1361c817b8c9e1d1e5bfdd64bb --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dz9n4T9kV6/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.EooUH41KSd/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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-02-18 04:14:08,914 truncating revision to first 12 chars 2016-02-18 04:14:08,914 Setting DEBUG logging. 2016-02-18 04:14:08,914 attempt 1/10 2016-02-18 04:14:08,914 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a3458328b296?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-18 04:14:09,216 unpacking tar archive at: fx-team-a3458328b296/testing/mozharness/ program finished with exit code 0 elapsedTime=0.545343 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 04:14:09.407016) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-18 04:14:09.407539) ========= echo a3458328b296fd1361c817b8c9e1d1e5bfdd64bb in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'a3458328b296fd1361c817b8c9e1d1e5bfdd64bb'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dz9n4T9kV6/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.EooUH41KSd/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 a3458328b296fd1361c817b8c9e1d1e5bfdd64bb program finished with exit code 0 elapsedTime=0.005506 script_repo_revision: 'a3458328b296fd1361c817b8c9e1d1e5bfdd64bb' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-18 04:14:09.461476) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-18 04:14:09.461877) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-18 04:14:09.477725) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2016-02-18 04:14:09.478072) ========= /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.dz9n4T9kV6/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.EooUH41KSd/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 04:14:09 INFO - MultiFileLogger online at 20160218 04:14:09 in /builds/slave/test 04:14:09 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 04:14:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:14:09 INFO - {'append_to_log': False, 04:14:09 INFO - 'base_work_dir': '/builds/slave/test', 04:14:09 INFO - 'blob_upload_branch': 'Fx-Team', 04:14:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:14:09 INFO - 'branch': 'Fx-Team', 04:14:09 INFO - 'buildbot_json_path': 'buildprops.json', 04:14:09 INFO - 'config_files': ('talos/mac_config.py',), 04:14:09 INFO - 'default_actions': ('clobber', 04:14:09 INFO - 'read-buildbot-config', 04:14:09 INFO - 'download-and-extract', 04:14:09 INFO - 'populate-webroot', 04:14:09 INFO - 'create-virtualenv', 04:14:09 INFO - 'install', 04:14:09 INFO - 'run-tests'), 04:14:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:14:09 INFO - 'download_minidump_stackwalk': True, 04:14:09 INFO - 'download_symbols': 'ondemand', 04:14:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:14:09 INFO - 'tooltool.py': '/tools/tooltool.py', 04:14:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:14:09 INFO - '/tools/misc-python/virtualenv.py')}, 04:14:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:14:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:14:09 INFO - 'installer_path': 'installer.exe', 04:14:09 INFO - 'log_level': 'info', 04:14:09 INFO - 'log_name': 'talos', 04:14:09 INFO - 'log_to_console': True, 04:14:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:14:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:14:09 INFO - 'opt_config_files': (), 04:14:09 INFO - 'pip_index': False, 04:14:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:14:09 INFO - 'cmd': ('bash', 04:14:09 INFO - '-c', 04:14:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:14:09 INFO - 'enabled': True, 04:14:09 INFO - 'halt_on_failure': False, 04:14:09 INFO - 'name': 'check_screen_resolution'},), 04:14:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:14:09 INFO - 'cmd': ('bash', 04:14:09 INFO - '-c', 04:14:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:14:09 INFO - 'enabled': True, 04:14:09 INFO - 'halt_on_failure': False, 04:14:09 INFO - 'name': 'check_screen_resolution'},), 04:14:09 INFO - 'run_cmd_checks_enabled': True, 04:14:09 INFO - 'sps_profile': False, 04:14:09 INFO - 'sps_profile_interval': 0, 04:14:09 INFO - 'suite': 'dromaeojs-e10s', 04:14:09 INFO - 'system_bits': '32', 04:14:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:14:09 INFO - 'title': 't-yosemite-r7-0139', 04:14:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:14:09 INFO - 'use_talos_json': True, 04:14:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:14:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:14:09 INFO - 'work_dir': 'build'} 04:14:09 INFO - ##### 04:14:09 INFO - ##### Running clobber step. 04:14:09 INFO - ##### 04:14:09 INFO - Running pre-action listener: _resource_record_pre_action 04:14:09 INFO - Running main action method: clobber 04:14:09 INFO - rmtree: /builds/slave/test/build 04:14:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:14:11 INFO - Running post-action listener: _resource_record_post_action 04:14:11 INFO - ##### 04:14:11 INFO - ##### Running read-buildbot-config step. 04:14:11 INFO - ##### 04:14:11 INFO - Running pre-action listener: _resource_record_pre_action 04:14:11 INFO - Running main action method: read_buildbot_config 04:14:11 INFO - Using buildbot properties: 04:14:11 INFO - { 04:14:11 INFO - "project": "", 04:14:11 INFO - "product": "firefox", 04:14:11 INFO - "script_repo_revision": "production", 04:14:11 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 04:14:11 INFO - "repository": "", 04:14:11 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 04:14:11 INFO - "buildid": "20160218023126", 04:14:11 INFO - "pgo_build": "False", 04:14:11 INFO - "basedir": "/builds/slave/test", 04:14:11 INFO - "buildnumber": 452, 04:14:11 INFO - "slavename": "t-yosemite-r7-0139", 04:14:11 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 04:14:11 INFO - "platform": "yosemite_r7", 04:14:11 INFO - "scheduler": "tests-fx-team-macosx64-talos", 04:14:11 INFO - "branch": "fx-team", 04:14:11 INFO - "repo_path": "integration/fx-team", 04:14:11 INFO - "revision": "a3458328b296fd1361c817b8c9e1d1e5bfdd64bb", 04:14:11 INFO - "stage_platform": "macosx64", 04:14:11 INFO - "builduid": "265ec1307b114be4928e5f93de15cea5", 04:14:11 INFO - "slavebuilddir": "test" 04:14:11 INFO - } 04:14:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ip46fxnjSviNhr9safwQ6A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 04:14:11 INFO - Running post-action listener: _resource_record_post_action 04:14:11 INFO - ##### 04:14:11 INFO - ##### Running download-and-extract step. 04:14:11 INFO - ##### 04:14:11 INFO - Running pre-action listener: _resource_record_pre_action 04:14:11 INFO - Running main action method: download_and_extract 04:14:11 INFO - mkdir: /builds/slave/test/build/tests 04:14:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:11 INFO - https://queue.taskcluster.net/v1/task/Ip46fxnjSviNhr9safwQ6A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:14:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ip46fxnjSviNhr9safwQ6A/artifacts/public/build/test_packages.json 04:14:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ip46fxnjSviNhr9safwQ6A/artifacts/public/build/test_packages.json 04:14:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ip46fxnjSviNhr9safwQ6A/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:14:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ip46fxnjSviNhr9safwQ6A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:14:22 INFO - Downloaded 1277 bytes. 04:14:22 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:14:22 INFO - Using the following test package requirements: 04:14:22 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:14:22 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:14:22 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 04:14:22 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:14:22 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 04:14:22 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:14:22 INFO - u'jsshell-mac.zip'], 04:14:22 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:14:22 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 04:14:22 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:14:22 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:14:22 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 04:14:22 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:14:22 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 04:14:22 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:14:22 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 04:14:22 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:14:22 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:14:22 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 04:14:22 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:14: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')]} 04:14:22 INFO - https://queue.taskcluster.net/v1/task/Ip46fxnjSviNhr9safwQ6A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:14:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ip46fxnjSviNhr9safwQ6A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:14:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ip46fxnjSviNhr9safwQ6A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:14:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ip46fxnjSviNhr9safwQ6A/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 04:14:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ip46fxnjSviNhr9safwQ6A/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 04:14:32 INFO - Downloaded 17806608 bytes. 04:14:32 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'] 04:14:32 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 04:14:35 INFO - Return code: 0 04:14:35 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 04:14:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:35 INFO - https://queue.taskcluster.net/v1/task/Ip46fxnjSviNhr9safwQ6A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:14:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ip46fxnjSviNhr9safwQ6A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:14:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ip46fxnjSviNhr9safwQ6A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:14:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ip46fxnjSviNhr9safwQ6A/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 04:14:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ip46fxnjSviNhr9safwQ6A/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 04:14:39 INFO - Downloaded 17806608 bytes. 04:14:39 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'] 04:14:39 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 04:14:42 INFO - Return code: 0 04:14: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')]} 04:14:42 INFO - https://queue.taskcluster.net/v1/task/Ip46fxnjSviNhr9safwQ6A/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:14:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ip46fxnjSviNhr9safwQ6A/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 04:14:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ip46fxnjSviNhr9safwQ6A/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 04:14:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ip46fxnjSviNhr9safwQ6A/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 04:14:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ip46fxnjSviNhr9safwQ6A/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 04:14:44 INFO - Downloaded 10707071 bytes. 04:14:44 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'] 04:14:44 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 04:14:44 INFO - Return code: 0 04:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:44 INFO - https://queue.taskcluster.net/v1/task/Ip46fxnjSviNhr9safwQ6A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:14:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ip46fxnjSviNhr9safwQ6A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:14:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ip46fxnjSviNhr9safwQ6A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:14:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ip46fxnjSviNhr9safwQ6A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 04:14:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ip46fxnjSviNhr9safwQ6A/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 04:14:47 INFO - Downloaded 111230467 bytes. 04:14:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ip46fxnjSviNhr9safwQ6A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:14:47 INFO - mkdir: /builds/slave/test/properties 04:14:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:14:47 INFO - Writing to file /builds/slave/test/properties/build_url 04:14:47 INFO - Contents: 04:14:47 INFO - build_url:https://queue.taskcluster.net/v1/task/Ip46fxnjSviNhr9safwQ6A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:14:48 INFO - Running post-action listener: _resource_record_post_action 04:14:48 INFO - Running post-action listener: set_extra_try_arguments 04:14:48 INFO - ##### 04:14:48 INFO - ##### Running populate-webroot step. 04:14:48 INFO - ##### 04:14:48 INFO - Running pre-action listener: _resource_record_pre_action 04:14:48 INFO - Running main action method: populate_webroot 04:14:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:14:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:14:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:14:48 INFO - '--tppagecycles', 04:14:48 INFO - '7'], 04:14:48 INFO - 'tests': ['tsvgm']}}, 04:14:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:14:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:14:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:14:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:14:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:14:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:14:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:14:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:48 INFO - 'talos_options': ['--e10s'], 04:14:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:14:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:48 INFO - 'tests': ['damp', 'tps']}, 04:14:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:48 INFO - 'talos_options': ['--e10s'], 04:14:48 INFO - 'tests': ['damp', 'tps']}, 04:14:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:14:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:14:48 INFO - 'other': {'tests': ['a11yr', 04:14:48 INFO - 'ts_paint', 04:14:48 INFO - 'tpaint', 04:14:48 INFO - 'sessionrestore', 04:14:48 INFO - 'sessionrestore_no_auto_restore']}, 04:14:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:14:48 INFO - 'tests': ['a11yr', 04:14:48 INFO - 'ts_paint', 04:14:48 INFO - 'tpaint', 04:14:48 INFO - 'sessionrestore', 04:14:48 INFO - 'sessionrestore_no_auto_restore']}, 04:14:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:14:48 INFO - 'tests': ['a11yr', 04:14:48 INFO - 'ts_paint', 04:14:48 INFO - 'tpaint', 04:14:48 INFO - 'sessionrestore', 04:14:48 INFO - 'sessionrestore_no_auto_restore']}, 04:14:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:14:48 INFO - 'tests': ['a11yr', 04:14:48 INFO - 'ts_paint', 04:14:48 INFO - 'tpaint', 04:14:48 INFO - 'sessionrestore', 04:14:48 INFO - 'sessionrestore_no_auto_restore']}, 04:14:48 INFO - 'other_l64': {'tests': ['a11yr', 04:14:48 INFO - 'ts_paint', 04:14:48 INFO - 'tpaint', 04:14:48 INFO - 'sessionrestore', 04:14:48 INFO - 'sessionrestore_no_auto_restore']}, 04:14:48 INFO - 'other_nol64': {'tests': ['a11yr', 04:14:48 INFO - 'ts_paint', 04:14:48 INFO - 'tpaint', 04:14:48 INFO - 'sessionrestore', 04:14:48 INFO - 'sessionrestore_no_auto_restore']}, 04:14:48 INFO - 'svgr': {'tests': ['tsvgx', 04:14:48 INFO - 'tsvgr_opacity', 04:14:48 INFO - 'tart', 04:14:48 INFO - 'tscrollx', 04:14:48 INFO - 'cart']}, 04:14:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:14:48 INFO - 'tests': ['tsvgx', 04:14:48 INFO - 'tsvgr_opacity', 04:14:48 INFO - 'tart', 04:14:48 INFO - 'tscrollx', 04:14:48 INFO - 'cart']}, 04:14:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:48 INFO - 'tests': ['tp5o']}, 04:14:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:48 INFO - 'talos_options': ['--e10s'], 04:14:48 INFO - 'tests': ['tp5o']}, 04:14:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:48 INFO - 'talos_options': ['--xperf_path', 04:14:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:14:48 INFO - 'tests': ['tp5n']}, 04:14:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:48 INFO - 'talos_options': ['--e10s', 04:14:48 INFO - '--xperf_path', 04:14:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:14:48 INFO - 'tests': ['tp5n']}}, 04:14:48 INFO - 'talos.zip': {'path': '', 04:14:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:14:48 INFO - Running post-action listener: _resource_record_post_action 04:14:48 INFO - ##### 04:14:48 INFO - ##### Running create-virtualenv step. 04:14:48 INFO - ##### 04:14:48 INFO - Running pre-action listener: _resource_record_pre_action 04:14:48 INFO - Running main action method: create_virtualenv 04:14:48 INFO - Creating virtualenv /builds/slave/test/build/venv 04:14:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:14:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:14:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:14:48 INFO - Using real prefix '/tools/python27' 04:14:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:14:49 INFO - Installing distribute.............................................................................................................................................................................................done. 04:14:52 INFO - Installing pip.................done. 04:14:52 INFO - Return code: 0 04:14:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:14: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')]} 04:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14: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')]} 04:14:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10de15a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de1c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3d14a4e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcb9d30>, '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 0x10dadddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dcb0b20>, '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.dz9n4T9kV6/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.EooUH41KSd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 04:14:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:14:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:14:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dz9n4T9kV6/Render', 04:14:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:14:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:14:52 INFO - 'HOME': '/Users/cltbld', 04:14:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:14:52 INFO - 'LOGNAME': 'cltbld', 04:14:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:52 INFO - 'MOZ_NO_REMOTE': '1', 04:14:52 INFO - 'NO_EM_RESTART': '1', 04:14:52 INFO - 'PAGER': '/bin/cat', 04:14:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:14:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:52 INFO - 'PWD': '/builds/slave/test', 04:14:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:14:52 INFO - 'SHELL': '/bin/bash', 04:14:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EooUH41KSd/Listeners', 04:14:52 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 04:14:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:14:52 INFO - 'USER': 'cltbld', 04:14:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:14:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:14:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:52 INFO - 'XPC_FLAGS': '0x0', 04:14:52 INFO - 'XPC_SERVICE_NAME': '0', 04:14:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:14:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:52 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:14:52 INFO - Cleaning up... 04:14:52 INFO - Return code: 0 04:14:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:14: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')]} 04:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14: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')]} 04:14:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10de15a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de1c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3d14a4e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcb9d30>, '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 0x10dadddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dcb0b20>, '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.dz9n4T9kV6/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.EooUH41KSd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 04:14:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:14:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:14:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dz9n4T9kV6/Render', 04:14:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:14:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:14:52 INFO - 'HOME': '/Users/cltbld', 04:14:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:14:52 INFO - 'LOGNAME': 'cltbld', 04:14:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:52 INFO - 'MOZ_NO_REMOTE': '1', 04:14:52 INFO - 'NO_EM_RESTART': '1', 04:14:52 INFO - 'PAGER': '/bin/cat', 04:14:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:14:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:52 INFO - 'PWD': '/builds/slave/test', 04:14:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:14:52 INFO - 'SHELL': '/bin/bash', 04:14:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EooUH41KSd/Listeners', 04:14:52 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 04:14:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:14:52 INFO - 'USER': 'cltbld', 04:14:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:14:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:14:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:52 INFO - 'XPC_FLAGS': '0x0', 04:14:52 INFO - 'XPC_SERVICE_NAME': '0', 04:14:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:14:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:52 INFO - Downloading/unpacking psutil>=0.7.1 04:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:14:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:14:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:14:55 INFO - Installing collected packages: psutil 04:14:55 INFO - Running setup.py install for psutil 04:14:56 INFO - building 'psutil._psutil_osx' extension 04:14:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:14:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:14:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:14:56 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 04:14:56 INFO - building 'psutil._psutil_posix' extension 04:14:56 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 04:14:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:14:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:14:56 INFO - ^ 04:14:56 INFO - 1 warning generated. 04:14:56 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:14:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:14:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:14:57 INFO - Successfully installed psutil 04:14:57 INFO - Cleaning up... 04:14:57 INFO - Return code: 0 04:14:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:14:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:57 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 0x10de15a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de1c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3d14a4e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcb9d30>, '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 0x10dadddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dcb0b20>, '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.dz9n4T9kV6/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.EooUH41KSd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 04:14:57 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 04:14:57 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 04:14:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dz9n4T9kV6/Render', 04:14:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:14:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:14:57 INFO - 'HOME': '/Users/cltbld', 04:14:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:14:57 INFO - 'LOGNAME': 'cltbld', 04:14:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:57 INFO - 'MOZ_NO_REMOTE': '1', 04:14:57 INFO - 'NO_EM_RESTART': '1', 04:14:57 INFO - 'PAGER': '/bin/cat', 04:14:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:14:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:57 INFO - 'PWD': '/builds/slave/test', 04:14:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:14:57 INFO - 'SHELL': '/bin/bash', 04:14:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EooUH41KSd/Listeners', 04:14:57 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 04:14:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:14:57 INFO - 'USER': 'cltbld', 04:14:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:14:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:14:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:57 INFO - 'XPC_FLAGS': '0x0', 04:14:57 INFO - 'XPC_SERVICE_NAME': '0', 04:14:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:14:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:14:57 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 04:14:57 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 04:14:57 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 04:14:57 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 04:14:57 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 04:14:57 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 04:14:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:14:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:14:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:14:59 INFO - Installing collected packages: mozsystemmonitor 04:14:59 INFO - Running setup.py install for mozsystemmonitor 04:14:59 INFO - Successfully installed mozsystemmonitor 04:14:59 INFO - Cleaning up... 04:15:00 INFO - Return code: 0 04:15:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:15: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')]} 04:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15: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')]} 04:15:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15: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', '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 0x10de15a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de1c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3d14a4e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcb9d30>, '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 0x10dadddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dcb0b20>, '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.dz9n4T9kV6/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.EooUH41KSd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 04:15: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:15: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 blobuploader==1.2.4 04:15:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dz9n4T9kV6/Render', 04:15:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:15:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:15:00 INFO - 'HOME': '/Users/cltbld', 04:15:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:15:00 INFO - 'LOGNAME': 'cltbld', 04:15:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:00 INFO - 'MOZ_NO_REMOTE': '1', 04:15:00 INFO - 'NO_EM_RESTART': '1', 04:15:00 INFO - 'PAGER': '/bin/cat', 04:15:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:15:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:00 INFO - 'PWD': '/builds/slave/test', 04:15:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:15:00 INFO - 'SHELL': '/bin/bash', 04:15:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EooUH41KSd/Listeners', 04:15:00 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 04:15:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:15:00 INFO - 'USER': 'cltbld', 04:15:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:15:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:15:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:00 INFO - 'XPC_FLAGS': '0x0', 04:15:00 INFO - 'XPC_SERVICE_NAME': '0', 04:15:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:15:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:00 INFO - Downloading/unpacking blobuploader==1.2.4 04:15: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 04:15: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 04:15: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 04:15: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 04:15: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 04:15: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 04:15:02 INFO - Downloading blobuploader-1.2.4.tar.gz 04:15:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:15:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:15:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:15:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:15:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:15:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:15:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:15:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:15:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:15:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:15:04 INFO - Downloading docopt-0.6.1.tar.gz 04:15:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:15:04 INFO - Installing collected packages: blobuploader, requests, docopt 04:15:04 INFO - Running setup.py install for blobuploader 04:15:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:15:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:15:04 INFO - Running setup.py install for requests 04:15:04 INFO - Running setup.py install for docopt 04:15:04 INFO - Successfully installed blobuploader requests docopt 04:15:04 INFO - Cleaning up... 04:15:05 INFO - Return code: 0 04:15:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10de15a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de1c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3d14a4e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcb9d30>, '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 0x10dadddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dcb0b20>, '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.dz9n4T9kV6/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.EooUH41KSd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 04:15:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:15:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:15:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dz9n4T9kV6/Render', 04:15:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:15:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:15:05 INFO - 'HOME': '/Users/cltbld', 04:15:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:15:05 INFO - 'LOGNAME': 'cltbld', 04:15:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:05 INFO - 'MOZ_NO_REMOTE': '1', 04:15:05 INFO - 'NO_EM_RESTART': '1', 04:15:05 INFO - 'PAGER': '/bin/cat', 04:15:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:15:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:05 INFO - 'PWD': '/builds/slave/test', 04:15:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:15:05 INFO - 'SHELL': '/bin/bash', 04:15:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EooUH41KSd/Listeners', 04:15:05 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 04:15:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:15:05 INFO - 'USER': 'cltbld', 04:15:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:15:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:15:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:05 INFO - 'XPC_FLAGS': '0x0', 04:15:05 INFO - 'XPC_SERVICE_NAME': '0', 04:15:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:15:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:15:05 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-GyoHnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:15:05 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-Rw73cj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:15:05 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-QZ0L2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:15:05 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-iShXjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:15:05 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-bEnbp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:15:05 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-LaSQmq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:15:05 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-cL7HXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:15:06 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-ck7sr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:15:06 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-mTSa0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:15:06 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-ttzbQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:15:06 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-58U7Hj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:15:06 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-0UV8Vv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:15:06 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-kedvC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:15:06 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-QO2dpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:15:06 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-0bBrZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:15:06 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-THglpj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:15:06 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-WNH6FI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:15:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:15:07 INFO - Running setup.py install for manifestparser 04:15:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:15:07 INFO - Running setup.py install for mozcrash 04:15:07 INFO - Running setup.py install for mozdebug 04:15:07 INFO - Running setup.py install for mozdevice 04:15:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:15:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:15:07 INFO - Running setup.py install for mozfile 04:15:07 INFO - Running setup.py install for mozhttpd 04:15:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:15:07 INFO - Running setup.py install for mozinfo 04:15:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:15:08 INFO - Running setup.py install for mozInstall 04:15:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:15:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:15:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:15:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:15:08 INFO - Running setup.py install for mozleak 04:15:08 INFO - Running setup.py install for mozlog 04:15:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:15:08 INFO - Running setup.py install for moznetwork 04:15:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:15:08 INFO - Running setup.py install for mozprocess 04:15:08 INFO - Running setup.py install for mozprofile 04:15:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:15:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:15:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:15:08 INFO - Running setup.py install for mozrunner 04:15:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:15:09 INFO - Running setup.py install for mozscreenshot 04:15:09 INFO - Running setup.py install for moztest 04:15:09 INFO - Running setup.py install for mozversion 04:15:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:15:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:15:09 INFO - Cleaning up... 04:15:09 INFO - Return code: 0 04:15:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:15:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:09 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 0x10de15a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de1c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3d14a4e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcb9d30>, '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 0x10dadddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dcb0b20>, '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.dz9n4T9kV6/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.EooUH41KSd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 04:15:09 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 04:15:09 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 04:15:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dz9n4T9kV6/Render', 04:15:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:15:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:15:09 INFO - 'HOME': '/Users/cltbld', 04:15:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:15:09 INFO - 'LOGNAME': 'cltbld', 04:15:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:09 INFO - 'MOZ_NO_REMOTE': '1', 04:15:09 INFO - 'NO_EM_RESTART': '1', 04:15:09 INFO - 'PAGER': '/bin/cat', 04:15:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:15:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:09 INFO - 'PWD': '/builds/slave/test', 04:15:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:15:09 INFO - 'SHELL': '/bin/bash', 04:15:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EooUH41KSd/Listeners', 04:15:09 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 04:15:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:15:09 INFO - 'USER': 'cltbld', 04:15:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:15:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:15:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:09 INFO - 'XPC_FLAGS': '0x0', 04:15:09 INFO - 'XPC_SERVICE_NAME': '0', 04:15:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:15:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:15:09 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-fys8v6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:15:10 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-DWxGIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:15:10 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)) 04:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:15:10 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-FI7u2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:15:10 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)) 04:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:15:10 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-ocbTqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:15:10 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)) 04:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:15:10 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-6sS2hv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:15:10 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)) 04:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:15:10 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-3uGvC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:15:10 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)) 04:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:15:10 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-rEPpPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:15:10 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)) 04:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:15:10 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-jJVaK9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:15:10 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)) 04:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:15:10 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-gTZd2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:15:10 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)) 04:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:15:10 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-fb6jTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:15:10 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)) 04:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:15:10 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-3tyQPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:15:11 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-eetRZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:15:11 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)) 04:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:15:11 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-IvTCpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:15:11 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)) 04:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:15:11 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-XWwDA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:15:11 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)) 04:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:15:11 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-Zg33vE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:15:11 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)) 04:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:15:11 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-dG4WmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:15:11 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)) 04:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:15:11 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-Njel49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:15:11 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)) 04:15:11 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)) 04:15:11 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)) 04:15:11 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)) 04:15:11 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)) 04:15:11 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)) 04:15:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:15: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 04:15: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 04:15: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 04:15: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 04:15: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 04:15: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 04:15:13 INFO - Downloading blessings-1.6.tar.gz 04:15:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:15:14 INFO - Installing collected packages: blessings 04:15:14 INFO - Running setup.py install for blessings 04:15:14 INFO - Successfully installed blessings 04:15:14 INFO - Cleaning up... 04:15:14 INFO - Return code: 0 04:15:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:15:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:15:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:15:14 INFO - Reading from file tmpfile_stdout 04:15:14 INFO - Current package versions: 04:15:14 INFO - blessings == 1.6 04:15:14 INFO - blobuploader == 1.2.4 04:15:14 INFO - docopt == 0.6.1 04:15:14 INFO - manifestparser == 1.1 04:15:14 INFO - mozInstall == 1.12 04:15:14 INFO - mozcrash == 0.16 04:15:14 INFO - mozdebug == 0.1 04:15:14 INFO - mozdevice == 0.48 04:15:14 INFO - mozfile == 1.2 04:15:14 INFO - mozhttpd == 0.7 04:15:14 INFO - mozinfo == 0.9 04:15:14 INFO - mozleak == 0.1 04:15:14 INFO - mozlog == 3.1 04:15:14 INFO - moznetwork == 0.27 04:15:14 INFO - mozprocess == 0.22 04:15:14 INFO - mozprofile == 0.28 04:15:14 INFO - mozrunner == 6.11 04:15:14 INFO - mozscreenshot == 0.1 04:15:14 INFO - mozsystemmonitor == 0.0 04:15:14 INFO - moztest == 0.7 04:15:14 INFO - mozversion == 1.4 04:15:14 INFO - psutil == 3.1.1 04:15:14 INFO - requests == 1.2.3 04:15:14 INFO - wsgiref == 0.1.2 04:15:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:15:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10de15a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de1c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3d14a4e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcb9d30>, '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 0x10dadddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dcb0b20>, '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.dz9n4T9kV6/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.EooUH41KSd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 04:15:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:15:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:15:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dz9n4T9kV6/Render', 04:15:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:15:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:15:14 INFO - 'HOME': '/Users/cltbld', 04:15:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:15:14 INFO - 'LOGNAME': 'cltbld', 04:15:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:14 INFO - 'MOZ_NO_REMOTE': '1', 04:15:14 INFO - 'NO_EM_RESTART': '1', 04:15:14 INFO - 'PAGER': '/bin/cat', 04:15:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:15:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:14 INFO - 'PWD': '/builds/slave/test', 04:15:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:15:14 INFO - 'SHELL': '/bin/bash', 04:15:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EooUH41KSd/Listeners', 04:15:14 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 04:15:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:15:14 INFO - 'USER': 'cltbld', 04:15:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:15:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:15:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:14 INFO - 'XPC_FLAGS': '0x0', 04:15:14 INFO - 'XPC_SERVICE_NAME': '0', 04:15:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:15:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:15:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:15:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:15:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:15:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:15:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:15:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:15:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:15:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:15:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:15:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:15:14 INFO - Cleaning up... 04:15:14 INFO - Return code: 0 04:15:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:15:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10de15a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de1c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3d14a4e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcb9d30>, '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 0x10dadddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dcb0b20>, '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.dz9n4T9kV6/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.EooUH41KSd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 04:15:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:15:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:15:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dz9n4T9kV6/Render', 04:15:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:15:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:15:14 INFO - 'HOME': '/Users/cltbld', 04:15:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:15:14 INFO - 'LOGNAME': 'cltbld', 04:15:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:14 INFO - 'MOZ_NO_REMOTE': '1', 04:15:14 INFO - 'NO_EM_RESTART': '1', 04:15:14 INFO - 'PAGER': '/bin/cat', 04:15:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:15:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:14 INFO - 'PWD': '/builds/slave/test', 04:15:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:15:14 INFO - 'SHELL': '/bin/bash', 04:15:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EooUH41KSd/Listeners', 04:15:14 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 04:15:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:15:14 INFO - 'USER': 'cltbld', 04:15:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:15:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:15:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:14 INFO - 'XPC_FLAGS': '0x0', 04:15:14 INFO - 'XPC_SERVICE_NAME': '0', 04:15:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:15:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:15 INFO - Downloading/unpacking jsonschema 04:15:15 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 04:15:15 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 04:15:15 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 04:15:15 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 04:15:15 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 04:15:15 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 04:15:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:15:17 INFO - Downloading/unpacking functools32 (from jsonschema) 04:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:15:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:15:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:15:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:15:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:15:17 INFO - Downloading functools32-3.2.3-2.tar.gz 04:15:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:15:17 INFO - warning: no files found matching '*.txt' 04:15:17 INFO - no previously-included directories found matching 'build' 04:15:17 INFO - no previously-included directories found matching 'dist' 04:15:17 INFO - no previously-included directories found matching '.git*' 04:15:18 INFO - Installing collected packages: jsonschema, functools32 04:15:18 INFO - Running setup.py install for functools32 04:15:18 INFO - warning: no files found matching '*.txt' 04:15:18 INFO - no previously-included directories found matching 'build' 04:15:18 INFO - no previously-included directories found matching 'dist' 04:15:18 INFO - no previously-included directories found matching '.git*' 04:15:18 INFO - Successfully installed jsonschema functools32 04:15:18 INFO - Cleaning up... 04:15:18 INFO - Return code: 0 04:15:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:15:18 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')]} 04:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:18 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')]} 04:15:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:18 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 0x10de15a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de1c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3d14a4e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcb9d30>, '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 0x10dadddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dcb0b20>, '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.dz9n4T9kV6/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.EooUH41KSd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 04:15:18 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 04:15:18 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 04:15:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dz9n4T9kV6/Render', 04:15:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:15:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:15:18 INFO - 'HOME': '/Users/cltbld', 04:15:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:15:18 INFO - 'LOGNAME': 'cltbld', 04:15:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:18 INFO - 'MOZ_NO_REMOTE': '1', 04:15:18 INFO - 'NO_EM_RESTART': '1', 04:15:18 INFO - 'PAGER': '/bin/cat', 04:15:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:15:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:18 INFO - 'PWD': '/builds/slave/test', 04:15:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:15:18 INFO - 'SHELL': '/bin/bash', 04:15:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EooUH41KSd/Listeners', 04:15:18 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 04:15:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:15:18 INFO - 'USER': 'cltbld', 04:15:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:15:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:15:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:18 INFO - 'XPC_FLAGS': '0x0', 04:15:18 INFO - 'XPC_SERVICE_NAME': '0', 04:15:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:15:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:18 INFO - Downloading/unpacking flake8 04:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:15:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:15:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:15:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:15:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:15:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:15:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:15:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:15:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:15:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:15:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:15:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:15:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:15:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:15:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:15:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:15:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:15:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:15:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:15:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:15:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:15:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:15:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:15:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:15:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:15:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:15:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:15:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:15:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:15:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:15:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:15:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:15:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:15:22 INFO - no previously-included directories found matching 'docs/_build' 04:15:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:15:22 INFO - Running setup.py install for pep8 04:15:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:15:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:15:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:15:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:15:22 INFO - no previously-included directories found matching 'docs/_build' 04:15:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:15:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:15:22 INFO - Cleaning up... 04:15:22 INFO - Return code: 0 04:15:22 INFO - Running post-action listener: _resource_record_post_action 04:15:22 INFO - Running post-action listener: _start_resource_monitoring 04:15:22 INFO - Starting resource monitoring. 04:15:22 INFO - ##### 04:15:22 INFO - ##### Running install step. 04:15:22 INFO - ##### 04:15:22 INFO - Running pre-action listener: _resource_record_pre_action 04:15:22 INFO - Running main action method: install 04:15:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:15:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:15:22 INFO - Reading from file tmpfile_stdout 04:15:22 INFO - Detecting whether we're running mozinstall >=1.0... 04:15:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:15:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:15:22 INFO - Reading from file tmpfile_stdout 04:15:22 INFO - Output received: 04:15:22 INFO - Usage: mozinstall [options] installer 04:15:22 INFO - Options: 04:15:22 INFO - -h, --help show this help message and exit 04:15:22 INFO - -d DEST, --destination=DEST 04:15:22 INFO - Directory to install application into. [default: 04:15:22 INFO - "/builds/slave/test"] 04:15:22 INFO - --app=APP Application being installed. [default: firefox] 04:15:22 INFO - mkdir: /builds/slave/test/build/application 04:15:22 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'] 04:15:22 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 04:15:56 INFO - Reading from file tmpfile_stdout 04:15:56 INFO - Output received: 04:15:56 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:15:56 INFO - Running post-action listener: _resource_record_post_action 04:15:56 INFO - ##### 04:15:56 INFO - ##### Running run-tests step. 04:15:56 INFO - ##### 04:15:56 INFO - Running pre-action listener: _resource_record_pre_action 04:15:56 INFO - Running main action method: run_tests 04:15:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:15:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:15:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:15:56 INFO - 2016-02-18 04:15:56.798 screenresolution[1660:8364] starting screenresolution argv=screenresolution get 04:15:56 INFO - 2016-02-18 04:15:56.801 screenresolution[1660:8364] Display 0: 1600x1200x32@60 04:15:56 INFO - 2016-02-18 04:15:56.807 screenresolution[1661:8366] starting screenresolution argv=screenresolution list 04:15:56 INFO - Available Modes on Display 0 04:15:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:15:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:15:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:15:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:15:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:15:57 INFO - Intel Iris: 04:15:57 INFO - Chipset Model: Intel Iris 04:15:57 INFO - Type: GPU 04:15:57 INFO - Bus: Built-In 04:15:57 INFO - VRAM (Dynamic, Max): 1536 MB 04:15:57 INFO - Vendor: Intel (0x8086) 04:15:57 INFO - Device ID: 0x0a2e 04:15:57 INFO - Revision ID: 0x0009 04:15:57 INFO - Displays: 04:15:57 INFO - Display: 04:15:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:15:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:15:57 INFO - Display Serial Number: 1600x1200 60 04:15:57 INFO - Main Display: Yes 04:15:57 INFO - Mirror: Off 04:15:57 INFO - Online: Yes 04:15:57 INFO - Rotation: Supported 04:15:57 INFO - Return code: 0 04:15:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:15:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:15:57 INFO - Python 2.7.3 04:15:57 INFO - Return code: 0 04:15:57 INFO - grabbing minidump binary from tooltool 04:15:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:57 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcb9d30>, '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 0x10dadddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dcb0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:15:57 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:15:57 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:15:57 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:15:57 INFO - Return code: 0 04:15:57 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:15:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:15:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:15:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:15:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:15:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:15:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:15:58 INFO - Return code: 0 04:15:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ip46fxnjSviNhr9safwQ6A/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0139', '--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 04:15:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ip46fxnjSviNhr9safwQ6A/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0139 --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 04:15:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dz9n4T9kV6/Render', 04:15:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:15:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:15:58 INFO - 'HOME': '/Users/cltbld', 04:15:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:15:58 INFO - 'LOGNAME': 'cltbld', 04:15:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:15:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:15:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:58 INFO - 'MOZ_NO_REMOTE': '1', 04:15:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:15:58 INFO - 'NO_EM_RESTART': '1', 04:15:58 INFO - 'PAGER': '/bin/cat', 04:15:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:15:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:58 INFO - 'PWD': '/builds/slave/test', 04:15:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:15:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:15:58 INFO - 'SHELL': '/bin/bash', 04:15:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EooUH41KSd/Listeners', 04:15:58 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 04:15:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:15:58 INFO - 'USER': 'cltbld', 04:15:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:15:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:15:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:58 INFO - 'XPC_FLAGS': '0x0', 04:15:58 INFO - 'XPC_SERVICE_NAME': '0', 04:15:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:15:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ip46fxnjSviNhr9safwQ6A/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0139', '--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 04:15:58 INFO - mozversion application_buildid: 20160218023126 04:15:58 INFO - mozversion application_changeset: a3458328b296fd1361c817b8c9e1d1e5bfdd64bb 04:15:58 INFO - mozversion application_display_name: Nightly 04:15:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:15:58 INFO - mozversion application_name: Firefox 04:15:58 INFO - mozversion application_remotingname: firefox 04:15:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:15:58 INFO - mozversion application_vendor: Mozilla 04:15:58 INFO - mozversion application_version: 47.0a1 04:15:58 INFO - mozversion platform_buildid: 20160218023126 04:15:58 INFO - mozversion platform_changeset: a3458328b296fd1361c817b8c9e1d1e5bfdd64bb 04:15:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:15:58 INFO - mozversion platform_version: 47.0a1 04:15:58 INFO - using testdate: 1455797758 04:15:58 INFO - actual date: 1455797758 04:15:59 INFO - starting webserver on 'localhost:49278' 04:15:59 INFO - SUITE-START | Running 2 tests 04:15:59 INFO - TEST-START | dromaeo_css 04:15:59 INFO - operating with platform_type : mac_ 04:15:59 INFO - Initialising browser for dromaeo_css test... 04:15:59 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/tmpG7HXJP/profile http://localhost:49278/getInfo.html) 04:16:01 INFO - PROCESS | 1679 | __metrics Screen width/height:1600/1200 04:16:01 INFO - PROCESS | 1679 | colorDepth:24 04:16:01 INFO - PROCESS | 1679 | Browser inner width/height: 1024/689 04:16:01 INFO - PROCESS | 1679 | __metrics 04:16:02 ERROR - PROCESS | 1679 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2871: TypeError: this.tabs is undefined 04:16:02 INFO - TEST-INFO | 1679: exit 0 04:16:02 INFO - Browser initialized. 04:16:02 INFO - Running cycle 1/1 for dromaeo_css test... 04:16:02 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/tmpG7HXJP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:16:14 INFO - PROCESS | 1684 | RSS: Main: 255795200 04:16:14 INFO - PROCESS | 1684 | 04:17:04 INFO - PROCESS | 1684 | 1455797824531 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] 04:19:14 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 04:19:15 INFO - PROCESS | 1684 | RSS: Main: 270274560 04:19:15 INFO - PROCESS | 1684 | 04:22:18 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 04:22:18 INFO - PROCESS | 1684 | RSS: Main: 283082752 04:22:18 INFO - PROCESS | 1684 | 04:25:20 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 04:25:21 INFO - PROCESS | 1684 | RSS: Main: 284770304 04:25:21 INFO - PROCESS | 1684 | 04:28:22 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 04:28:23 INFO - PROCESS | 1684 | RSS: Main: 286457856 04:28:23 INFO - PROCESS | 1684 | 04:31:25 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 04:31:26 INFO - PROCESS | 1684 | RSS: Main: 287883264 04:31:26 INFO - PROCESS | 1684 | 04:34:28 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 04:34:29 INFO - PROCESS | 1684 | RSS: Main: 291463168 04:34:29 INFO - PROCESS | 1684 | 04:34:29 INFO - PROCESS | 1684 | __start_tp_report 04:34:29 INFO - PROCESS | 1684 | _x_x_mozilla_page_load 04:34:29 INFO - PROCESS | 1684 | _x_x_mozilla_page_load_details 04:34:29 INFO - PROCESS | 1684 | |i|pagename|runs| 04:34:29 INFO - PROCESS | 1684 | |0;dojo.html;3010.9698903010963;3097.5818264534287;3364.5457863188462;3456.8074014465014;3638.781673099614;4855.684380515264;4942.6540142190015;5809.912851307223;5956.493698035672;6028.547858910577;4233.618974292305;5856.795012174574;5861.677607731573;5934.317553481351;5970.6716130612795;5167.379914410257;5222.608304377168;5340.973295133519;5347.759350829222;5443.265159203516;5337.866553336178;5378.193271009341;5391.946080539184;5395.190721391803;5401.540869026137;5157.638965272433;5177.559907407875;5305.946940530584;5311.973440132774;5314.893702125936;5274.182501712203;5283.022640811462;5283.154695248781;5287.814926477593;5370.838874833761;5117.104506711311;5214.348206474191;5220.347456567929;5272.156454967187;5296.549793267577;5630.521405680481;5700.40145784695;5793.362730099686;5815.476607105338;5826.883462330772;6206.627602343829;6221.191245138149;6243.282022567418;6252.843678908018;6256.15541901842;5788.623739456922;6193.87612247757;6216.595921265103;6239.251289845202;6264.59280146789;5916.3787802281;5970.164177015221;5971.014782560872;5983.252093488314;5998.100284957248;5968;6067.1202675611785;6194.0708893666315;6364.109024736541;6403.359664033559;6140.473573783541;6252.718627661766;6271.905921411182;6272.090546870678;6291.559590828598;5018.974905125524;6227.657478838707;6233.470155036873;6236.719347629368;6240.251169859646;6079.118527813443;6092.870172099287;6140.3552626974415;6144;6165.075238714139;6157.321565119188;6162.352952939967;6162.5378096642935;6167.105769663373;6175.96912015446;4937.629677774181;4949.975250123726;4978.054169707744;4996.375453068366;5001.099802035668;4383.60547550722;4403.889902752457;4415.337699345124;4432.889177770581;4488.798004089824;5109.901371205208;5257.526822585909;5924.644521328734;5987.13186587951;6070.180525628984;5263.289455923401;5774.971125144348;5874.619464425857;6169.876602467925;6284.214473190851;5073.239014147834;6004.609700369462;6037.154798328237;6044.365341639153;6062.514998800086;5441.265429167091;5450.618456708072;5467.863303417446;5476.452354764571;5489.204065410493;5391.245225668409;6258.812235632939;6446.09754634361;6453.6127832329275;6460.676966151767;6196.969015154896;6250.812475625738;6260.62436253808;6266.091416744638;6310;6281.309056003744;6446.774362897276;6492.902606461002;6497.935020649922;6510.056041873996;6179.62922224668;6229.844253893508;6232.75068997235;6239.625622462667;6250.343713910156;6027.939720602913;6182.258129024546;6208.348123446973;6210.068489726577;6246.969250073687;6104.847378815565;6150.169727086965;6160.137580738789;6215.627062376272;6250;6171.290301615192;6202.472789812736;6225.688715564294;6228.128062071404;6230.283517395557;5995.640261584144;6081.057436097412;6131.96934015327;6139.802738465956;6149.323574406722;6140.140380346666;6140.688304616564;6202.379762023762;6207.6275423474735;6213.471854892204;6159.23009623797;6160.260768707783;6167.074938759222;6179.62922224668;6184.81445556634 04:34:29 INFO - PROCESS | 1684 | |1;ext.html;476.53537800644375;492.9235968424894;552.866623421985;555.5056000159856;573.9655620662761;36971.4454283186;37285;37512.437313440285;37553.248935021285;37596.624033759654;38502;38844.61155388445;38924.22151556967;39051.804740976324;39147.629832955856;9432.292578056638;9637.325387222898;9676.709698709015;9692.27307951903;9698.9515052425;9465.148136667698;9515;9550.283728720338;9591.42451452915;9595.376300540478;9527.90472095277;9528.904710952906;9616;9625.90374096257;9630.18143457807;9618.567164477616;9632.807343853083;9671.806563868719;9715.805683886354;9720.902790972106;9514.001029891831;9516;9548.952255238748;9623.1820295275;9639.518024098837;31442;37733.62266377328;37811.67659131917;37823.621763782285;38075.238495230216;3010.313929935913;3179.8569064391927;3208.4866421372467;3407.795532268072;3771.7359784815076;27548.862255688793;27727.752251148748;28214.435711285863;28793.712062879313;29158.708412916025;2787.790915681332;2814.6340975673033;2830.4197639483855;2849.458602865449;2882.726141016621;406609;407301.6349182529;409826;410092;410356;57371;63483;64180.71638567296;66264.33735662678;67587.3241267581;64476;64670;64742.67628661921;64962.0255696165;65215.34784652188;14506.347214375379;14830.480933167502;16046.876718629585;16116.435924742813;16201.675966480605;12187.45156467961;12406.75186496265;12415.255084694947;12437.689057773629;12472.002239820793;20174.394768156977;21078.789212107684;21202.681959770616;21203.46991325229;21240.468988275417;9118.772030699152;9257.95371023154;9343.2525397968;9356.204722598519;9420.764480888032;816.3183741575732;856.2935578148052;908.3596064774318;1067.1622776120707;1108.2187058124002;26089.869550652504;29189.41621167565;29433.969811056937;29735.702642973294;29850.850745746568;1074.2426589254558;1093.109116070416;1160.825876118589;1174.3130268792681;1181.9834941949916;14941.925290373478;15214.619634509227;15269.923650381677;15971.961822481502;16222.918885405497;575401;662479;666052;668832;677980;59783.70108149519;60096.699516502136;60109.69945150334;60282.69858650678;60459.395406045376;1210.2798834693344;1390.867867552581;1393.1849867827232;1395.644110751752;1418.8155539779762;30043.673359250402;30169;30543.847280763453;30766.230844229074;30950.53574196434;41243.587564123976;50776.492235077174;51236.48763512317;51523.48476515187;51783.2232516505;522107;526012;527282;528772;529121;32674;43447.13105737931;45299.320510193036;45807.54192458033;45866.541334586225;43338.78330608327;43590;44009.11981760411;44273.01542861158;44795;36213.91358259256;37057.88826335214;37287.81356093202;38060;38415.807920960215;34755.82622086874;35115.82442087773;35163;35546.64453355433;35592.644073558935;28161.577576336782;30266.697333026386;34587;34644.82677586596;34710;31239.84380078176;32713.836430817693;32738;32894.34211315712;32949.50575741318;19451.61096778085;24279.393015174763;24598.13906513335;24935.755781978984;24993.12524061649 04:34:29 INFO - PROCESS | 1684 | |2;jquery.html;293.46589207642086;363.24626400219535;364.6881915961853;368.9907752306192;370.62011438275783;15821.920890395531;19305.420837374884;19873.304434344802;20190.596188076248;21312.93435328235;19567.119479623416;20180.69728954067;20200.59598808023;20578.691319630216;20617.38147855563;5621.241132447119;5719.48524632785;5887.617304875191;5940.19807326012;5942.732577034022;5805.158252053449;5872.236609240814;5915.940840591582;5926.525877929756;5935.821925342225;4117.732347397409;4774.522547745215;5803.013487707079;6059.636421814683;6299.685015749217;5416.458354164592;6248;6267.185265915425;6274.309825919146;6280.183576135073;5361.973190134025;5413.621046526745;5421.512063914227;5426.240326354314;5441.428649991773;12237;12746.490140394466;12759.553415630407;12774.936125319315;18663.90668046651;2151.408362700254;2164.3723320237114;2434.2683053900246;2567.679040119985;2646.907358242452;9229.6308147674;9682.741433021807;9779.46212958287;11346.943265283704;13680.726385472335;1758.9296428142986;1817.5728703754608;1853.2679591561257;1860.7953125156223;1877.4367689693038;99735.01589904557;100293.49853250687;100529;101232.9876701231;101507.49246253795;9458.905410945803;10733.248672593;11021.83467247992;11110.333379997226;11117.72205694848;12954.546590869462;12967.481300747864;12975.77078232603;13014.869851301366;13122.540711075066;8385.329173666092;8455.74632761018;8476.4490308131;8525.31797456202;8532.530710810965;6606.240282367493;8564.657413703506;8658.437201581877;8673.522956237468;8688.218060374596;4417.734935903856;4490.12442573695;4498.280275155959;4498.617617502484;4518.1415531049;1822.2255541394854;1836.1370156026646;1871.8876867388;1920.9711854322197;1947.3642140601962;383.98848034559006;385.4026259298077;409.3470913892337;806.5201205282847;933.50524222161;9502.809943801085;11694.70763230909;11734.647960561197;11861.932426081694;11866;410.48689138576776;437.0472370232859;437.2588462555937;444.4044979727181;448.33422367783817;5955.702214889238;6091.269047714302;6113.694315284218;6141.07883817422;6143.907841382383;668372.5557838725;741598.2920085365;778334;815344;818923;88342;108058;112047;112454;113752.86247137423;433.80919376311596;483.44645381038515;485.71342907684635;488.5602957338353;488.71898658271635;8738;10866.565337386415;10966.396848173108;11047.447627618427;11075.612353567587;48256;48588.75705621449;49366.25950610815;49490.762730932016;49765.253521196486;64731.705365891474;69773;72482;73213;74995.62502187454;7523.1348394935285;7749.457537972513;7753.806154846174;7778.766637000899;7894.526328420313;6864.313568643096;10877.292975956538;11477.417581044198;12189.817152742538;12414.068944828994;10297.433641149808;10566.682999510027;10671.626493072705;10851.45742712877;10907.836382454429;10476.476176191312;10528.789424211625;10585.100266477435;10602.89397106019;10884.78230435371;6297.842553936188;8443.986721593448;10575.524101415609;11192.104631629287;11216.943915280372;7381.1511676157925;7741.148473668005;7860.685572577033;7903.644336004779;7906.248906353887;7262.164851042197;7352.411807055316;7676.884846727416;7802.531848089133;7898.723544676139 04:34:29 INFO - PROCESS | 1684 | |3;mootools.html;1497.2214448486786;1503.4963287298754;1721.388906938037;1867.0851282871397;1867.691830847911;7864.685412583504;8514.531700756472;8631.784205394868;8795.736127916165;8820.558972051396;8532.360072994536;8622.65509379624;8690;8742.125787421255;8778.517181555011;2458.594331935233;2469.6542484052156;2485.453200295932;2494.538510375586;2497.400623850272;2423.4183795889035;2490.439651078502;2490.7384724603926;2490.887910044052;2492.439201179738;2152.203684636687;2395.185636883459;2446.7186273578586;2468.123816045305;2473.1591258971944;2384.3800611840875;2420.165043060141;2423.6243382275775;2427.52663230671;2435.561598912195;2461.778439940396;2463.2117722328862;2471.295680731001;2471.9258422247362;2474.505098980193;8635.136486351377;8654.307655387554;8684;8691.521966291852;8693.217610415093;5235.110031294689;5464.9180262296095;5489.039418101856;5500.972495137538;5502.8349149525175;3656.177360093984;3671.6511931366476;3702.185519185775;3715.7213209009433;3761.4545890845948;1050.1965996013057;1054.4253381906803;1057.7144171073844;1074.0226393981518;1074.9086327662158;11932.866377694105;11954.74475180111;12008;12016.038716902627;12030.699232519257;4811.109944660179;4815.975920120377;4890.021995600823;4898.995705880286;4908.705477671351;10100.848487272697;10107.39355638664;10127.341722788142;10178.949105254427;10179.389236645826;5424.755885985141;5460.781568737286;5470.124780035255;5480.6437581557075;5491.450854914557;4889.828855990023;4921.4832442593015;4955.801767929314;4963.8262660806695;4988;3933.704972127102;3936.586658400884;3943.38877473992;3961.544422391462;3972.8609498667406;1208.6313674329238;1295.1387327427344;1298.6558561981083;1300.9934950325187;1316.967075823112;1107.8449017137607;1110.7556337605713;1136.613551392514;1280.775864223757;1381.461230120254;7987.2012798720825;7999.200079991954;8057.959710201529;8100.3519718422385;8146.185381461925;1106.6790630717003;1115.7210697325668;1188.251401616993;1203.3682316783584;1205.2045649871043;6165.784197553154;6233.563650544509;6242.344553821783;6263.71813268404;6278.560500764994;10263.384196948207;10424.739381515523;10543.420111893765;10562.419066951237;10565.683029509128;10216.080552750289;10294.124999375137;10413;10480.371177729361;10498.790024199627;8100.878486822702;8208.958955205186;8282.047564530036;8296.709615163561;8301.709440169685;7991.800204994922;8002.439829212132;8048.678052877819;8084.231997960184;8228.670853165806;9617.519124043909;9681.177099946583;9762.414255144715;9780.657676981557;9868.210543156674;9816.018398160128;10216.744581385525;10228.53971571296;10235.181185505291;10238.078572928473;7271.163816161209;7447.70209191648;7455.440841936768;7552.697892084255;7581.393488520795;8078.5960701963495;8112.351011919151;8162.306203972729;8185;8219.95890020546;7210.71157153708;7502.662380193014;7606.8098297543;7716.5370077795515;7791.766247012599;7437.181909990005;7522.3605993491165;7563.243675632392;7605.049368828896;7652.349550288288;7651.732189373345;7701.922980770345;7713.267239612228;7721.53670779755;7746.49647772893;6274.498040156685;6907.34380233877;6945.374916257561;6997.7200911962955;7025.508214424941;5888.823335299948;7145.071140751669;7189.71241150369;7193;7204.423646108404 04:34:29 INFO - PROCESS | 1684 | |4;prototype.html;257.8916854920933;322.8966730646193;329.58966087221404;330.29482055810865;330.96855798699113;6636.170478690164;6763.763268285611;6882.483813713972;7069.045678833362;7136.821579460509;5836.007878660627;7027.824304392393;7038.542494737839;7054.57672539648;7056.188538318095;4456.974895773966;4953.380827396575;5186.948130518703;5203.245529398235;5226.2944502492055;4390.934135987963;4552.726836389811;4620.260758278676;4821.059893320804;5028.874278143057;5075.467075957026;5111.591072714174;5123.820666276681;5132.5124113209185;5147.330846989886;4762.928556071662;5094.286799848006;5105.846824595231;5116.820911268106;5128.9230661540105;3864.536255649312;4358.912821743547;4373.387725718402;4374.671899607511;4387.363832244307;5868.061110222387;5889.204957330791;6542.3130571290285;6807.2512023677355;6821.249662537117;5536.446355364472;5747.511461525775;6050.878982420371;6066.757329706807;6074.8785024299705;7011.614361210131;7230.710771569131;7312.268773122645;7471.2155223701275;7510.887336689954;4861.343718597979;4868.245421959602;4874.561289483963;4880.951190488121;4900.975495122537;7046.189688185873;7363.7849754790395;7894.171112033211;7906.841863162762;7912.762617121495;4113.629773320416;4856.708597484162;4964.652474326835;4965.677230979974;4974.37820272466;5064.696118232918;5066;5080.161773307437;5081.59347252219;5085.1355269604255;5936.643801371932;6011.887800756786;6017.819465416044;6018.6990650467305;6046.032634778414;7293.708251669874;7445.478816482902;7488.887666685004;7512.924870751332;7519.887201691979;1742.1637613945377;1759.9472015839544;1761.5155832146263;1768.1689605885213;1772.1227992143713;1126.4367816091954;1134.8524691790014;1136.1365362324527;1136.9260998035268;1145.1754736589642;6940.13248343957;6940.236573976858;6954.617496037767;6980.650967451607;7023.22744498115;6221.720022598994;7608.31525162738;7611.65747541362;7642.426817988673;7644.388448924073;6772.8984065239065;6942.791716248521;6947.096877405905;6964.129483814523;7024.754133605402;4101.630853223224;4135.1316223592785;4144.48193975753;4146.834126634901;4150.667946564267;8140.877886831702;8141.552214628252;8144.796380090545;8156.714514991947;8158.918410815816;7845;8022.27799498048;8074.757757267292;8075.919240807634;8077.990251218597;6702.765403210864;7404.704176769043;8184.345252379795;8189;8201;6144.38556144382;6997.790066298019;7193.244709305448;7829.099653539688;7853.214678532101;6759.715654025719;6820.249772525118;7717.884231736416;7729.6521656524465;7734.458587898793;7974.760757177294;8243.505389676639;8252.711155109542;8259.793505162419;8282.792930176794;3959.287328280937;4822.300766388924;4823.686460380064;4824.155772739827;4839.806407743651;7747.612619368896;7747.961260193663;7784.766457006299;7790.376769858511;7796.415268854972;7360.017230154754;7445.292697193758;7512.661930213263;7537.095548533992;7538.0954285483895;7494.5128566643;7517.323440890346;7524.2851929066655;7531.510451820614;7546.735864244725;7149.0706208192605;7332.376747976482;7337.376323012603;7354.742584009534;7372.041634587469;7472.514286571355;7485.251474852471;7495.850082998419;7508;7516.586587737727;7350.338469537767;7364;7377.815554610963;7381.520201186906;7412.11054673421 04:34:29 INFO - PROCESS | 1684 | |5;yui.html;649.502895825123;683.9760608378705;704.063595418094;705.6753893209125;708.9822754431135;14832.925835370821;15115.697686046273;15234.542963711092;15266.69466610667;17401.651966960686;15906.681866362665;15947.362105515795;15956.920215398906;15963.361465541364;16043.518694439157;708.0724251230904;869.2915274051659;884.3102380143498;886.3795343259744;886.7472770260478;847.9491230526157;864.191980498233;868.7914900423916;871.263782104121;874.1215078845783;892.830362231174;921.6129225725211;923.6490133749165;925.8102089071758;925.8981512033671;906.9274458043341;911.8495448251031;921.1433366968716;922.5064590444114;924.1451657217048;673.3939454490949;679.5752654590881;685.0341019163006;685.8285428642839;686.4748467422426;15479.845201548065;15557.844421555867;15580;15582.06507609547;15707.293171807296;12588.118831681786;12632.368381580884;12807.871921280854;12874.034447416387;13101;10053.221764006898;10209.2467118374;10235.897641023568;10268.589256429734;10281.331713438603;3371.325734853039;3462.342154990569;3463.1515278756615;3472.9131771705656;3482.164280572644;87905.56047219787;89666;90829;91108;92308.53845730795;9189.448633082036;9407.623695052122;9601.231901447867;9874.80250394988;9960.551775170135;20376.796232037785;20626.793732062488;20627;20657.690134647994;20729.27447539329;7283.890741638879;7560.886586701204;7598.20218877021;7792.610369481503;7967.8406431871035;4118.938215926763;4123.505179378494;4163.562825903297;4312.417823593837;4315.726860576137;2932.398858234057;2985.6566494852937;3482.077249528877;3482.930341393158;3488.5116083748294;632.2886752403546;643.2024289880515;647.1748520636132;661.5137873662854;667.559410788877;561.2899681902396;617.0965606819901;619.8977168767103;628.9654069026155;634.80321100459;8354.665813367397;8517.57412129391;8746.86879696805;8782.473051616924;8841.955790221007;596.9761209551656;608.3551435478319;608.3855306140741;624.9062640603946;636.926753423353;3524.3656141894703;3828.808559572066;3936.566977632458;3980.2238563480423;3989.2819292527624;86975.82560436039;88122.11877881267;88211;89799;90076;76979.23020769721;77138;78325;78450.6077469609;78662.82005769918;61585.384146157965;62645;63145.05282420675;63433.048504272476;76282.61858690671;8162;8359.916400835913;8428.4942903426;8498;9032.412893161923;46791.766041169576;50147.74926125346;55228.17157742717;55657;59773.10340344811;77095.84356234549;77551.61224193843;77831.22168778467;77946.2205377939;80682.43094805273;11627;11779.411029448322;11812.586559470377;11929.642110736691;12232.877671223174;11729.178957472895;11950.103742219542;12110.878891210976;12228.816567751668;12332.07509436778;11328.263662861887;11488.368139752394;11628.709282267673;11894;12005.459754311252;11452;11511.94244028808;11943.402829858645;11968.102392320785;12358.814617780561;10940.12479001662;11318.717032074264;11579.478923448296;11876.881231187923;11923.880761192277;9642.471279748674;9839.754006149904;10011.849822252818;10152.949235254073;10206.897931020892;9751.951240243754;10179.578148090912;10200.489975501047;10255.974402559685;10427.530761115617 04:34:29 INFO - PROCESS | 1684 | __end_tp_report 04:34:29 INFO - PROCESS | 1684 | __start_cc_report 04:34:29 INFO - PROCESS | 1684 | _x_x_mozilla_cycle_collect,356 04:34:29 INFO - PROCESS | 1684 | __end_cc_report 04:34:29 INFO - PROCESS | 1684 | __startTimestamp1455798869200__endTimestamp 04:34:29 INFO - PROCESS | 1684 | 04:34:29 INFO - PROCESS | 1684 | ------- Summary: start ------- 04:34:29 INFO - PROCESS | 1684 | Number of tests: 6 04:34:29 INFO - PROCESS | 1684 | 04:34:29 INFO - PROCESS | 1684 | [#0] dojo.html Cycles:165 Average:5760.16 Median:6062.51 stddev:670.85 (11.1%) stddev-sans-first:637.30 04:34:29 INFO - PROCESS | 1684 | Values: 3011.0 3097.6 3364.5 3456.8 3638.8 4855.7 4942.7 5809.9 5956.5 6028.5 4233.6 5856.8 5861.7 5934.3 5970.7 5167.4 5222.6 5341.0 5347.8 5443.3 5337.9 5378.2 5391.9 5395.2 5401.5 5157.6 5177.6 5305.9 5312.0 5314.9 5274.2 5283.0 5283.2 5287.8 5370.8 5117.1 5214.3 5220.3 5272.2 5296.5 5630.5 5700.4 5793.4 5815.5 5826.9 6206.6 6221.2 6243.3 6252.8 6256.2 5788.6 6193.9 6216.6 6239.3 6264.6 5916.4 5970.2 5971.0 5983.3 5998.1 5968.0 6067.1 6194.1 6364.1 6403.4 6140.5 6252.7 6271.9 6272.1 6291.6 5019.0 6227.7 6233.5 6236.7 6240.3 6079.1 6092.9 6140.4 6144.0 6165.1 6157.3 6162.4 6162.5 6167.1 6176.0 4937.6 4950.0 4978.1 4996.4 5001.1 4383.6 4403.9 4415.3 4432.9 4488.8 5109.9 5257.5 5924.6 5987.1 6070.2 5263.3 5775.0 5874.6 6169.9 6284.2 5073.2 6004.6 6037.2 6044.4 6062.5 5441.3 5450.6 5467.9 5476.5 5489.2 5391.2 6258.8 6446.1 6453.6 6460.7 6197.0 6250.8 6260.6 6266.1 6310.0 6281.3 6446.8 6492.9 6497.9 6510.1 6179.6 6229.8 6232.8 6239.6 6250.3 6027.9 6182.3 6208.3 6210.1 6247.0 6104.8 6150.2 6160.1 6215.6 6250.0 6171.3 6202.5 6225.7 6228.1 6230.3 5995.6 6081.1 6132.0 6139.8 6149.3 6140.1 6140.7 6202.4 6207.6 6213.5 6159.2 6160.3 6167.1 6179.6 6184.8 04:34:29 INFO - PROCESS | 1684 | 04:34:29 INFO - PROCESS | 1684 | [#1] ext.html Cycles:180 Average:66776.14 Median:38067.62 stddev:143775.33 (377.7%) stddev-sans-first:144092.48 04:34:29 INFO - PROCESS | 1684 | Values: 476.5 492.9 552.9 555.5 574.0 36971.4 37285.0 37512.4 37553.2 37596.6 38502.0 38844.6 38924.2 39051.8 39147.6 9432.3 9637.3 9676.7 9692.3 9699.0 9465.1 9515.0 9550.3 9591.4 9595.4 9527.9 9528.9 9616.0 9625.9 9630.2 9618.6 9632.8 9671.8 9715.8 9720.9 9514.0 9516.0 9549.0 9623.2 9639.5 31442.0 37733.6 37811.7 37823.6 38075.2 3010.3 3179.9 3208.5 3407.8 3771.7 27548.9 27727.8 28214.4 28793.7 29158.7 2787.8 2814.6 2830.4 2849.5 2882.7 406609.0 407301.6 409826.0 410092.0 410356.0 57371.0 63483.0 64180.7 66264.3 67587.3 64476.0 64670.0 64742.7 64962.0 65215.3 14506.3 14830.5 16046.9 16116.4 16201.7 12187.5 12406.8 12415.3 12437.7 12472.0 20174.4 21078.8 21202.7 21203.5 21240.5 9118.8 9258.0 9343.3 9356.2 9420.8 816.3 856.3 908.4 1067.2 1108.2 26089.9 29189.4 29434.0 29735.7 29850.9 1074.2 1093.1 1160.8 1174.3 1182.0 14941.9 15214.6 15269.9 15972.0 16222.9 575401.0 662479.0 666052.0 668832.0 677980.0 59783.7 60096.7 60109.7 60282.7 60459.4 1210.3 1390.9 1393.2 1395.6 1418.8 30043.7 30169.0 30543.8 30766.2 30950.5 41243.6 50776.5 51236.5 51523.5 51783.2 522107.0 526012.0 527282.0 528772.0 529121.0 32674.0 43447.1 45299.3 45807.5 45866.5 43338.8 43590.0 44009.1 44273.0 44795.0 36213.9 37057.9 37287.8 38060.0 38415.8 34755.8 35115.8 35163.0 35546.6 35592.6 28161.6 30266.7 34587.0 34644.8 34710.0 31239.8 32713.8 32738.0 32894.3 32949.5 19451.6 24279.4 24598.1 24935.8 24993.1 04:34:29 INFO - PROCESS | 1684 | 04:34:29 INFO - PROCESS | 1684 | [#2] jquery.html Cycles:180 Average:36957.51 Median:4494.20 stddev:126199.27 (2808.0%) stddev-sans-first:126523.26 04:34:29 INFO - PROCESS | 1684 | Values: 293.5 363.2 364.7 369.0 370.6 15821.9 19305.4 19873.3 20190.6 21312.9 19567.1 20180.7 20200.6 20578.7 20617.4 5621.2 5719.5 5887.6 5940.2 5942.7 5805.2 5872.2 5915.9 5926.5 5935.8 4117.7 4774.5 5803.0 6059.6 6299.7 5416.5 6248.0 6267.2 6274.3 6280.2 5362.0 5413.6 5421.5 5426.2 5441.4 12237.0 12746.5 12759.6 12774.9 18663.9 2151.4 2164.4 2434.3 2567.7 2646.9 9229.6 9682.7 9779.5 11346.9 13680.7 1758.9 1817.6 1853.3 1860.8 1877.4 99735.0 100293.5 100529.0 101233.0 101507.5 9458.9 10733.2 11021.8 11110.3 11117.7 12954.5 12967.5 12975.8 13014.9 13122.5 8385.3 8455.7 8476.4 8525.3 8532.5 6606.2 8564.7 8658.4 8673.5 8688.2 4417.7 4490.1 4498.3 4498.6 4518.1 1822.2 1836.1 1871.9 1921.0 1947.4 384.0 385.4 409.3 806.5 933.5 9502.8 11694.7 11734.6 11861.9 11866.0 410.5 437.0 437.3 444.4 448.3 5955.7 6091.3 6113.7 6141.1 6143.9 668372.6 741598.3 778334.0 815344.0 818923.0 88342.0 108058.0 112047.0 112454.0 113752.9 433.8 483.4 485.7 488.6 488.7 8738.0 10866.6 10966.4 11047.4 11075.6 48256.0 48588.8 49366.3 49490.8 49765.3 64731.7 69773.0 72482.0 73213.0 74995.6 7523.1 7749.5 7753.8 7778.8 7894.5 6864.3 10877.3 11477.4 12189.8 12414.1 10297.4 10566.7 10671.6 10851.5 10907.8 10476.5 10528.8 10585.1 10602.9 10884.8 6297.8 8444.0 10575.5 11192.1 11216.9 7381.2 7741.1 7860.7 7903.6 7906.2 7262.2 7352.4 7676.9 7802.5 7898.7 04:34:29 INFO - PROCESS | 1684 | 04:34:29 INFO - PROCESS | 1684 | [#3] mootools.html Cycles:180 Average:6070.58 Median:4938.64 stddev:3177.50 (64.3%) stddev-sans-first:3167.82 04:34:29 INFO - PROCESS | 1684 | Values: 1497.2 1503.5 1721.4 1867.1 1867.7 7864.7 8514.5 8631.8 8795.7 8820.6 8532.4 8622.7 8690.0 8742.1 8778.5 2458.6 2469.7 2485.5 2494.5 2497.4 2423.4 2490.4 2490.7 2490.9 2492.4 2152.2 2395.2 2446.7 2468.1 2473.2 2384.4 2420.2 2423.6 2427.5 2435.6 2461.8 2463.2 2471.3 2471.9 2474.5 8635.1 8654.3 8684.0 8691.5 8693.2 5235.1 5464.9 5489.0 5501.0 5502.8 3656.2 3671.7 3702.2 3715.7 3761.5 1050.2 1054.4 1057.7 1074.0 1074.9 11932.9 11954.7 12008.0 12016.0 12030.7 4811.1 4816.0 4890.0 4899.0 4908.7 10100.8 10107.4 10127.3 10178.9 10179.4 5424.8 5460.8 5470.1 5480.6 5491.5 4889.8 4921.5 4955.8 4963.8 4988.0 3933.7 3936.6 3943.4 3961.5 3972.9 1208.6 1295.1 1298.7 1301.0 1317.0 1107.8 1110.8 1136.6 1280.8 1381.5 7987.2 7999.2 8058.0 8100.4 8146.2 1106.7 1115.7 1188.3 1203.4 1205.2 6165.8 6233.6 6242.3 6263.7 6278.6 10263.4 10424.7 10543.4 10562.4 10565.7 10216.1 10294.1 10413.0 10480.4 10498.8 8100.9 8209.0 8282.0 8296.7 8301.7 7991.8 8002.4 8048.7 8084.2 8228.7 9617.5 9681.2 9762.4 9780.7 9868.2 9816.0 10216.7 10228.5 10235.2 10238.1 7271.2 7447.7 7455.4 7552.7 7581.4 8078.6 8112.4 8162.3 8185.0 8220.0 7210.7 7502.7 7606.8 7716.5 7791.8 7437.2 7522.4 7563.2 7605.0 7652.3 7651.7 7701.9 7713.3 7721.5 7746.5 6274.5 6907.3 6945.4 6997.7 7025.5 5888.8 7145.1 7189.7 7193.0 7204.4 04:34:29 INFO - PROCESS | 1684 | 04:34:29 INFO - PROCESS | 1684 | [#4] prototype.html Cycles:180 Average:6057.87 Median:6940.18 stddev:1960.38 (28.2%) stddev-sans-first:1916.93 04:34:29 INFO - PROCESS | 1684 | Values: 257.9 322.9 329.6 330.3 331.0 6636.2 6763.8 6882.5 7069.0 7136.8 5836.0 7027.8 7038.5 7054.6 7056.2 4457.0 4953.4 5186.9 5203.2 5226.3 4390.9 4552.7 4620.3 4821.1 5028.9 5075.5 5111.6 5123.8 5132.5 5147.3 4762.9 5094.3 5105.8 5116.8 5128.9 3864.5 4358.9 4373.4 4374.7 4387.4 5868.1 5889.2 6542.3 6807.3 6821.2 5536.4 5747.5 6050.9 6066.8 6074.9 7011.6 7230.7 7312.3 7471.2 7510.9 4861.3 4868.2 4874.6 4881.0 4901.0 7046.2 7363.8 7894.2 7906.8 7912.8 4113.6 4856.7 4964.7 4965.7 4974.4 5064.7 5066.0 5080.2 5081.6 5085.1 5936.6 6011.9 6017.8 6018.7 6046.0 7293.7 7445.5 7488.9 7512.9 7519.9 1742.2 1759.9 1761.5 1768.2 1772.1 1126.4 1134.9 1136.1 1136.9 1145.2 6940.1 6940.2 6954.6 6980.7 7023.2 6221.7 7608.3 7611.7 7642.4 7644.4 6772.9 6942.8 6947.1 6964.1 7024.8 4101.6 4135.1 4144.5 4146.8 4150.7 8140.9 8141.6 8144.8 8156.7 8158.9 7845.0 8022.3 8074.8 8075.9 8078.0 6702.8 7404.7 8184.3 8189.0 8201.0 6144.4 6997.8 7193.2 7829.1 7853.2 6759.7 6820.2 7717.9 7729.7 7734.5 7974.8 8243.5 8252.7 8259.8 8282.8 3959.3 4822.3 4823.7 4824.2 4839.8 7747.6 7748.0 7784.8 7790.4 7796.4 7360.0 7445.3 7512.7 7537.1 7538.1 7494.5 7517.3 7524.3 7531.5 7546.7 7149.1 7332.4 7337.4 7354.7 7372.0 7472.5 7485.3 7495.9 7508.0 7516.6 7350.3 7364.0 7377.8 7381.5 7412.1 04:34:29 INFO - PROCESS | 1684 | 04:34:29 INFO - PROCESS | 1684 | [#5] yui.html Cycles:180 Average:18886.04 Median:31096.88 stddev:26563.74 (85.4%) stddev-sans-first:26602.97 04:34:29 INFO - PROCESS | 1684 | Values: 649.5 684.0 704.1 705.7 709.0 14832.9 15115.7 15234.5 15266.7 17401.7 15906.7 15947.4 15956.9 15963.4 16043.5 708.1 869.3 884.3 886.4 886.7 847.9 864.2 868.8 871.3 874.1 892.8 921.6 923.6 925.8 925.9 906.9 911.8 921.1 922.5 924.1 673.4 679.6 685.0 685.8 686.5 15479.8 15557.8 15580.0 15582.1 15707.3 12588.1 12632.4 12807.9 12874.0 13101.0 10053.2 10209.2 10235.9 10268.6 10281.3 3371.3 3462.3 3463.2 3472.9 3482.2 87905.6 89666.0 90829.0 91108.0 92308.5 9189.4 9407.6 9601.2 9874.8 9960.6 20376.8 20626.8 20627.0 20657.7 20729.3 7283.9 7560.9 7598.2 7792.6 7967.8 4118.9 4123.5 4163.6 4312.4 4315.7 2932.4 2985.7 3482.1 3482.9 3488.5 632.3 643.2 647.2 661.5 667.6 561.3 617.1 619.9 629.0 634.8 8354.7 8517.6 8746.9 8782.5 8842.0 597.0 608.4 608.4 624.9 636.9 3524.4 3828.8 3936.6 3980.2 3989.3 86975.8 88122.1 88211.0 89799.0 90076.0 76979.2 77138.0 78325.0 78450.6 78662.8 61585.4 62645.0 63145.1 63433.0 76282.6 8162.0 8359.9 8428.5 8498.0 9032.4 46791.8 50147.7 55228.2 55657.0 59773.1 77095.8 77551.6 77831.2 77946.2 80682.4 11627.0 11779.4 11812.6 11929.6 12232.9 11729.2 11950.1 12110.9 12228.8 12332.1 11328.3 11488.4 11628.7 11894.0 12005.5 11452.0 11511.9 11943.4 11968.1 12358.8 10940.1 11318.7 11579.5 11876.9 11923.9 9642.5 9839.8 10011.8 10152.9 10206.9 9752.0 10179.6 10200.5 10256.0 10427.5 04:34:29 INFO - PROCESS | 1684 | -------- Summary: end -------- 04:34:29 INFO - PROCESS | 1684 | 04:34:29 INFO - TEST-INFO | 1684: exit 0 04:34:29 INFO - TEST-OK | dromaeo_css | took 1110680ms 04:34:29 INFO - TEST-START | kraken 04:34:29 INFO - operating with platform_type : mac_ 04:34:29 INFO - Initialising browser for kraken test... 04:34:29 INFO - TEST-INFO | started process 1693 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/tmpgr_MNv/profile http://localhost:49278/getInfo.html) 04:34:32 INFO - PROCESS | 1693 | __metrics Screen width/height:1600/1200 04:34:32 INFO - PROCESS | 1693 | colorDepth:24 04:34:32 INFO - PROCESS | 1693 | Browser inner width/height: 1024/689 04:34:32 INFO - PROCESS | 1693 | __metrics 04:34:32 ERROR - PROCESS | 1693 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2871: TypeError: this.tabs is undefined 04:34:33 INFO - TEST-INFO | 1693: exit 0 04:34:33 INFO - Browser initialized. 04:34:33 INFO - Running cycle 1/1 for kraken test... 04:34:33 INFO - TEST-INFO | started process 1696 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/tmpgr_MNv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:34:45 INFO - PROCESS | 1696 | RSS: Main: 257376256 04:34:45 INFO - PROCESS | 1696 | 04:34:48 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 04:34:48 INFO - PROCESS | 1696 | RSS: Main: 269377536 04:34:48 INFO - PROCESS | 1696 | 04:34:51 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 04:34:51 INFO - PROCESS | 1696 | RSS: Main: 277078016 04:34:51 INFO - PROCESS | 1696 | 04:34:55 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 04:34:55 INFO - PROCESS | 1696 | RSS: Main: 279715840 04:34:55 INFO - PROCESS | 1696 | 04:34:57 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 04:34:58 INFO - PROCESS | 1696 | RSS: Main: 281571328 04:34:58 INFO - PROCESS | 1696 | 04:35:00 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:35:01 INFO - PROCESS | 1696 | RSS: Main: 282312704 04:35:01 INFO - PROCESS | 1696 | 04:35:04 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 04:35:04 INFO - PROCESS | 1696 | RSS: Main: 284237824 04:35:04 INFO - PROCESS | 1696 | 04:35:07 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 04:35:08 INFO - PROCESS | 1696 | RSS: Main: 283996160 04:35:08 INFO - PROCESS | 1696 | 04:35:11 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 04:35:12 INFO - PROCESS | 1696 | RSS: Main: 284315648 04:35:12 INFO - PROCESS | 1696 | 04:35:13 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:35:14 INFO - PROCESS | 1696 | RSS: Main: 284151808 04:35:14 INFO - PROCESS | 1696 | 04:35:16 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:35:16 INFO - PROCESS | 1696 | RSS: Main: 282542080 04:35:16 INFO - PROCESS | 1696 | 04:35:19 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:35:19 INFO - PROCESS | 1696 | RSS: Main: 283488256 04:35:19 INFO - PROCESS | 1696 | 04:35:22 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:35:22 INFO - PROCESS | 1696 | RSS: Main: 282386432 04:35:22 INFO - PROCESS | 1696 | 04:35:25 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:35:25 INFO - PROCESS | 1696 | RSS: Main: 284512256 04:35:25 INFO - PROCESS | 1696 | 04:35:27 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 04:35:27 INFO - PROCESS | 1696 | RSS: Main: 284131328 04:35:27 INFO - PROCESS | 1696 | 04:35:27 INFO - PROCESS | 1696 | __start_tp_report 04:35:27 INFO - PROCESS | 1696 | _x_x_mozilla_page_load 04:35:27 INFO - PROCESS | 1696 | _x_x_mozilla_page_load_details 04:35:27 INFO - PROCESS | 1696 | |i|pagename|runs| 04:35:27 INFO - PROCESS | 1696 | |0;ai-astar;122;153;169;117;171;171;115;114;115;115 04:35:27 INFO - PROCESS | 1696 | |1;audio-beat-detection;177;159;177;153;129;142;141;127;157;123 04:35:27 INFO - PROCESS | 1696 | |2;audio-dft;190;197;198;208;209;233;272;200;202;195 04:35:27 INFO - PROCESS | 1696 | |3;audio-fft;66;84;69;138;87;78;76;59;112;58 04:35:27 INFO - PROCESS | 1696 | |4;audio-oscillator;82;82;103;78;108;123;150;114;81;113 04:35:27 INFO - PROCESS | 1696 | |5;imaging-gaussian-blur;107;139;99;94;87;93;89;93;90;94 04:35:27 INFO - PROCESS | 1696 | |6;imaging-darkroom;132;97;138;148;96;97;97;97;138;97 04:35:27 INFO - PROCESS | 1696 | |7;imaging-desaturate;83;109;104;145;110;97;77;78;129;152 04:35:27 INFO - PROCESS | 1696 | |8;json-parse-financial;54;57;56;56;55;71;65;91;86;86 04:35:27 INFO - PROCESS | 1696 | |9;json-stringify-tinderbox;64;67;75;77;94;103;103;98;66;65 04:35:27 INFO - PROCESS | 1696 | |10;stanford-crypto-aes;92;110;115;73;100;115;77;88;71;109 04:35:27 INFO - PROCESS | 1696 | |11;stanford-crypto-ccm;127;130;124;124;123;126;134;127;138;137 04:35:27 INFO - PROCESS | 1696 | |12;stanford-crypto-pbkdf2;129;129;128;141;141;140;142;141;142;143 04:35:27 INFO - PROCESS | 1696 | |13;stanford-crypto-sha256-iterative;66;66;68;68;71;69;72;81;68;65 04:35:27 INFO - PROCESS | 1696 | __end_tp_report 04:35:27 INFO - PROCESS | 1696 | __start_cc_report 04:35:27 INFO - PROCESS | 1696 | _x_x_mozilla_cycle_collect,883 04:35:27 INFO - PROCESS | 1696 | __end_cc_report 04:35:27 INFO - PROCESS | 1696 | __startTimestamp1455798927837__endTimestamp 04:35:27 INFO - PROCESS | 1696 | 04:35:27 INFO - PROCESS | 1696 | ------- Summary: start ------- 04:35:27 INFO - PROCESS | 1696 | Number of tests: 14 04:35:27 INFO - PROCESS | 1696 | 04:35:27 INFO - PROCESS | 1696 | [#0] ai-astar Cycles:10 Average:136.20 Median:137.50 stddev:26.23 (19.1%) stddev-sans-first:27.31 04:35:27 INFO - PROCESS | 1696 | Values: 122.0 153.0 169.0 117.0 171.0 171.0 115.0 114.0 115.0 115.0 04:35:27 INFO - PROCESS | 1696 | 04:35:27 INFO - PROCESS | 1696 | [#1] audio-beat-detection Cycles:10 Average:148.50 Median:155.00 stddev:19.49 (12.6%) stddev-sans-first:17.73 04:35:27 INFO - PROCESS | 1696 | Values: 177.0 159.0 177.0 153.0 129.0 142.0 141.0 127.0 157.0 123.0 04:35:27 INFO - PROCESS | 1696 | 04:35:27 INFO - PROCESS | 1696 | [#2] audio-dft Cycles:10 Average:210.40 Median:205.00 stddev:24.67 (12.0%) stddev-sans-first:25.04 04:35:27 INFO - PROCESS | 1696 | Values: 190.0 197.0 198.0 208.0 209.0 233.0 272.0 200.0 202.0 195.0 04:35:27 INFO - PROCESS | 1696 | 04:35:27 INFO - PROCESS | 1696 | [#3] audio-fft Cycles:10 Average:82.70 Median:72.50 stddev:25.04 (34.5%) stddev-sans-first:25.82 04:35:27 INFO - PROCESS | 1696 | Values: 66.0 84.0 69.0 138.0 87.0 78.0 76.0 59.0 112.0 58.0 04:35:27 INFO - PROCESS | 1696 | 04:35:27 INFO - PROCESS | 1696 | [#4] audio-oscillator Cycles:10 Average:103.40 Median:114.00 stddev:23.20 (20.4%) stddev-sans-first:23.28 04:35:27 INFO - PROCESS | 1696 | Values: 82.0 82.0 103.0 78.0 108.0 123.0 150.0 114.0 81.0 113.0 04:35:27 INFO - PROCESS | 1696 | 04:35:27 INFO - PROCESS | 1696 | [#5] imaging-gaussian-blur Cycles:10 Average:98.50 Median:93.00 stddev:15.31 (16.5%) stddev-sans-first:15.92 04:35:27 INFO - PROCESS | 1696 | Values: 107.0 139.0 99.0 94.0 87.0 93.0 89.0 93.0 90.0 94.0 04:35:27 INFO - PROCESS | 1696 | 04:35:27 INFO - PROCESS | 1696 | [#6] imaging-darkroom Cycles:10 Average:113.70 Median:97.00 stddev:22.11 (22.8%) stddev-sans-first:22.44 04:35:27 INFO - PROCESS | 1696 | Values: 132.0 97.0 138.0 148.0 96.0 97.0 97.0 97.0 138.0 97.0 04:35:27 INFO - PROCESS | 1696 | 04:35:27 INFO - PROCESS | 1696 | [#7] imaging-desaturate Cycles:10 Average:108.40 Median:114.50 stddev:26.61 (23.2%) stddev-sans-first:26.59 04:35:27 INFO - PROCESS | 1696 | Values: 83.0 109.0 104.0 145.0 110.0 97.0 77.0 78.0 129.0 152.0 04:35:27 INFO - PROCESS | 1696 | 04:35:27 INFO - PROCESS | 1696 | [#8] json-parse-financial Cycles:10 Average:67.70 Median:68.00 stddev:14.79 (21.7%) stddev-sans-first:14.83 04:35:27 INFO - PROCESS | 1696 | Values: 54.0 57.0 56.0 56.0 55.0 71.0 65.0 91.0 86.0 86.0 04:35:27 INFO - PROCESS | 1696 | 04:35:27 INFO - PROCESS | 1696 | [#9] json-stringify-tinderbox Cycles:10 Average:81.20 Median:71.00 stddev:16.48 (23.2%) stddev-sans-first:16.26 04:35:27 INFO - PROCESS | 1696 | Values: 64.0 67.0 75.0 77.0 94.0 103.0 103.0 98.0 66.0 65.0 04:35:27 INFO - PROCESS | 1696 | 04:35:27 INFO - PROCESS | 1696 | [#10] stanford-crypto-aes Cycles:10 Average:95.00 Median:72.00 stddev:17.28 (24.0%) stddev-sans-first:18.30 04:35:27 INFO - PROCESS | 1696 | Values: 92.0 110.0 115.0 73.0 100.0 115.0 77.0 88.0 71.0 109.0 04:35:27 INFO - PROCESS | 1696 | 04:35:27 INFO - PROCESS | 1696 | [#11] stanford-crypto-ccm Cycles:10 Average:129.00 Median:128.50 stddev:5.52 (4.3%) stddev-sans-first:5.80 04:35:27 INFO - PROCESS | 1696 | Values: 127.0 130.0 124.0 124.0 123.0 126.0 134.0 127.0 138.0 137.0 04:35:27 INFO - PROCESS | 1696 | 04:35:27 INFO - PROCESS | 1696 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.60 Median:141.00 stddev:6.22 (4.4%) stddev-sans-first:5.77 04:35:27 INFO - PROCESS | 1696 | Values: 129.0 129.0 128.0 141.0 141.0 140.0 142.0 141.0 142.0 143.0 04:35:27 INFO - PROCESS | 1696 | 04:35:27 INFO - PROCESS | 1696 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:68.50 stddev:4.62 (6.7%) stddev-sans-first:4.74 04:35:27 INFO - PROCESS | 1696 | Values: 66.0 66.0 68.0 68.0 71.0 69.0 72.0 81.0 68.0 65.0 04:35:27 INFO - PROCESS | 1696 | -------- Summary: end -------- 04:35:27 INFO - PROCESS | 1696 | 04:35:28 INFO - TEST-INFO | 1696: exit 0 04:35:28 INFO - TEST-OK | kraken | took 59052ms 04:35:28 INFO - SUITE-END | took 1169s 04:35:29 INFO - Completed test suite (00:19:29) 04:35:29 INFO - Working with test: dromaeo_css 04:35:29 INFO - Generating results file: dromaeo_css 04:35:29 INFO - Working with test: kraken 04:35:29 INFO - Generating results file: kraken 04:35:29 INFO - javascript benchmark 04:35:29 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:35:29 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 04:35:29 INFO - process_Request line: dromaeo_css 7465.38 graph.html#tests=[[72,64,61]] 04:35:29 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:35:29 INFO - process_Request line: kraken 1581.70 graph.html#tests=[[232,64,61]] 04:35:29 INFO - RETURN: dromaeo_css: 7465.38 04:35:29 INFO - RETURN: kraken: 1581.70 04:35:29 INFO - javascript benchmark 04:35:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3010.9698903010963, 3097.5818264534287, 3364.5457863188462, 3456.8074014465014, 3638.781673099614, 4855.684380515264, 4942.6540142190015, 5809.912851307223, 5956.493698035672, 6028.547858910577, 4233.618974292305, 5856.795012174574, 5861.677607731573, 5934.317553481351, 5970.6716130612795, 5167.379914410257, 5222.608304377168, 5340.973295133519, 5347.759350829222, 5443.265159203516, 5337.866553336178, 5378.193271009341, 5391.946080539184, 5395.190721391803, 5401.540869026137, 5157.638965272433, 5177.559907407875, 5305.946940530584, 5311.973440132774, 5314.893702125936, 5274.182501712203, 5283.022640811462, 5283.154695248781, 5287.814926477593, 5370.838874833761, 5117.104506711311, 5214.348206474191, 5220.347456567929, 5272.156454967187, 5296.549793267577, 5630.521405680481, 5700.40145784695, 5793.362730099686, 5815.476607105338, 5826.883462330772, 6206.627602343829, 6221.191245138149, 6243.282022567418, 6252.843678908018, 6256.15541901842, 5788.623739456922, 6193.87612247757, 6216.595921265103, 6239.251289845202, 6264.59280146789, 5916.3787802281, 5970.164177015221, 5971.014782560872, 5983.252093488314, 5998.100284957248, 5968.0, 6067.1202675611785, 6194.0708893666315, 6364.109024736541, 6403.359664033559, 6140.473573783541, 6252.718627661766, 6271.905921411182, 6272.090546870678, 6291.559590828598, 5018.974905125524, 6227.657478838707, 6233.470155036873, 6236.719347629368, 6240.251169859646, 6079.118527813443, 6092.870172099287, 6140.3552626974415, 6144.0, 6165.075238714139, 6157.321565119188, 6162.352952939967, 6162.5378096642935, 6167.105769663373, 6175.96912015446, 4937.629677774181, 4949.975250123726, 4978.054169707744, 4996.375453068366, 5001.099802035668, 4383.60547550722, 4403.889902752457, 4415.337699345124, 4432.889177770581, 4488.798004089824, 5109.901371205208, 5257.526822585909, 5924.644521328734, 5987.13186587951, 6070.180525628984, 5263.289455923401, 5774.971125144348, 5874.619464425857, 6169.876602467925, 6284.214473190851, 5073.239014147834, 6004.609700369462, 6037.154798328237, 6044.365341639153, 6062.514998800086, 5441.265429167091, 5450.618456708072, 5467.863303417446, 5476.452354764571, 5489.204065410493, 5391.245225668409, 6258.812235632939, 6446.09754634361, 6453.6127832329275, 6460.676966151767, 6196.969015154896, 6250.812475625738, 6260.62436253808, 6266.091416744638, 6310.0, 6281.309056003744, 6446.774362897276, 6492.902606461002, 6497.935020649922, 6510.056041873996, 6179.62922224668, 6229.844253893508, 6232.75068997235, 6239.625622462667, 6250.343713910156, 6027.939720602913, 6182.258129024546, 6208.348123446973, 6210.068489726577, 6246.969250073687, 6104.847378815565, 6150.169727086965, 6160.137580738789, 6215.627062376272, 6250.0, 6171.290301615192, 6202.472789812736, 6225.688715564294, 6228.128062071404, 6230.283517395557, 5995.640261584144, 6081.057436097412, 6131.96934015327, 6139.802738465956, 6149.323574406722, 6140.140380346666, 6140.688304616564, 6202.379762023762, 6207.6275423474735, 6213.471854892204, 6159.23009623797, 6160.260768707783, 6167.074938759222, 6179.62922224668, 6184.81445556634], "unit": "score", "name": "dojo.html", "value": 5718.6063442526965}, {"lowerIsBetter": false, "replicates": [476.53537800644375, 492.9235968424894, 552.866623421985, 555.5056000159856, 573.9655620662761, 36971.4454283186, 37285.0, 37512.437313440285, 37553.248935021285, 37596.624033759654, 38502.0, 38844.61155388445, 38924.22151556967, 39051.804740976324, 39147.629832955856, 9432.292578056638, 9637.325387222898, 9676.709698709015, 9692.27307951903, 9698.9515052425, 9465.148136667698, 9515.0, 9550.283728720338, 9591.42451452915, 9595.376300540478, 9527.90472095277, 9528.904710952906, 9616.0, 9625.90374096257, 9630.18143457807, 9618.567164477616, 9632.807343853083, 9671.806563868719, 9715.805683886354, 9720.902790972106, 9514.001029891831, 9516.0, 9548.952255238748, 9623.1820295275, 9639.518024098837, 31442.0, 37733.62266377328, 37811.67659131917, 37823.621763782285, 38075.238495230216, 3010.313929935913, 3179.8569064391927, 3208.4866421372467, 3407.795532268072, 3771.7359784815076, 27548.862255688793, 27727.752251148748, 28214.435711285863, 28793.712062879313, 29158.708412916025, 2787.790915681332, 2814.6340975673033, 2830.4197639483855, 2849.458602865449, 2882.726141016621, 406609.0, 407301.6349182529, 409826.0, 410092.0, 410356.0, 57371.0, 63483.0, 64180.71638567296, 66264.33735662678, 67587.3241267581, 64476.0, 64670.0, 64742.67628661921, 64962.0255696165, 65215.34784652188, 14506.347214375379, 14830.480933167502, 16046.876718629585, 16116.435924742813, 16201.675966480605, 12187.45156467961, 12406.75186496265, 12415.255084694947, 12437.689057773629, 12472.002239820793, 20174.394768156977, 21078.789212107684, 21202.681959770616, 21203.46991325229, 21240.468988275417, 9118.772030699152, 9257.95371023154, 9343.2525397968, 9356.204722598519, 9420.764480888032, 816.3183741575732, 856.2935578148052, 908.3596064774318, 1067.1622776120707, 1108.2187058124002, 26089.869550652504, 29189.41621167565, 29433.969811056937, 29735.702642973294, 29850.850745746568, 1074.2426589254558, 1093.109116070416, 1160.825876118589, 1174.3130268792681, 1181.9834941949916, 14941.925290373478, 15214.619634509227, 15269.923650381677, 15971.961822481502, 16222.918885405497, 575401.0, 662479.0, 666052.0, 668832.0, 677980.0, 59783.70108149519, 60096.699516502136, 60109.69945150334, 60282.69858650678, 60459.395406045376, 1210.2798834693344, 1390.867867552581, 1393.1849867827232, 1395.644110751752, 1418.8155539779762, 30043.673359250402, 30169.0, 30543.847280763453, 30766.230844229074, 30950.53574196434, 41243.587564123976, 50776.492235077174, 51236.48763512317, 51523.48476515187, 51783.2232516505, 522107.0, 526012.0, 527282.0, 528772.0, 529121.0, 32674.0, 43447.13105737931, 45299.320510193036, 45807.54192458033, 45866.541334586225, 43338.78330608327, 43590.0, 44009.11981760411, 44273.01542861158, 44795.0, 36213.91358259256, 37057.88826335214, 37287.81356093202, 38060.0, 38415.807920960215, 34755.82622086874, 35115.82442087773, 35163.0, 35546.64453355433, 35592.644073558935, 28161.577576336782, 30266.697333026386, 34587.0, 34644.82677586596, 34710.0, 31239.84380078176, 32713.836430817693, 32738.0, 32894.34211315712, 32949.50575741318, 19451.61096778085, 24279.393015174763, 24598.13906513335, 24935.755781978984, 24993.12524061649], "unit": "score", "name": "ext.html", "value": 19814.276136188382}, {"lowerIsBetter": false, "replicates": [293.46589207642086, 363.24626400219535, 364.6881915961853, 368.9907752306192, 370.62011438275783, 15821.920890395531, 19305.420837374884, 19873.304434344802, 20190.596188076248, 21312.93435328235, 19567.119479623416, 20180.69728954067, 20200.59598808023, 20578.691319630216, 20617.38147855563, 5621.241132447119, 5719.48524632785, 5887.617304875191, 5940.19807326012, 5942.732577034022, 5805.158252053449, 5872.236609240814, 5915.940840591582, 5926.525877929756, 5935.821925342225, 4117.732347397409, 4774.522547745215, 5803.013487707079, 6059.636421814683, 6299.685015749217, 5416.458354164592, 6248.0, 6267.185265915425, 6274.309825919146, 6280.183576135073, 5361.973190134025, 5413.621046526745, 5421.512063914227, 5426.240326354314, 5441.428649991773, 12237.0, 12746.490140394466, 12759.553415630407, 12774.936125319315, 18663.90668046651, 2151.408362700254, 2164.3723320237114, 2434.2683053900246, 2567.679040119985, 2646.907358242452, 9229.6308147674, 9682.741433021807, 9779.46212958287, 11346.943265283704, 13680.726385472335, 1758.9296428142986, 1817.5728703754608, 1853.2679591561257, 1860.7953125156223, 1877.4367689693038, 99735.01589904557, 100293.49853250687, 100529.0, 101232.9876701231, 101507.49246253795, 9458.905410945803, 10733.248672593, 11021.83467247992, 11110.333379997226, 11117.72205694848, 12954.546590869462, 12967.481300747864, 12975.77078232603, 13014.869851301366, 13122.540711075066, 8385.329173666092, 8455.74632761018, 8476.4490308131, 8525.31797456202, 8532.530710810965, 6606.240282367493, 8564.657413703506, 8658.437201581877, 8673.522956237468, 8688.218060374596, 4417.734935903856, 4490.12442573695, 4498.280275155959, 4498.617617502484, 4518.1415531049, 1822.2255541394854, 1836.1370156026646, 1871.8876867388, 1920.9711854322197, 1947.3642140601962, 383.98848034559006, 385.4026259298077, 409.3470913892337, 806.5201205282847, 933.50524222161, 9502.809943801085, 11694.70763230909, 11734.647960561197, 11861.932426081694, 11866.0, 410.48689138576776, 437.0472370232859, 437.2588462555937, 444.4044979727181, 448.33422367783817, 5955.702214889238, 6091.269047714302, 6113.694315284218, 6141.07883817422, 6143.907841382383, 668372.5557838725, 741598.2920085365, 778334.0, 815344.0, 818923.0, 88342.0, 108058.0, 112047.0, 112454.0, 113752.86247137423, 433.80919376311596, 483.44645381038515, 485.71342907684635, 488.5602957338353, 488.71898658271635, 8738.0, 10866.565337386415, 10966.396848173108, 11047.447627618427, 11075.612353567587, 48256.0, 48588.75705621449, 49366.25950610815, 49490.762730932016, 49765.253521196486, 64731.705365891474, 69773.0, 72482.0, 73213.0, 74995.62502187454, 7523.1348394935285, 7749.457537972513, 7753.806154846174, 7778.766637000899, 7894.526328420313, 6864.313568643096, 10877.292975956538, 11477.417581044198, 12189.817152742538, 12414.068944828994, 10297.433641149808, 10566.682999510027, 10671.626493072705, 10851.45742712877, 10907.836382454429, 10476.476176191312, 10528.789424211625, 10585.100266477435, 10602.89397106019, 10884.78230435371, 6297.842553936188, 8443.986721593448, 10575.524101415609, 11192.104631629287, 11216.943915280372, 7381.1511676157925, 7741.148473668005, 7860.685572577033, 7903.644336004779, 7906.248906353887, 7262.164851042197, 7352.411807055316, 7676.884846727416, 7802.531848089133, 7898.723544676139], "unit": "score", "name": "jquery.html", "value": 8140.663770310884}, {"lowerIsBetter": false, "replicates": [1497.2214448486786, 1503.4963287298754, 1721.388906938037, 1867.0851282871397, 1867.691830847911, 7864.685412583504, 8514.531700756472, 8631.784205394868, 8795.736127916165, 8820.558972051396, 8532.360072994536, 8622.65509379624, 8690.0, 8742.125787421255, 8778.517181555011, 2458.594331935233, 2469.6542484052156, 2485.453200295932, 2494.538510375586, 2497.400623850272, 2423.4183795889035, 2490.439651078502, 2490.7384724603926, 2490.887910044052, 2492.439201179738, 2152.203684636687, 2395.185636883459, 2446.7186273578586, 2468.123816045305, 2473.1591258971944, 2384.3800611840875, 2420.165043060141, 2423.6243382275775, 2427.52663230671, 2435.561598912195, 2461.778439940396, 2463.2117722328862, 2471.295680731001, 2471.9258422247362, 2474.505098980193, 8635.136486351377, 8654.307655387554, 8684.0, 8691.521966291852, 8693.217610415093, 5235.110031294689, 5464.9180262296095, 5489.039418101856, 5500.972495137538, 5502.8349149525175, 3656.177360093984, 3671.6511931366476, 3702.185519185775, 3715.7213209009433, 3761.4545890845948, 1050.1965996013057, 1054.4253381906803, 1057.7144171073844, 1074.0226393981518, 1074.9086327662158, 11932.866377694105, 11954.74475180111, 12008.0, 12016.038716902627, 12030.699232519257, 4811.109944660179, 4815.975920120377, 4890.021995600823, 4898.995705880286, 4908.705477671351, 10100.848487272697, 10107.39355638664, 10127.341722788142, 10178.949105254427, 10179.389236645826, 5424.755885985141, 5460.781568737286, 5470.124780035255, 5480.6437581557075, 5491.450854914557, 4889.828855990023, 4921.4832442593015, 4955.801767929314, 4963.8262660806695, 4988.0, 3933.704972127102, 3936.586658400884, 3943.38877473992, 3961.544422391462, 3972.8609498667406, 1208.6313674329238, 1295.1387327427344, 1298.6558561981083, 1300.9934950325187, 1316.967075823112, 1107.8449017137607, 1110.7556337605713, 1136.613551392514, 1280.775864223757, 1381.461230120254, 7987.2012798720825, 7999.200079991954, 8057.959710201529, 8100.3519718422385, 8146.185381461925, 1106.6790630717003, 1115.7210697325668, 1188.251401616993, 1203.3682316783584, 1205.2045649871043, 6165.784197553154, 6233.563650544509, 6242.344553821783, 6263.71813268404, 6278.560500764994, 10263.384196948207, 10424.739381515523, 10543.420111893765, 10562.419066951237, 10565.683029509128, 10216.080552750289, 10294.124999375137, 10413.0, 10480.371177729361, 10498.790024199627, 8100.878486822702, 8208.958955205186, 8282.047564530036, 8296.709615163561, 8301.709440169685, 7991.800204994922, 8002.439829212132, 8048.678052877819, 8084.231997960184, 8228.670853165806, 9617.519124043909, 9681.177099946583, 9762.414255144715, 9780.657676981557, 9868.210543156674, 9816.018398160128, 10216.744581385525, 10228.53971571296, 10235.181185505291, 10238.078572928473, 7271.163816161209, 7447.70209191648, 7455.440841936768, 7552.697892084255, 7581.393488520795, 8078.5960701963495, 8112.351011919151, 8162.306203972729, 8185.0, 8219.95890020546, 7210.71157153708, 7502.662380193014, 7606.8098297543, 7716.5370077795515, 7791.766247012599, 7437.181909990005, 7522.3605993491165, 7563.243675632392, 7605.049368828896, 7652.349550288288, 7651.732189373345, 7701.922980770345, 7713.267239612228, 7721.53670779755, 7746.49647772893, 6274.498040156685, 6907.34380233877, 6945.374916257561, 6997.7200911962955, 7025.508214424941, 5888.823335299948, 7145.071140751669, 7189.71241150369, 7193.0, 7204.423646108404], "unit": "score", "name": "mootools.html", "value": 4955.128385776813}, {"lowerIsBetter": false, "replicates": [257.8916854920933, 322.8966730646193, 329.58966087221404, 330.29482055810865, 330.96855798699113, 6636.170478690164, 6763.763268285611, 6882.483813713972, 7069.045678833362, 7136.821579460509, 5836.007878660627, 7027.824304392393, 7038.542494737839, 7054.57672539648, 7056.188538318095, 4456.974895773966, 4953.380827396575, 5186.948130518703, 5203.245529398235, 5226.2944502492055, 4390.934135987963, 4552.726836389811, 4620.260758278676, 4821.059893320804, 5028.874278143057, 5075.467075957026, 5111.591072714174, 5123.820666276681, 5132.5124113209185, 5147.330846989886, 4762.928556071662, 5094.286799848006, 5105.846824595231, 5116.820911268106, 5128.9230661540105, 3864.536255649312, 4358.912821743547, 4373.387725718402, 4374.671899607511, 4387.363832244307, 5868.061110222387, 5889.204957330791, 6542.3130571290285, 6807.2512023677355, 6821.249662537117, 5536.446355364472, 5747.511461525775, 6050.878982420371, 6066.757329706807, 6074.8785024299705, 7011.614361210131, 7230.710771569131, 7312.268773122645, 7471.2155223701275, 7510.887336689954, 4861.343718597979, 4868.245421959602, 4874.561289483963, 4880.951190488121, 4900.975495122537, 7046.189688185873, 7363.7849754790395, 7894.171112033211, 7906.841863162762, 7912.762617121495, 4113.629773320416, 4856.708597484162, 4964.652474326835, 4965.677230979974, 4974.37820272466, 5064.696118232918, 5066.0, 5080.161773307437, 5081.59347252219, 5085.1355269604255, 5936.643801371932, 6011.887800756786, 6017.819465416044, 6018.6990650467305, 6046.032634778414, 7293.708251669874, 7445.478816482902, 7488.887666685004, 7512.924870751332, 7519.887201691979, 1742.1637613945377, 1759.9472015839544, 1761.5155832146263, 1768.1689605885213, 1772.1227992143713, 1126.4367816091954, 1134.8524691790014, 1136.1365362324527, 1136.9260998035268, 1145.1754736589642, 6940.13248343957, 6940.236573976858, 6954.617496037767, 6980.650967451607, 7023.22744498115, 6221.720022598994, 7608.31525162738, 7611.65747541362, 7642.426817988673, 7644.388448924073, 6772.8984065239065, 6942.791716248521, 6947.096877405905, 6964.129483814523, 7024.754133605402, 4101.630853223224, 4135.1316223592785, 4144.48193975753, 4146.834126634901, 4150.667946564267, 8140.877886831702, 8141.552214628252, 8144.796380090545, 8156.714514991947, 8158.918410815816, 7845.0, 8022.27799498048, 8074.757757267292, 8075.919240807634, 8077.990251218597, 6702.765403210864, 7404.704176769043, 8184.345252379795, 8189.0, 8201.0, 6144.38556144382, 6997.790066298019, 7193.244709305448, 7829.099653539688, 7853.214678532101, 6759.715654025719, 6820.249772525118, 7717.884231736416, 7729.6521656524465, 7734.458587898793, 7974.760757177294, 8243.505389676639, 8252.711155109542, 8259.793505162419, 8282.792930176794, 3959.287328280937, 4822.300766388924, 4823.686460380064, 4824.155772739827, 4839.806407743651, 7747.612619368896, 7747.961260193663, 7784.766457006299, 7790.376769858511, 7796.415268854972, 7360.017230154754, 7445.292697193758, 7512.661930213263, 7537.095548533992, 7538.0954285483895, 7494.5128566643, 7517.323440890346, 7524.2851929066655, 7531.510451820614, 7546.735864244725, 7149.0706208192605, 7332.376747976482, 7337.376323012603, 7354.742584009534, 7372.041634587469, 7472.514286571355, 7485.251474852471, 7495.850082998419, 7508.0, 7516.586587737727, 7350.338469537767, 7364.0, 7377.815554610963, 7381.520201186906, 7412.11054673421], "unit": "score", "name": "prototype.html", "value": 5395.098037692022}, {"lowerIsBetter": false, "replicates": [649.502895825123, 683.9760608378705, 704.063595418094, 705.6753893209125, 708.9822754431135, 14832.925835370821, 15115.697686046273, 15234.542963711092, 15266.69466610667, 17401.651966960686, 15906.681866362665, 15947.362105515795, 15956.920215398906, 15963.361465541364, 16043.518694439157, 708.0724251230904, 869.2915274051659, 884.3102380143498, 886.3795343259744, 886.7472770260478, 847.9491230526157, 864.191980498233, 868.7914900423916, 871.263782104121, 874.1215078845783, 892.830362231174, 921.6129225725211, 923.6490133749165, 925.8102089071758, 925.8981512033671, 906.9274458043341, 911.8495448251031, 921.1433366968716, 922.5064590444114, 924.1451657217048, 673.3939454490949, 679.5752654590881, 685.0341019163006, 685.8285428642839, 686.4748467422426, 15479.845201548065, 15557.844421555867, 15580.0, 15582.06507609547, 15707.293171807296, 12588.118831681786, 12632.368381580884, 12807.871921280854, 12874.034447416387, 13101.0, 10053.221764006898, 10209.2467118374, 10235.897641023568, 10268.589256429734, 10281.331713438603, 3371.325734853039, 3462.342154990569, 3463.1515278756615, 3472.9131771705656, 3482.164280572644, 87905.56047219787, 89666.0, 90829.0, 91108.0, 92308.53845730795, 9189.448633082036, 9407.623695052122, 9601.231901447867, 9874.80250394988, 9960.551775170135, 20376.796232037785, 20626.793732062488, 20627.0, 20657.690134647994, 20729.27447539329, 7283.890741638879, 7560.886586701204, 7598.20218877021, 7792.610369481503, 7967.8406431871035, 4118.938215926763, 4123.505179378494, 4163.562825903297, 4312.417823593837, 4315.726860576137, 2932.398858234057, 2985.6566494852937, 3482.077249528877, 3482.930341393158, 3488.5116083748294, 632.2886752403546, 643.2024289880515, 647.1748520636132, 661.5137873662854, 667.559410788877, 561.2899681902396, 617.0965606819901, 619.8977168767103, 628.9654069026155, 634.80321100459, 8354.665813367397, 8517.57412129391, 8746.86879696805, 8782.473051616924, 8841.955790221007, 596.9761209551656, 608.3551435478319, 608.3855306140741, 624.9062640603946, 636.926753423353, 3524.3656141894703, 3828.808559572066, 3936.566977632458, 3980.2238563480423, 3989.2819292527624, 86975.82560436039, 88122.11877881267, 88211.0, 89799.0, 90076.0, 76979.23020769721, 77138.0, 78325.0, 78450.6077469609, 78662.82005769918, 61585.384146157965, 62645.0, 63145.05282420675, 63433.048504272476, 76282.61858690671, 8162.0, 8359.916400835913, 8428.4942903426, 8498.0, 9032.412893161923, 46791.766041169576, 50147.74926125346, 55228.17157742717, 55657.0, 59773.10340344811, 77095.84356234549, 77551.61224193843, 77831.22168778467, 77946.2205377939, 80682.43094805273, 11627.0, 11779.411029448322, 11812.586559470377, 11929.642110736691, 12232.877671223174, 11729.178957472895, 11950.103742219542, 12110.878891210976, 12228.816567751668, 12332.07509436778, 11328.263662861887, 11488.368139752394, 11628.709282267673, 11894.0, 12005.459754311252, 11452.0, 11511.94244028808, 11943.402829858645, 11968.102392320785, 12358.814617780561, 10940.12479001662, 11318.717032074264, 11579.478923448296, 11876.881231187923, 11923.880761192277, 9642.471279748674, 9839.754006149904, 10011.849822252818, 10152.949235254073, 10206.897931020892, 9751.951240243754, 10179.578148090912, 10200.489975501047, 10255.974402559685, 10427.530761115617], "unit": "score", "name": "yui.html", "value": 7019.345232621718}], "name": "dromaeo_css", "value": 7465.379264381755}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [122.0, 153.0, 169.0, 117.0, 171.0, 171.0, 115.0, 114.0, 115.0, 115.0], "unit": "score", "name": "ai-astar", "value": 136.2}, {"lowerIsBetter": true, "replicates": [177.0, 159.0, 177.0, 153.0, 129.0, 142.0, 141.0, 127.0, 157.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 148.5}, {"lowerIsBetter": true, "replicates": [190.0, 197.0, 198.0, 208.0, 209.0, 233.0, 272.0, 200.0, 202.0, 195.0], "unit": "score", "name": "audio-dft", "value": 210.4}, {"lowerIsBetter": true, "replicates": [66.0, 84.0, 69.0, 138.0, 87.0, 78.0, 76.0, 59.0, 112.0, 58.0], "unit": "score", "name": "audio-fft", "value": 82.7}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 103.0, 78.0, 108.0, 123.0, 150.0, 114.0, 81.0, 113.0], "unit": "score", "name": "audio-oscillator", "value": 103.4}, {"lowerIsBetter": true, "replicates": [107.0, 139.0, 99.0, 94.0, 87.0, 93.0, 89.0, 93.0, 90.0, 94.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 98.5}, {"lowerIsBetter": true, "replicates": [132.0, 97.0, 138.0, 148.0, 96.0, 97.0, 97.0, 97.0, 138.0, 97.0], "unit": "score", "name": "imaging-darkroom", "value": 113.7}, {"lowerIsBetter": true, "replicates": [83.0, 109.0, 104.0, 145.0, 110.0, 97.0, 77.0, 78.0, 129.0, 152.0], "unit": "score", "name": "imaging-desaturate", "value": 108.4}, {"lowerIsBetter": true, "replicates": [54.0, 57.0, 56.0, 56.0, 55.0, 71.0, 65.0, 91.0, 86.0, 86.0], "unit": "score", "name": "json-parse-financial", "value": 67.7}, {"lowerIsBetter": true, "replicates": [64.0, 67.0, 75.0, 77.0, 94.0, 103.0, 103.0, 98.0, 66.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 81.2}, {"lowerIsBetter": true, "replicates": [92.0, 110.0, 115.0, 73.0, 100.0, 115.0, 77.0, 88.0, 71.0, 109.0], "unit": "score", "name": "stanford-crypto-aes", "value": 95.0}, {"lowerIsBetter": true, "replicates": [127.0, 130.0, 124.0, 124.0, 123.0, 126.0, 134.0, 127.0, 138.0, 137.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 129.0}, {"lowerIsBetter": true, "replicates": [129.0, 129.0, 128.0, 141.0, 141.0, 140.0, 142.0, 141.0, 142.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.6}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 68.0, 68.0, 71.0, 69.0, 72.0, 81.0, 68.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.4}], "name": "kraken", "value": 1581.7}]} 04:35:29 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1581.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7465.38"}}} 04:35:29 INFO - Return code: 0 04:35:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:35:29 ERROR - # TBPL SUCCESS # 04:35:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:35:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:35:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:35:29 INFO - 2016-02-18 04:35:29.677 screenresolution[1701:11012] starting screenresolution argv=screenresolution get 04:35:29 INFO - 2016-02-18 04:35:29.680 screenresolution[1701:11012] Display 0: 1600x1200x32@60 04:35:29 INFO - 2016-02-18 04:35:29.686 screenresolution[1702:11015] starting screenresolution argv=screenresolution list 04:35:29 INFO - Available Modes on Display 0 04:35:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:35:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:35:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:35:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:35:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:35:29 INFO - Intel Iris: 04:35:29 INFO - Chipset Model: Intel Iris 04:35:29 INFO - Type: GPU 04:35:29 INFO - Bus: Built-In 04:35:29 INFO - VRAM (Dynamic, Max): 1536 MB 04:35:29 INFO - Vendor: Intel (0x8086) 04:35:29 INFO - Device ID: 0x0a2e 04:35:29 INFO - Revision ID: 0x0009 04:35:29 INFO - Displays: 04:35:29 INFO - Display: 04:35:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:35:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:35:29 INFO - Display Serial Number: 1600x1200 60 04:35:29 INFO - Main Display: Yes 04:35:29 INFO - Mirror: Off 04:35:29 INFO - Online: Yes 04:35:29 INFO - Rotation: Supported 04:35:29 INFO - Return code: 0 04:35:29 INFO - Running post-action listener: _resource_record_post_action 04:35:29 INFO - Running post-run listener: _resource_record_post_run 04:35:30 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 33840640; Write bytes: 714198528; Read time: 383; Write time: 2167 04:35:30 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 401646080; Write bytes: 397002752; Read time: 30013; Write time: 808 04:35:30 INFO - run-tests - Wall time: 1173s; CPU: 54.0%; Read bytes: 32058880; Write bytes: 305579520; Read time: 335; Write time: 1329 04:35:30 INFO - Running post-run listener: _upload_blobber_files 04:35:30 INFO - Blob upload gear active. 04:35:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:35:30 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 04:35:30 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'] 04:35:30 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 04:35:31 INFO - (blobuploader) - INFO - Open directory for files ... 04:35:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:35:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:35:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:35:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:35:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:35:32 INFO - (blobuploader) - INFO - Done attempting. 04:35:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:35:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:35:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:35:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:35:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:35:33 INFO - (blobuploader) - INFO - Done attempting. 04:35:33 INFO - (blobuploader) - INFO - Iteration through files over. 04:35:33 INFO - Return code: 0 04:35:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:35:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:35:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/97284ace3925e63f652f478c667a7ab352b62078db4128ccf2fe448944f5234d1fd4e00c85bfd54266d1109f1cf901a396d2a820e9124c074a11805834748497", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1bdcf49b112f708ac03d701f08b6c4fe23fdad226d6a579c472b7f1959921f30a95f05f75a0f96d22496ec62f3eae72c27d778899f52c9e7dc6841e6358cfbff"} 04:35:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:35:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:35:33 INFO - Contents: 04:35:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/97284ace3925e63f652f478c667a7ab352b62078db4128ccf2fe448944f5234d1fd4e00c85bfd54266d1109f1cf901a396d2a820e9124c074a11805834748497", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1bdcf49b112f708ac03d701f08b6c4fe23fdad226d6a579c472b7f1959921f30a95f05f75a0f96d22496ec62f3eae72c27d778899f52c9e7dc6841e6358cfbff"} 04:35:33 INFO - Running post-run listener: copy_logs_to_upload_dir 04:35:33 INFO - Copying logs to upload dir... 04:35:33 INFO - mkdir: /builds/slave/test/build/upload/logs 04:35:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.139600 ========= master_lag: 2.39 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2016-02-18 04:35:36.007492) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-18 04:35:36.010778) ========= 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.dz9n4T9kV6/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.EooUH41KSd/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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/97284ace3925e63f652f478c667a7ab352b62078db4128ccf2fe448944f5234d1fd4e00c85bfd54266d1109f1cf901a396d2a820e9124c074a11805834748497", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1bdcf49b112f708ac03d701f08b6c4fe23fdad226d6a579c472b7f1959921f30a95f05f75a0f96d22496ec62f3eae72c27d778899f52c9e7dc6841e6358cfbff"} build_url:https://queue.taskcluster.net/v1/task/Ip46fxnjSviNhr9safwQ6A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011343 build_url: 'https://queue.taskcluster.net/v1/task/Ip46fxnjSviNhr9safwQ6A/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/97284ace3925e63f652f478c667a7ab352b62078db4128ccf2fe448944f5234d1fd4e00c85bfd54266d1109f1cf901a396d2a820e9124c074a11805834748497", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1bdcf49b112f708ac03d701f08b6c4fe23fdad226d6a579c472b7f1959921f30a95f05f75a0f96d22496ec62f3eae72c27d778899f52c9e7dc6841e6358cfbff"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-18 04:35:36.053681) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 04:35:36.054046) ========= 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.dz9n4T9kV6/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.EooUH41KSd/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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.005319 ========= master_lag: 0.10 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 04:35:36.164174) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-18 04:35:36.164563) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-18 04:35:36.165108) ========= ========= Total master_lag: 2.70 =========