builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0086 starttime: 1455931541.7 results: success (0) buildid: 20160219153820 builduid: 191707df27b3427497cbaba71b0e376d revision: 77cd9b2e6c8c168de7810a8a0f9c6dfa8ab98caf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-19 17:25:41.704826) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-19 17:25:41.705399) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-19 17:25:41.705703) ========= 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.GSd7eqlxZy/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.hXOme0ztH9/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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.005522 basedir: '/builds/slave/test' ========= master_lag: 0.11 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-19 17:25:41.823516) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-19 17:25:41.823805) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-19 17:25:42.067500) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 17:25:42.067762) ========= 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.GSd7eqlxZy/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.hXOme0ztH9/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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.005455 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 17:25:42.130319) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-19 17:25:42.130601) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-19 17:25:42.130930) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 17:25:42.131255) ========= 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.GSd7eqlxZy/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.hXOme0ztH9/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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-19 17:25:42-- 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% 227M=0s 2016-02-19 17:25:42 (227 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.623971 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 17:25:42.781637) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 17:25:42.781920) ========= 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.GSd7eqlxZy/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.hXOme0ztH9/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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.025390 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 17:25:42.846503) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-19 17:25:42.846815) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 77cd9b2e6c8c168de7810a8a0f9c6dfa8ab98caf --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 77cd9b2e6c8c168de7810a8a0f9c6dfa8ab98caf --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GSd7eqlxZy/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.hXOme0ztH9/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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-19 17:25:42,933 truncating revision to first 12 chars 2016-02-19 17:25:42,933 Setting DEBUG logging. 2016-02-19 17:25:42,933 attempt 1/10 2016-02-19 17:25:42,933 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/77cd9b2e6c8c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-19 17:25:43,672 unpacking tar archive at: fx-team-77cd9b2e6c8c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.985748 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-19 17:25:43.853094) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-19 17:25:43.853404) ========= echo 77cd9b2e6c8c168de7810a8a0f9c6dfa8ab98caf in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'77cd9b2e6c8c168de7810a8a0f9c6dfa8ab98caf'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GSd7eqlxZy/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.hXOme0ztH9/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 77cd9b2e6c8c168de7810a8a0f9c6dfa8ab98caf program finished with exit code 0 elapsedTime=0.005341 script_repo_revision: '77cd9b2e6c8c168de7810a8a0f9c6dfa8ab98caf' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-19 17:25:43.907135) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-19 17:25:43.907408) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-19 17:25:43.926707) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 40 secs) (at 2016-02-19 17:25:43.926971) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.GSd7eqlxZy/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.hXOme0ztH9/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 17:25:44 INFO - MultiFileLogger online at 20160219 17:25:44 in /builds/slave/test 17:25:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:25:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:25:44 INFO - {'append_to_log': False, 17:25:44 INFO - 'base_work_dir': '/builds/slave/test', 17:25:44 INFO - 'blob_upload_branch': 'Fx-Team', 17:25:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:25:44 INFO - 'branch': 'Fx-Team', 17:25:44 INFO - 'buildbot_json_path': 'buildprops.json', 17:25:44 INFO - 'config_files': ('talos/mac_config.py',), 17:25:44 INFO - 'default_actions': ('clobber', 17:25:44 INFO - 'read-buildbot-config', 17:25:44 INFO - 'download-and-extract', 17:25:44 INFO - 'populate-webroot', 17:25:44 INFO - 'create-virtualenv', 17:25:44 INFO - 'install', 17:25:44 INFO - 'run-tests'), 17:25:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:25:44 INFO - 'download_minidump_stackwalk': True, 17:25:44 INFO - 'download_symbols': 'ondemand', 17:25:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:25:44 INFO - 'tooltool.py': '/tools/tooltool.py', 17:25:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:25:44 INFO - '/tools/misc-python/virtualenv.py')}, 17:25:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:25:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:25:44 INFO - 'installer_path': 'installer.exe', 17:25:44 INFO - 'log_level': 'info', 17:25:44 INFO - 'log_name': 'talos', 17:25:44 INFO - 'log_to_console': True, 17:25:44 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:25:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:25:44 INFO - 'opt_config_files': (), 17:25:44 INFO - 'pip_index': False, 17:25:44 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:25:44 INFO - 'cmd': ('bash', 17:25:44 INFO - '-c', 17:25:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:25:44 INFO - 'enabled': True, 17:25:44 INFO - 'halt_on_failure': False, 17:25:44 INFO - 'name': 'check_screen_resolution'},), 17:25:44 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:25:44 INFO - 'cmd': ('bash', 17:25:44 INFO - '-c', 17:25:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:25:44 INFO - 'enabled': True, 17:25:44 INFO - 'halt_on_failure': False, 17:25:44 INFO - 'name': 'check_screen_resolution'},), 17:25:44 INFO - 'run_cmd_checks_enabled': True, 17:25:44 INFO - 'sps_profile': False, 17:25:44 INFO - 'sps_profile_interval': 0, 17:25:44 INFO - 'suite': 'dromaeojs', 17:25:44 INFO - 'system_bits': '32', 17:25:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:25:44 INFO - 'title': 't-yosemite-r7-0086', 17:25:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:25:44 INFO - 'use_talos_json': True, 17:25:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:25:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:25:44 INFO - 'work_dir': 'build'} 17:25:44 INFO - ##### 17:25:44 INFO - ##### Running clobber step. 17:25:44 INFO - ##### 17:25:44 INFO - Running pre-action listener: _resource_record_pre_action 17:25:44 INFO - Running main action method: clobber 17:25:44 INFO - rmtree: /builds/slave/test/build 17:25:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:25:45 INFO - Running post-action listener: _resource_record_post_action 17:25:45 INFO - ##### 17:25:45 INFO - ##### Running read-buildbot-config step. 17:25:45 INFO - ##### 17:25:45 INFO - Running pre-action listener: _resource_record_pre_action 17:25:45 INFO - Running main action method: read_buildbot_config 17:25:45 INFO - Using buildbot properties: 17:25:45 INFO - { 17:25:45 INFO - "project": "", 17:25:45 INFO - "product": "firefox", 17:25:45 INFO - "script_repo_revision": "production", 17:25:45 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 17:25:45 INFO - "repository": "", 17:25:45 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 17:25:45 INFO - "buildid": "20160219153820", 17:25:45 INFO - "pgo_build": "False", 17:25:45 INFO - "basedir": "/builds/slave/test", 17:25:45 INFO - "buildnumber": 394, 17:25:45 INFO - "slavename": "t-yosemite-r7-0086", 17:25:45 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 17:25:45 INFO - "platform": "yosemite_r7", 17:25:45 INFO - "scheduler": "tests-fx-team-macosx64-talos", 17:25:45 INFO - "branch": "fx-team", 17:25:45 INFO - "repo_path": "integration/fx-team", 17:25:45 INFO - "revision": "77cd9b2e6c8c168de7810a8a0f9c6dfa8ab98caf", 17:25:45 INFO - "stage_platform": "macosx64", 17:25:45 INFO - "builduid": "191707df27b3427497cbaba71b0e376d", 17:25:45 INFO - "slavebuilddir": "test" 17:25:45 INFO - } 17:25:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/Mz6b8TcNSx6k7HISslQkeA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 17:25:45 INFO - Running post-action listener: _resource_record_post_action 17:25:45 INFO - ##### 17:25:45 INFO - ##### Running download-and-extract step. 17:25:45 INFO - ##### 17:25:45 INFO - Running pre-action listener: _resource_record_pre_action 17:25:45 INFO - Running main action method: download_and_extract 17:25:45 INFO - mkdir: /builds/slave/test/build/tests 17:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:45 INFO - https://queue.taskcluster.net/v1/task/Mz6b8TcNSx6k7HISslQkeA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:25:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mz6b8TcNSx6k7HISslQkeA/artifacts/public/build/test_packages.json 17:25:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mz6b8TcNSx6k7HISslQkeA/artifacts/public/build/test_packages.json 17:25:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mz6b8TcNSx6k7HISslQkeA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 17:25:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mz6b8TcNSx6k7HISslQkeA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 17:26:00 INFO - Downloaded 1277 bytes. 17:26:00 INFO - Reading from file /builds/slave/test/build/test_packages.json 17:26:00 INFO - Using the following test package requirements: 17:26:00 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 17:26:00 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:26:00 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 17:26:00 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:26:00 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 17:26:00 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:26:00 INFO - u'jsshell-mac.zip'], 17:26:00 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:26:00 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 17:26:00 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 17:26:00 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:26:00 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 17:26:00 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:26:00 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 17:26:00 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:26:00 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 17:26:00 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 17:26:00 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:26:00 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 17:26:00 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:26: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')]} 17:26:00 INFO - https://queue.taskcluster.net/v1/task/Mz6b8TcNSx6k7HISslQkeA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:26:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mz6b8TcNSx6k7HISslQkeA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 17:26:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mz6b8TcNSx6k7HISslQkeA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 17:26:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mz6b8TcNSx6k7HISslQkeA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 17:26:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mz6b8TcNSx6k7HISslQkeA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:26:01 INFO - Downloaded 17809215 bytes. 17:26:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:26:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 17:26:04 INFO - Return code: 0 17:26:04 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 17:26:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:04 INFO - https://queue.taskcluster.net/v1/task/Mz6b8TcNSx6k7HISslQkeA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:26:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mz6b8TcNSx6k7HISslQkeA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 17:26:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mz6b8TcNSx6k7HISslQkeA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 17:26:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mz6b8TcNSx6k7HISslQkeA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 17:26:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mz6b8TcNSx6k7HISslQkeA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:26:19 INFO - Downloaded 17809215 bytes. 17:26:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:26:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 17:26:22 INFO - Return code: 0 17:26: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')]} 17:26:22 INFO - https://queue.taskcluster.net/v1/task/Mz6b8TcNSx6k7HISslQkeA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 17:26:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mz6b8TcNSx6k7HISslQkeA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 17:26:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mz6b8TcNSx6k7HISslQkeA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 17:26:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mz6b8TcNSx6k7HISslQkeA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 17:26:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mz6b8TcNSx6k7HISslQkeA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:26:23 INFO - Downloaded 10707015 bytes. 17:26:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:26:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 17:26:23 INFO - Return code: 0 17:26:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:23 INFO - https://queue.taskcluster.net/v1/task/Mz6b8TcNSx6k7HISslQkeA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 17:26:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mz6b8TcNSx6k7HISslQkeA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 17:26:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mz6b8TcNSx6k7HISslQkeA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 17:26:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mz6b8TcNSx6k7HISslQkeA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 17:26:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mz6b8TcNSx6k7HISslQkeA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 17:26:32 INFO - Downloaded 111233274 bytes. 17:26:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Mz6b8TcNSx6k7HISslQkeA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 17:26:32 INFO - mkdir: /builds/slave/test/properties 17:26:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:26:32 INFO - Writing to file /builds/slave/test/properties/build_url 17:26:32 INFO - Contents: 17:26:32 INFO - build_url:https://queue.taskcluster.net/v1/task/Mz6b8TcNSx6k7HISslQkeA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 17:26:32 INFO - Running post-action listener: _resource_record_post_action 17:26:32 INFO - Running post-action listener: set_extra_try_arguments 17:26:32 INFO - ##### 17:26:32 INFO - ##### Running populate-webroot step. 17:26:32 INFO - ##### 17:26:32 INFO - Running pre-action listener: _resource_record_pre_action 17:26:32 INFO - Running main action method: populate_webroot 17:26:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:26:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:26:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:26:32 INFO - '--tppagecycles', 17:26:32 INFO - '7'], 17:26:32 INFO - 'tests': ['tsvgm']}}, 17:26:32 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:26:32 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:26:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:26:32 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 17:26:32 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:26:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:26:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:26:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:32 INFO - 'talos_options': ['--e10s'], 17:26:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:26:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:32 INFO - 'tests': ['damp', 'tps']}, 17:26:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:32 INFO - 'talos_options': ['--e10s'], 17:26:32 INFO - 'tests': ['damp', 'tps']}, 17:26:32 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:26:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:26:32 INFO - 'other': {'tests': ['a11yr', 17:26:32 INFO - 'ts_paint', 17:26:32 INFO - 'tpaint', 17:26:32 INFO - 'sessionrestore', 17:26:32 INFO - 'sessionrestore_no_auto_restore']}, 17:26:32 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:26:32 INFO - 'tests': ['a11yr', 17:26:32 INFO - 'ts_paint', 17:26:32 INFO - 'tpaint', 17:26:32 INFO - 'sessionrestore', 17:26:32 INFO - 'sessionrestore_no_auto_restore']}, 17:26:32 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:26:32 INFO - 'tests': ['a11yr', 17:26:32 INFO - 'ts_paint', 17:26:32 INFO - 'tpaint', 17:26:32 INFO - 'sessionrestore', 17:26:32 INFO - 'sessionrestore_no_auto_restore']}, 17:26:32 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:26:32 INFO - 'tests': ['a11yr', 17:26:32 INFO - 'ts_paint', 17:26:32 INFO - 'tpaint', 17:26:32 INFO - 'sessionrestore', 17:26:32 INFO - 'sessionrestore_no_auto_restore']}, 17:26:32 INFO - 'other_l64': {'tests': ['a11yr', 17:26:32 INFO - 'ts_paint', 17:26:32 INFO - 'tpaint', 17:26:32 INFO - 'sessionrestore', 17:26:32 INFO - 'sessionrestore_no_auto_restore']}, 17:26:32 INFO - 'other_nol64': {'tests': ['a11yr', 17:26:32 INFO - 'ts_paint', 17:26:32 INFO - 'tpaint', 17:26:32 INFO - 'sessionrestore', 17:26:32 INFO - 'sessionrestore_no_auto_restore']}, 17:26:32 INFO - 'svgr': {'tests': ['tsvgx', 17:26:32 INFO - 'tsvgr_opacity', 17:26:32 INFO - 'tart', 17:26:32 INFO - 'tscrollx', 17:26:32 INFO - 'cart']}, 17:26:32 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:26:32 INFO - 'tests': ['tsvgx', 17:26:32 INFO - 'tsvgr_opacity', 17:26:32 INFO - 'tart', 17:26:32 INFO - 'tscrollx', 17:26:32 INFO - 'cart']}, 17:26:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:32 INFO - 'tests': ['tp5o']}, 17:26:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:32 INFO - 'talos_options': ['--e10s'], 17:26:32 INFO - 'tests': ['tp5o']}, 17:26:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:32 INFO - 'talos_options': ['--xperf_path', 17:26:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:26:32 INFO - 'tests': ['tp5n']}, 17:26:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:32 INFO - 'talos_options': ['--e10s', 17:26:32 INFO - '--xperf_path', 17:26:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:26:32 INFO - 'tests': ['tp5n']}}, 17:26:32 INFO - 'talos.zip': {'path': '', 17:26:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:26:32 INFO - Running post-action listener: _resource_record_post_action 17:26:32 INFO - ##### 17:26:32 INFO - ##### Running create-virtualenv step. 17:26:32 INFO - ##### 17:26:32 INFO - Running pre-action listener: _resource_record_pre_action 17:26:32 INFO - Running main action method: create_virtualenv 17:26:32 INFO - Creating virtualenv /builds/slave/test/build/venv 17:26:32 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:26:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:26:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:26:33 INFO - Using real prefix '/tools/python27' 17:26:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:26:33 INFO - Installing distribute.............................................................................................................................................................................................done. 17:26:36 INFO - Installing pip.................done. 17:26:36 INFO - Return code: 0 17:26:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:26:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:36 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 0x108e59a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e614c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc04ad821a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cfdd30>, '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 0x108b21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108cf4b20>, '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.GSd7eqlxZy/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.hXOme0ztH9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:26:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:26:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:26:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GSd7eqlxZy/Render', 17:26:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:26:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:26:36 INFO - 'HOME': '/Users/cltbld', 17:26:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:26:36 INFO - 'LOGNAME': 'cltbld', 17:26:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:36 INFO - 'MOZ_NO_REMOTE': '1', 17:26:36 INFO - 'NO_EM_RESTART': '1', 17:26:36 INFO - 'PAGER': '/bin/cat', 17:26:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:26:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:36 INFO - 'PWD': '/builds/slave/test', 17:26:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:26:36 INFO - 'SHELL': '/bin/bash', 17:26:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hXOme0ztH9/Listeners', 17:26:36 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 17:26:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:26:36 INFO - 'USER': 'cltbld', 17:26:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:26:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:26:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:36 INFO - 'XPC_FLAGS': '0x0', 17:26:36 INFO - 'XPC_SERVICE_NAME': '0', 17:26:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:26:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:36 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:26:36 INFO - Cleaning up... 17:26:36 INFO - Return code: 0 17:26:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:26:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:36 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 0x108e59a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e614c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc04ad821a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cfdd30>, '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 0x108b21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108cf4b20>, '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.GSd7eqlxZy/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.hXOme0ztH9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:26:36 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 17:26:36 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 17:26:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GSd7eqlxZy/Render', 17:26:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:26:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:26:36 INFO - 'HOME': '/Users/cltbld', 17:26:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:26:36 INFO - 'LOGNAME': 'cltbld', 17:26:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:36 INFO - 'MOZ_NO_REMOTE': '1', 17:26:36 INFO - 'NO_EM_RESTART': '1', 17:26:36 INFO - 'PAGER': '/bin/cat', 17:26:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:26:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:36 INFO - 'PWD': '/builds/slave/test', 17:26:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:26:36 INFO - 'SHELL': '/bin/bash', 17:26:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hXOme0ztH9/Listeners', 17:26:36 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 17:26:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:26:36 INFO - 'USER': 'cltbld', 17:26:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:26:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:26:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:36 INFO - 'XPC_FLAGS': '0x0', 17:26:36 INFO - 'XPC_SERVICE_NAME': '0', 17:26:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:26:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:37 INFO - Downloading/unpacking psutil>=0.7.1 17:26:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:26:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:26:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:26:40 INFO - Installing collected packages: psutil 17:26:40 INFO - Running setup.py install for psutil 17:26:40 INFO - building 'psutil._psutil_osx' extension 17:26:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 17:26:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 17:26:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 17:26:40 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 17:26:41 INFO - building 'psutil._psutil_posix' extension 17:26:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 17:26:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:26:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:26:41 INFO - ^ 17:26:41 INFO - 1 warning generated. 17:26:41 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 17:26:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:26:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:26:41 INFO - Successfully installed psutil 17:26:41 INFO - Cleaning up... 17:26:41 INFO - Return code: 0 17:26:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:26:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:41 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 0x108e59a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e614c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc04ad821a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cfdd30>, '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 0x108b21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108cf4b20>, '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.GSd7eqlxZy/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.hXOme0ztH9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:26:41 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 17:26:41 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 17:26:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GSd7eqlxZy/Render', 17:26:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:26:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:26:41 INFO - 'HOME': '/Users/cltbld', 17:26:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:26:41 INFO - 'LOGNAME': 'cltbld', 17:26:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:41 INFO - 'MOZ_NO_REMOTE': '1', 17:26:41 INFO - 'NO_EM_RESTART': '1', 17:26:41 INFO - 'PAGER': '/bin/cat', 17:26:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:26:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:41 INFO - 'PWD': '/builds/slave/test', 17:26:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:26:41 INFO - 'SHELL': '/bin/bash', 17:26:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hXOme0ztH9/Listeners', 17:26:41 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 17:26:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:26:41 INFO - 'USER': 'cltbld', 17:26:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:26:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:26:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:41 INFO - 'XPC_FLAGS': '0x0', 17:26:41 INFO - 'XPC_SERVICE_NAME': '0', 17:26:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:26:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:26:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:26:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:26:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:26:44 INFO - Installing collected packages: mozsystemmonitor 17:26:44 INFO - Running setup.py install for mozsystemmonitor 17:26:44 INFO - Successfully installed mozsystemmonitor 17:26:44 INFO - Cleaning up... 17:26:44 INFO - Return code: 0 17:26:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:26:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108e59a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e614c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc04ad821a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cfdd30>, '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 0x108b21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108cf4b20>, '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.GSd7eqlxZy/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.hXOme0ztH9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:26:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:26:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:26:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GSd7eqlxZy/Render', 17:26:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:26:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:26:44 INFO - 'HOME': '/Users/cltbld', 17:26:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:26:44 INFO - 'LOGNAME': 'cltbld', 17:26:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:44 INFO - 'MOZ_NO_REMOTE': '1', 17:26:44 INFO - 'NO_EM_RESTART': '1', 17:26:44 INFO - 'PAGER': '/bin/cat', 17:26:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:26:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:44 INFO - 'PWD': '/builds/slave/test', 17:26:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:26:44 INFO - 'SHELL': '/bin/bash', 17:26:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hXOme0ztH9/Listeners', 17:26:44 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 17:26:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:26:44 INFO - 'USER': 'cltbld', 17:26:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:26:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:26:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:44 INFO - 'XPC_FLAGS': '0x0', 17:26:44 INFO - 'XPC_SERVICE_NAME': '0', 17:26:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:26:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:44 INFO - Downloading/unpacking blobuploader==1.2.4 17:26:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:47 INFO - Downloading blobuploader-1.2.4.tar.gz 17:26:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:26:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:26:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:48 INFO - Downloading docopt-0.6.1.tar.gz 17:26:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:26:48 INFO - Installing collected packages: blobuploader, requests, docopt 17:26:48 INFO - Running setup.py install for blobuploader 17:26:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:26:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:26:48 INFO - Running setup.py install for requests 17:26:49 INFO - Running setup.py install for docopt 17:26:49 INFO - Successfully installed blobuploader requests docopt 17:26:49 INFO - Cleaning up... 17:26:49 INFO - Return code: 0 17:26:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:26:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:49 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 0x108e59a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e614c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc04ad821a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cfdd30>, '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 0x108b21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108cf4b20>, '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.GSd7eqlxZy/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.hXOme0ztH9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:26:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:26:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:26:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GSd7eqlxZy/Render', 17:26:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:26:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:26:49 INFO - 'HOME': '/Users/cltbld', 17:26:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:26:49 INFO - 'LOGNAME': 'cltbld', 17:26:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:49 INFO - 'MOZ_NO_REMOTE': '1', 17:26:49 INFO - 'NO_EM_RESTART': '1', 17:26:49 INFO - 'PAGER': '/bin/cat', 17:26:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:26:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:49 INFO - 'PWD': '/builds/slave/test', 17:26:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:26:49 INFO - 'SHELL': '/bin/bash', 17:26:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hXOme0ztH9/Listeners', 17:26:49 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 17:26:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:26:49 INFO - 'USER': 'cltbld', 17:26:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:26:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:26:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:49 INFO - 'XPC_FLAGS': '0x0', 17:26:49 INFO - 'XPC_SERVICE_NAME': '0', 17:26:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:26:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:26:50 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-nyfaof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:26:50 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-pv6r9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:26:50 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-g4slPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:26:50 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-BbeT4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:26:50 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-RazOFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:26:50 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-jKL06t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:26:50 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-PZfChh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:26:50 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-xtxEXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:26:50 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-NYKcZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:26:51 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-HCMSrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:26:51 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-ELJAh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:26:51 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-Ax3ee_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:26:51 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-4UOLvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:26:51 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-BJh1WV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:26:51 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-RkujJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:26:51 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-FaDb1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:26:51 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-yHbkba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:26:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:26:51 INFO - Running setup.py install for manifestparser 17:26:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:26:52 INFO - Running setup.py install for mozcrash 17:26:52 INFO - Running setup.py install for mozdebug 17:26:52 INFO - Running setup.py install for mozdevice 17:26:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:26:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:26:52 INFO - Running setup.py install for mozfile 17:26:52 INFO - Running setup.py install for mozhttpd 17:26:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:26:52 INFO - Running setup.py install for mozinfo 17:26:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:26:52 INFO - Running setup.py install for mozInstall 17:26:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:26:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:26:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:26:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:26:53 INFO - Running setup.py install for mozleak 17:26:53 INFO - Running setup.py install for mozlog 17:26:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:26:53 INFO - Running setup.py install for moznetwork 17:26:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:26:53 INFO - Running setup.py install for mozprocess 17:26:53 INFO - Running setup.py install for mozprofile 17:26:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:26:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:26:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:26:53 INFO - Running setup.py install for mozrunner 17:26:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:26:54 INFO - Running setup.py install for mozscreenshot 17:26:54 INFO - Running setup.py install for moztest 17:26:54 INFO - Running setup.py install for mozversion 17:26:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:26:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:26:54 INFO - Cleaning up... 17:26:54 INFO - Return code: 0 17:26:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:54 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 0x108e59a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e614c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc04ad821a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cfdd30>, '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 0x108b21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108cf4b20>, '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.GSd7eqlxZy/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.hXOme0ztH9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:26:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:26:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:26:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GSd7eqlxZy/Render', 17:26:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:26:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:26:54 INFO - 'HOME': '/Users/cltbld', 17:26:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:26:54 INFO - 'LOGNAME': 'cltbld', 17:26:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:54 INFO - 'MOZ_NO_REMOTE': '1', 17:26:54 INFO - 'NO_EM_RESTART': '1', 17:26:54 INFO - 'PAGER': '/bin/cat', 17:26:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:26:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:54 INFO - 'PWD': '/builds/slave/test', 17:26:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:26:54 INFO - 'SHELL': '/bin/bash', 17:26:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hXOme0ztH9/Listeners', 17:26:54 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 17:26:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:26:54 INFO - 'USER': 'cltbld', 17:26:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:26:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:26:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:54 INFO - 'XPC_FLAGS': '0x0', 17:26:54 INFO - 'XPC_SERVICE_NAME': '0', 17:26:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:26:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:26:54 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-J38mVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:26:54 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:26:54 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-JMXKa0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:26:54 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)) 17:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:26:54 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-Brc4GL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:26:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:26:55 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-mJnK61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:26:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:26:55 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-z4R1eP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:26:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:26:55 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-3I96ay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:26:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:26:55 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-B2ZvzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:26:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:26:55 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-e_XNMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:26:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:26:55 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-5apgnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:26:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:26:55 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-wod9l1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:26:55 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)) 17:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:26:55 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-L8QzIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:26:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:26:55 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-UbR9j8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:26:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:26:56 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-Nba9Rt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:26:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:26:56 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-L2CeLB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:26:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:26:56 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-vMmzzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:26:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:26:56 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-19nfpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:26:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:26:56 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-xlibeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:26:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:26:56 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)) 17:26:56 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)) 17:26:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:26:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:26:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:26:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:58 INFO - Downloading blessings-1.6.tar.gz 17:26:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:26:58 INFO - Installing collected packages: blessings 17:26:58 INFO - Running setup.py install for blessings 17:26:59 INFO - Successfully installed blessings 17:26:59 INFO - Cleaning up... 17:26:59 INFO - Return code: 0 17:26:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:26:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:26:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:26:59 INFO - Reading from file tmpfile_stdout 17:26:59 INFO - Current package versions: 17:26:59 INFO - blessings == 1.6 17:26:59 INFO - blobuploader == 1.2.4 17:26:59 INFO - docopt == 0.6.1 17:26:59 INFO - manifestparser == 1.1 17:26:59 INFO - mozInstall == 1.12 17:26:59 INFO - mozcrash == 0.16 17:26:59 INFO - mozdebug == 0.1 17:26:59 INFO - mozdevice == 0.48 17:26:59 INFO - mozfile == 1.2 17:26:59 INFO - mozhttpd == 0.7 17:26:59 INFO - mozinfo == 0.9 17:26:59 INFO - mozleak == 0.1 17:26:59 INFO - mozlog == 3.1 17:26:59 INFO - moznetwork == 0.27 17:26:59 INFO - mozprocess == 0.22 17:26:59 INFO - mozprofile == 0.28 17:26:59 INFO - mozrunner == 6.11 17:26:59 INFO - mozscreenshot == 0.1 17:26:59 INFO - mozsystemmonitor == 0.0 17:26:59 INFO - moztest == 0.7 17:26:59 INFO - mozversion == 1.4 17:26:59 INFO - psutil == 3.1.1 17:26:59 INFO - requests == 1.2.3 17:26:59 INFO - wsgiref == 0.1.2 17:26:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:26:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:59 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 0x108e59a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e614c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc04ad821a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cfdd30>, '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 0x108b21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108cf4b20>, '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.GSd7eqlxZy/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.hXOme0ztH9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:26:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:26:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:26:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GSd7eqlxZy/Render', 17:26:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:26:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:26:59 INFO - 'HOME': '/Users/cltbld', 17:26:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:26:59 INFO - 'LOGNAME': 'cltbld', 17:26:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:59 INFO - 'MOZ_NO_REMOTE': '1', 17:26:59 INFO - 'NO_EM_RESTART': '1', 17:26:59 INFO - 'PAGER': '/bin/cat', 17:26:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:26:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:59 INFO - 'PWD': '/builds/slave/test', 17:26:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:26:59 INFO - 'SHELL': '/bin/bash', 17:26:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hXOme0ztH9/Listeners', 17:26:59 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 17:26:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:26:59 INFO - 'USER': 'cltbld', 17:26:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:26:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:26:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:59 INFO - 'XPC_FLAGS': '0x0', 17:26:59 INFO - 'XPC_SERVICE_NAME': '0', 17:26:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:26:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:26:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:26:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:26:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:26:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:26:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:26:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:26:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:26:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:26:59 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:26:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:26:59 INFO - Cleaning up... 17:26:59 INFO - Return code: 0 17:26:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:26:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108e59a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e614c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc04ad821a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cfdd30>, '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 0x108b21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108cf4b20>, '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.GSd7eqlxZy/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.hXOme0ztH9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:26:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:26:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:26:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GSd7eqlxZy/Render', 17:26:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:26:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:26:59 INFO - 'HOME': '/Users/cltbld', 17:26:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:26:59 INFO - 'LOGNAME': 'cltbld', 17:26:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:59 INFO - 'MOZ_NO_REMOTE': '1', 17:26:59 INFO - 'NO_EM_RESTART': '1', 17:26:59 INFO - 'PAGER': '/bin/cat', 17:26:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:26:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:59 INFO - 'PWD': '/builds/slave/test', 17:26:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:26:59 INFO - 'SHELL': '/bin/bash', 17:26:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hXOme0ztH9/Listeners', 17:26:59 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 17:26:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:26:59 INFO - 'USER': 'cltbld', 17:26:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:26:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:26:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:59 INFO - 'XPC_FLAGS': '0x0', 17:26:59 INFO - 'XPC_SERVICE_NAME': '0', 17:26:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:27:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:00 INFO - Downloading/unpacking jsonschema 17:27: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 17:27: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 17:27: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 17:27: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 17:27: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 17:27: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 17:27:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:27:02 INFO - Downloading/unpacking functools32 (from jsonschema) 17:27: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 17:27: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 17:27: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 17:27: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 17:27: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 17:27: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 17:27:02 INFO - Downloading functools32-3.2.3-2.tar.gz 17:27:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:27:02 INFO - warning: no files found matching '*.txt' 17:27:02 INFO - no previously-included directories found matching 'build' 17:27:02 INFO - no previously-included directories found matching 'dist' 17:27:02 INFO - no previously-included directories found matching '.git*' 17:27:02 INFO - Installing collected packages: jsonschema, functools32 17:27:02 INFO - Running setup.py install for functools32 17:27:03 INFO - warning: no files found matching '*.txt' 17:27:03 INFO - no previously-included directories found matching 'build' 17:27:03 INFO - no previously-included directories found matching 'dist' 17:27:03 INFO - no previously-included directories found matching '.git*' 17:27:03 INFO - Successfully installed jsonschema functools32 17:27:03 INFO - Cleaning up... 17:27:03 INFO - Return code: 0 17:27:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:27:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:27:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:03 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 0x108e59a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e614c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc04ad821a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cfdd30>, '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 0x108b21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108cf4b20>, '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.GSd7eqlxZy/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.hXOme0ztH9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:27:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:27:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:27:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GSd7eqlxZy/Render', 17:27:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:27:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:27:03 INFO - 'HOME': '/Users/cltbld', 17:27:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:27:03 INFO - 'LOGNAME': 'cltbld', 17:27:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:03 INFO - 'MOZ_NO_REMOTE': '1', 17:27:03 INFO - 'NO_EM_RESTART': '1', 17:27:03 INFO - 'PAGER': '/bin/cat', 17:27:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:27:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:03 INFO - 'PWD': '/builds/slave/test', 17:27:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:27:03 INFO - 'SHELL': '/bin/bash', 17:27:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hXOme0ztH9/Listeners', 17:27:03 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 17:27:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:27:03 INFO - 'USER': 'cltbld', 17:27:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:27:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:27:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:03 INFO - 'XPC_FLAGS': '0x0', 17:27:03 INFO - 'XPC_SERVICE_NAME': '0', 17:27:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:27:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:03 INFO - Downloading/unpacking flake8 17:27: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 17:27: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 17:27: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 17:27: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 17:27: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 17:27: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 17:27:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:27:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:27:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:27:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:27:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:27:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:27:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:27:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:27:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:27:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:27:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:27:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:27:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:27:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:27:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:27:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:27:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:27:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:27:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:27:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:27:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:27:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:27:06 INFO - no previously-included directories found matching 'docs/_build' 17:27:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:27:07 INFO - Running setup.py install for pep8 17:27:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:27:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:27:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:27:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:27:07 INFO - no previously-included directories found matching 'docs/_build' 17:27:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:27:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:27:07 INFO - Cleaning up... 17:27:07 INFO - Return code: 0 17:27:07 INFO - Running post-action listener: _resource_record_post_action 17:27:07 INFO - Running post-action listener: _start_resource_monitoring 17:27:07 INFO - Starting resource monitoring. 17:27:07 INFO - ##### 17:27:07 INFO - ##### Running install step. 17:27:07 INFO - ##### 17:27:07 INFO - Running pre-action listener: _resource_record_pre_action 17:27:07 INFO - Running main action method: install 17:27:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:27:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:27:07 INFO - Reading from file tmpfile_stdout 17:27:07 INFO - Detecting whether we're running mozinstall >=1.0... 17:27:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:27:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:27:07 INFO - Reading from file tmpfile_stdout 17:27:07 INFO - Output received: 17:27:07 INFO - Usage: mozinstall [options] installer 17:27:07 INFO - Options: 17:27:07 INFO - -h, --help show this help message and exit 17:27:07 INFO - -d DEST, --destination=DEST 17:27:07 INFO - Directory to install application into. [default: 17:27:07 INFO - "/builds/slave/test"] 17:27:07 INFO - --app=APP Application being installed. [default: firefox] 17:27:07 INFO - mkdir: /builds/slave/test/build/application 17:27:07 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'] 17:27:07 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 17:27:41 INFO - Reading from file tmpfile_stdout 17:27:41 INFO - Output received: 17:27:41 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:27:41 INFO - Running post-action listener: _resource_record_post_action 17:27:41 INFO - ##### 17:27:41 INFO - ##### Running run-tests step. 17:27:41 INFO - ##### 17:27:41 INFO - Running pre-action listener: _resource_record_pre_action 17:27:41 INFO - Running main action method: run_tests 17:27:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:27:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:27:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:27:41 INFO - 2016-02-19 17:27:41.397 screenresolution[1650:8300] starting screenresolution argv=screenresolution get 17:27:41 INFO - 2016-02-19 17:27:41.400 screenresolution[1650:8300] Display 0: 1600x1200x32@60 17:27:41 INFO - 2016-02-19 17:27:41.405 screenresolution[1651:8303] starting screenresolution argv=screenresolution list 17:27:41 INFO - Available Modes on Display 0 17:27:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:27:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:27:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:27:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:27:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:27:41 INFO - Intel Iris: 17:27:41 INFO - Chipset Model: Intel Iris 17:27:41 INFO - Type: GPU 17:27:41 INFO - Bus: Built-In 17:27:41 INFO - VRAM (Dynamic, Max): 1536 MB 17:27:41 INFO - Vendor: Intel (0x8086) 17:27:41 INFO - Device ID: 0x0a2e 17:27:41 INFO - Revision ID: 0x0009 17:27:41 INFO - Displays: 17:27:41 INFO - Display: 17:27:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:27:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:27:41 INFO - Display Serial Number: 1600x1200 60 17:27:41 INFO - Main Display: Yes 17:27:41 INFO - Mirror: Off 17:27:41 INFO - Online: Yes 17:27:41 INFO - Rotation: Supported 17:27:41 INFO - Return code: 0 17:27:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:27:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:27:41 INFO - Python 2.7.3 17:27:41 INFO - Return code: 0 17:27:41 INFO - grabbing minidump binary from tooltool 17:27:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:27:41 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 0x108cfdd30>, '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 0x108b21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108cf4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:27:41 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:27:41 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 17:27:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:27:41 INFO - Return code: 0 17:27:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:27:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:27:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:27:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:27:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:27:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:27:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:27:42 INFO - Return code: 0 17:27:42 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', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Mz6b8TcNSx6k7HISslQkeA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0086', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:27:42 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 --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Mz6b8TcNSx6k7HISslQkeA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0086 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:27:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GSd7eqlxZy/Render', 17:27:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:27:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:27:42 INFO - 'HOME': '/Users/cltbld', 17:27:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:27:42 INFO - 'LOGNAME': 'cltbld', 17:27:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:27:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:27:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:42 INFO - 'MOZ_NO_REMOTE': '1', 17:27:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:27:42 INFO - 'NO_EM_RESTART': '1', 17:27:42 INFO - 'PAGER': '/bin/cat', 17:27:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:27:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:42 INFO - 'PWD': '/builds/slave/test', 17:27:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:27:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:27:42 INFO - 'SHELL': '/bin/bash', 17:27:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hXOme0ztH9/Listeners', 17:27:42 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 17:27:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:27:42 INFO - 'USER': 'cltbld', 17:27:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:27:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:27:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:42 INFO - 'XPC_FLAGS': '0x0', 17:27:42 INFO - 'XPC_SERVICE_NAME': '0', 17:27:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:27:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Mz6b8TcNSx6k7HISslQkeA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0086', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:27:43 INFO - mozversion application_buildid: 20160219153820 17:27:43 INFO - mozversion application_changeset: 77cd9b2e6c8c168de7810a8a0f9c6dfa8ab98caf 17:27:43 INFO - mozversion application_display_name: Nightly 17:27:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:27:43 INFO - mozversion application_name: Firefox 17:27:43 INFO - mozversion application_remotingname: firefox 17:27:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:27:43 INFO - mozversion application_vendor: Mozilla 17:27:43 INFO - mozversion application_version: 47.0a1 17:27:43 INFO - mozversion platform_buildid: 20160219153820 17:27:43 INFO - mozversion platform_changeset: 77cd9b2e6c8c168de7810a8a0f9c6dfa8ab98caf 17:27:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:27:43 INFO - mozversion platform_version: 47.0a1 17:27:43 INFO - using testdate: 1455931663 17:27:43 INFO - actual date: 1455931663 17:27:43 INFO - starting webserver on 'localhost:49274' 17:27:43 INFO - SUITE-START | Running 2 tests 17:27:43 INFO - TEST-START | dromaeo_css 17:27:43 INFO - operating with platform_type : mac_ 17:27:43 INFO - Initialising browser for dromaeo_css test... 17:27:43 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmpc1GT82/profile http://localhost:49274/getInfo.html) 17:27:45 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 17:27:45 INFO - PROCESS | 1669 | colorDepth:24 17:27:45 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 17:27:45 INFO - PROCESS | 1669 | __metrics 17:27:45 INFO - PROCESS | 1669 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:27:45 INFO - PROCESS | 1669 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:27:46 INFO - TEST-INFO | 1669: exit 0 17:27:46 INFO - Browser initialized. 17:27:46 INFO - Running cycle 1/1 for dromaeo_css test... 17:27:46 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmpc1GT82/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:27:58 INFO - PROCESS | 1673 | RSS: Main: 242483200 17:27:58 INFO - PROCESS | 1673 | 17:28:49 INFO - PROCESS | 1673 | 1455931729404 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:30:59 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 17:31:00 INFO - PROCESS | 1673 | RSS: Main: 361615360 17:31:00 INFO - PROCESS | 1673 | 17:34:03 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 17:34:03 INFO - PROCESS | 1673 | RSS: Main: 380141568 17:34:03 INFO - PROCESS | 1673 | 17:37:06 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 17:37:06 INFO - PROCESS | 1673 | RSS: Main: 378437632 17:37:06 INFO - PROCESS | 1673 | 17:40:08 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 17:40:09 INFO - PROCESS | 1673 | RSS: Main: 335159296 17:40:09 INFO - PROCESS | 1673 | 17:43:12 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 17:43:13 INFO - PROCESS | 1673 | RSS: Main: 338698240 17:43:13 INFO - PROCESS | 1673 | 17:46:15 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 17:46:16 INFO - PROCESS | 1673 | RSS: Main: 420372480 17:46:16 INFO - PROCESS | 1673 | 17:46:16 INFO - PROCESS | 1673 | __start_tp_report 17:46:16 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 17:46:16 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 17:46:16 INFO - PROCESS | 1673 | |i|pagename|runs| 17:46:16 INFO - PROCESS | 1673 | |0;dojo.html;2732.8633568321584;3440.105572551136;3452.205992621697;3460;3513.1041584395975;5583.888322233553;5648.096304591266;5648.152777083439;5684.459976302255;5717.857053573663;5582.27430434044;5641.633293835908;5649.23735295735;5676.347220069693;5677.517411020068;5126.282320475137;5133.974330128362;5151.304573882534;5190.558802501791;5223.686578805265;5228.320318358608;5230.843074707765;5235.528802407783;5237.8952420951555;5252.868678283055;5149.768260428271;5196.038732834438;5211.5049070338255;5217.295665085203;5231.790728370861;5174.508421699932;5226.660267082628;5233.764480598382;5235.55497782689;5295.947040529584;5083.262926875619;5091.79632814687;5095.286659867622;5134.897302053975;5156.613254005927;5526.253955715967;5548.334199895998;5580.693061881595;5588.329400471969;5611.887762244733;6180.567360284782;6187.938120618826;6189.38106189382;6207.503399728011;6216.409441103088;6139.324674285825;6144.047672610708;6202.162708034402;6249.25008998923;6269.279032911182;5779.797707080316;5794.797182098607;5806.59353845231;5810.099434587646;5855.853603659943;6229.657368844757;6230.158928544589;6231.22109736283;6235.625862448177;6237.282712488031;5912.70436478183;6017.608855424471;6077.246020137703;6107.755689772448;6136.723847426876;5855.59010869235;6181.041938499539;6232.626042437469;6239.376062393724;6239.594426362272;5976.85057873548;6113.4154954094565;6113.584860652744;6130.2414262968205;6149.800788846222;6157.415045570664;6188.195534580475;6192;6192.8761424771255;6216.968915155486;4812.590929771009;4818.180909245437;4827.589654879374;4858.732769697701;4886;4304.978475107604;4322.092360604308;4385.386045953569;4388.188185185751;4422.7346359218545;5593.328800543961;5601.327840659147;5622.7750889963945;5624.943750562442;5638.577106717013;6226.906596401058;6231.3145553989025;6238.75044998195;6261.906071408933;6271.843203919939;5516.117421212667;5600.159976003632;5611.6352437091455;5672.602917795797;5679.261695979496;5275.63070585063;5292;5312.043832110257;5312.840614781563;5337.8131765388025;6172.444479996821;6245.250569931637;6261.029540421151;6272.933601287792;6277.937220627735;6178.845528861814;6279.058141278845;6283.5601507895835;6287.591306565058;6290.811275661737;6218.06728990655;6250.906236406367;6254;6260.655663938345;6329.5252856036905;5988.970055149696;6095.35998720128;6133.754649813957;6150;6166;5418.972905135449;6231.875362492634;6254.061890716429;6258.937410625836;6267.529935254783;5797.246357973437;5805.216295800013;6034.275886893601;6046.395360463918;6062.878742425215;5877.73550190251;5920.73356698941;5992.820215393545;6000.849978750566;6046.848828779316;5829.562782791223;5835.328937172279;5837.67892765902;5844.912326315194;5847.1229315603;5992.340842507408;6000.309964354155;6012.609180403259;6013.789517366871;6080.422359875804;5760.0783874579865;5796.652200867961;5837.0368889132815;5929.229200203946;5959.28488581373 17:46:16 INFO - PROCESS | 1673 | |1;ext.html;452.60849365299003;488.99755501222484;490.5977098779002;540.9621326507145;576.9845072672096;29632.851835740817;37790;38426.42360364597;38467.99999999996;38561.228775424475;42963.71108866731;43145.56854431455;43184.56815431845;43242.56757432425;43252.567474325246;9570.712878613653;9812.165965892907;9815.754606134833;9824.410535367864;9834.26243031772;9667.516624168798;9719.708408747714;9735.853962190573;9809.558569864374;9827.066428689299;9813.214942804594;9866.556004979793;9868.407895526256;9875.209983201363;9884.90115098847;9731.902680973171;9811.509424528746;9817.6072957082;9826.312158148932;9830.115289623896;9581.329306948517;9720.125188733047;9731;9735.951320243425;9737.756556086084;40055;40357.59642403568;40541.39187912184;40547;40560.594394055974;3172.254520187754;3195.137312925497;3347.748918831073;3583.7670551414076;4035.293823580891;29540.852295738383;30242.395152096833;30925.536116958265;30931.84534077315;31007.68992310093;2731.877065532036;2794.18968499135;2820.562812764025;2832.1645114691214;2892.2335581071034;387455;390017;396935;397426;399050;66472;68001.65999169972;68108.65945670339;70773;71018.28981710116;74515.88226176612;74680.78511363745;74801.25198748051;74914.62542687252;74966;16961;17147.48557543276;17172.31310747581;17184.484465466056;17209;12998.480060797652;13075.823175914024;13077.215367078006;13077.803832942513;13109.213447193199;17352.826471735374;19749.703754443693;21319.68020479663;22598.548029039328;22653.941717868205;8205.251240834268;9657.855132172883;9858.507074646239;9887.950560247153;9924.454155021398;945.9810803783886;950.5674917912334;1024.3239461955075;1092.4210168610648;1123.5955056179769;28247.43505129886;28755.856220718764;29105.563416548768;29138.708612914023;29259.268518287212;1071.7052810477026;1086.8316559698355;1089.3518356577824;1176.9411529423494;1254.4605819497522;11693.356865372316;14765.608283947022;15863.04821710701;16074.43739469113;16218.673353680895;649647;652671;652994;654750;657118;50520.49479505158;58337.49975001514;59605.70197148986;59645.701771490865;59769.10346344808;1299.876511731384;1447.7466443372577;1449.1956963885145;1461.4811741831497;1462.3419461242484;28300.433991319645;28418.71581284161;29124.126276211748;29346.119616411543;29440.41119177647;46618;47355;47554;47988.28017579809;48261;318572;646525;650876;655155;656971;32238.838805805823;32497;32703;33434.83282583669;33537;42405.57594424016;42617.5738242626;44263;44622.77688611536;45520.31719524276;35081.82459087688;35436.93689189328;36118.45822312615;36171.27657446889;36521.63478365289;34730.47904281387;35490;35536.64463355333;35560.110997225274;35564.64435355717;34515.65484345225;35479.82260088683;35530.82234588914;35639.64360356363;35645.39595718251;29391.706082938897;31988.20029499281;32029.359412811147;32999;33079;21646;23431.41421464477;24789.25632231036;24910;25209.873950630128 17:46:16 INFO - PROCESS | 1673 | |2;jquery.html;338.94576867701164;359.24379181822263;360.40713027070484;363.75264819922444;366.1961993424431;12302.692432689188;15425.3829846806;19330.936798476097;19346.12942417591;20212.989350532487;19267.421977340666;19607.607847843035;19659.803401965975;20277.391678249638;20307.796922030775;5683.971580142103;5990.161377407145;6001.909971350433;6015.819525414245;6016.4357267110645;4216.388623649569;5853.09277062056;5970.194023806774;6332.556721029529;6624.701888415008;5541.889162216753;6557.573757705758;6574.178227721535;6575.835604109888;6582.243042050178;5564.387917329091;5703.54371650267;5720.742566584514;5756.568257380693;5761.193432919395;5693.914591281134;5696.743646535916;5707;5715.257016587859;5717.48542631161;12903.548375806895;17003.829961700347;23929.880350598134;24238.7880605969;24262.878685606636;2019.6970454431805;2116.883571403572;2134.4557137929883;2276.4877902471976;2749.408877091435;9355.672551460735;9869.407835529892;9891.604335826558;9952.552135153863;10019.198464122852;1798.3166396769143;1807.7649905512199;1850.9352172673891;1891.4798430431604;1908.5228692826793;71855.64072179605;74889.25110748931;76731.61634191849;95321;102583;9215;10873.782524349626;11148.219624626361;11278.54885804575;11287.887121128684;13488.662783430493;13644.317784110755;13657.453701852013;13674.589762307147;13712.24582647944;8460;8512.872306915402;8517.148285171557;8605.65577376898;8641.783955401039;8696.826063478695;8700.34747393948;8702.347323950602;8758.781030474289;8815.515146666867;4396.4284642996845;4461.933071003938;4466.3523789050405;4467.843625473093;4531.18438681034;1611.3151910438016;1752.4041825779295;1834.0371305064948;1864.3567969050655;1871.4759867237196;841.3143288220081;903.4714691905177;934.0566028311318;999.8350272205005;1021.3769600543662;18640.067996600115;19352.70970935437;19428.902855485914;19593.608127837364;19890.70163947542;904.8778414914034;986.8470387090013;1002.2533212756543;1005.8038682456997;1039.428314427062;10189.54147063384;10665.520051597698;10666.146708263475;10686.625968091079;10864.782704346027;629399;640434;642459;643635;652400;78194;81025.18974810294;96438.51780741192;96707.0329296698;98117;1010.1312870930993;1012.0233974214918;1045.994770026145;1047.9214058945608;1071.2929466552193;17441;17764.822351776318;17877.821221787617;17910.820891791438;17971.910140449214;44816.32775508435;45872;46500.767496162305;46795.532044680476;47167;62799;67592;69050.30949690439;69470.65264673645;74399;10346.586136554453;10764.192685548458;10915.454227288763;11445.027172690414;11742.530298787953;12614.243145411305;12939;12941.223526588436;13080.345982701017;13390.26353550564;10867.510962006887;11052.171087168334;11200.551977920792;11361;11475;10495.580176792842;10531.57873685044;10902.727431814268;11314.264572802742;11345.432728363714;10295.845562316721;10581.99471050249;11496.712582185512;11669.88330116722;11827.645170644895;11412.02997745201;11495.48270327854;11497.540098396305;11677.182597218452;11691;7785.948896898846;8094.919050809416;8104.959475202586;8124.471909325875;11788.941055294668 17:46:16 INFO - PROCESS | 1673 | |3;mootools.html;1396.0506855338365;1531.1043039821704;1550.6588550518886;1803.7294405839123;1958.7943265957074;7925.326347260482;8537.14628537146;8665.87001194981;8691;8713.128687131291;8326.625301861415;8606.526641034741;8613.181747733955;8613.310935125191;8646.308295336374;2148.871067735933;2410.144398738449;2434.926952191437;2451.8774061296954;2461.876906154694;2446.0949448704005;2472.6414669872856;2479.8636075015866;2483.242611003643;2490.68866391701;2449.7672721091467;2471.1351027140536;2471.9752802472017;2478.615814548748;2482.962755558668;2384.177458776728;2438.3904023994;2454.8527088374753;2461.4092617771694;2462.5198086373166;2422.9636555451684;2439.3657649011207;2443.572374834415;2463.519613675334;2467.605183170684;8705.956470217672;8804.339674524435;8804.691835785781;8813.647454101829;8833.160849719266;5284.524392804666;5465.754041068121;5469.945300546983;5484.890302193934;5500.367457742371;3613.1689711366535;3657.6708096271464;3705.6109108543756;3720.3675375186012;3731.1418373773913;1057.444841458233;1058.6929790360864;1059.1368035051407;1096.4627332607045;1116.1405717597486;11792.469338879686;11811.527538898434;11862.347570883598;11888.524459021628;11927.582534611247;4787.3537072495465;4829.879253018703;4900.387451568554;4926.704397736075;4928.778204980785;10168.593256269814;10172.796544069077;10183.083522482864;10187.439690817077;10196.980301969743;4867.196912509467;5442.564594832483;5475.288212532345;5478.945210547843;5485.753141108659;3849.345611246039;4466;4467.441569803775;4513.593776560126;4768.7615619218905;3876.8836934891997;3884.533855937306;3900.64894159527;3941.9356773670947;3951.920961580752;1300.5838131797734;1305.7127431964952;1307.5750381126172;1315.8420989481324;1318.0773458579033;1030.8762948446235;1048.5858086056119;1061.6549621373085;1310.698539335939;1371.4651285998468;7997.240262175084;8078.7172448964;8098.676052957933;8111.797205069803;8153.8776918346275;513.956313713331;519.1382305373063;520.6667732651106;523.7616884317626;529.100529100523;5228.529432351107;6119.84700382494;6131.110988906584;6146.985747351726;6165.84585385369;10229.283950123569;10567.577296908037;10597;10597.152227821756;10610.938906109328;10132.138768204637;10448.111910487694;10454.738631534272;10468.267221294436;10515;8067.475614085066;8195.590220488952;8204.220599043081;8227.753167404868;8300.626471808782;7949;7966.203379661987;8011.439199255996;8065.9596702016115;8193.836123277382;9515.762105947406;9545.474998875128;9634.90365096368;9687.806243874942;9768.169705575106;9879.209663227068;9896;9959.203263738738;10204.285700000928;10231.28381013322;6765.458763299022;6910.8617827644175;7395.445341599294;7432.182459929295;7552.244775522404;8125.634346454542;8135.75592732219;8179.63191656365;8185.672573097248;8192.385571082312;7188.856222875618;7288.562686238843;7306.926930730625;7416.1471430783995;7438.70245190208;7066.929330706833;7141.035960145314;7183.20984691694;7205.819854503679;7240.275972402717;7616.200298968529;7647.961760191163;7703.653335599799;7708.383329333752;7720.382369410321;6908;6947.374736273558;7000.859982800417;7010.509264351446;7045.1898031727005;7013.859722805618;7015.649217539205;7074.469414793808;7084.149902011792;7086.0433841432805 17:46:16 INFO - PROCESS | 1673 | |4;prototype.html;295.4489876380551;309.6903096903097;318.27115904578517;328.5285615142271;337.61849110505125;6384.553081284312;6582.539222254444;6612.801615951529;6642.3025582313885;6674.466042716583;5292.629515933886;6422.710978005989;6502.2197336319705;6539.4114529692315;6550.639714815683;4562.292844609075;4688.859334219962;4706.576408123268;4805;4807.8798030049265;4604.125216208927;4656;4715.009847931939;4717.764111794414;4766;4674.532546745332;4681.648876334271;4692.648051396141;4694;4727.432708075035;4508.030773383738;4693.929591056137;4711.670183087185;4716.221823399135;4719.740414277197;3913.25648126855;3995.2808494470983;3999.280129576675;4014.7791871447057;4043.4137050127565;6084.995975664055;6136.96931515344;6172.1667574877265;6193.2877719062435;6205.782797602063;5450.5639548836;5457.727113644302;5461.481159289861;5465.808696695636;5468.7265636718;6614.603123812587;6782.118324617768;6788.253292137861;6810.795676129724;6814.250432452426;4402.811240964921;4426.690131690783;4430.069685366077;4431.313146462304;4442.73343599385;6724.159480064992;6850.314968503159;7184.31748983851;7260.2739726026975;7267.89098163528;3766;4373.5726671696875;4492.707973981681;4517.2772356423475;4536.682432229778;4604.102200070954;4617.353570500132;4624.398828152386;4631.675782695179;4635.976820115945;5479.945200548023;5483.643563168382;5501.779928802883;5524.558035357162;5525.226468294442;6890.655467226618;6892.827679308058;6895.448364130857;6897.3447522485285;6952.096227490394;1349.561392547426;1555.0281074328545;1573.2920185916385;1602.4631748364195;1606.4618352851692;1015.2740790334946;1020.4897551224387;1026.4559783314855;1027.9434631095362;1032.0762917189074;6258.687065646699;6326.082718005863;6355;6390.233172019387;6445.1621289233035;7039.436845052383;7139.678714457862;7159.821004474929;7176.7488137914925;7197.748078817216;6485.7405703772265;6497.122888410098;6504.60972341661;6515.641639709766;6530.314316996742;3652.6164752701116;3847.3459511883048;3850.0182453474185;3856.402257650069;3857.942130867983;7517.548947063194;7539.472236943361;7561.130469996021;7561.621918904033;7561.735339263099;6378.872422551616;7138.892916606255;7444.255574442513;7453.515521491086;7456.40348772097;7499.737509187153;7532.661030253652;7548.282913123245;7555.546667199876;7575.545467271982;7204.675789589586;7208.9639551804;7212.603306818175;7222.205557388788;7230.240824713329;6818.113645226089;7061.682224299816;7114.430845532448;7121.679524421517;7142.857142857218;6696.698648560924;7027.9458081286175;7517.1355294139685;7522.5862577558755;7559.584222867795;4690.507496712932;4748.145333839942;4763.095011947719;4766.928496072493;4770.785314660918;5838.153467747238;6910.585364878123;7125.5368401053765;7134.643267836484;7236.167840698387;6955.23492415844;6966.198887127843;6975.058367120577;6981.197162326397;6996.965015174892;5760.395158508296;6948.687309071003;6952.965235173791;6960.686769095301;6962.338577835098;5291.3121294231505;5525.392206857323;6708.6981085850275;6776.509167983036;6794.76218332356;5891.3224979126235;6621;6764.2559318475915;6833.863322733617;6939.167299924042;5635.408282130317;6527.281998980204;6788;6791.93208067913;6823.931760682528 17:46:16 INFO - PROCESS | 1673 | |5;yui.html;680.9216940051895;733.70285034561;750.0923882102655;756.8372799848031;780.1925007617117;12619.495220191193;14912.701745965074;14987.250637468138;15052.698946021073;15057.322420491077;15770.921145394286;16222.51332460028;16237.350505979746;16243.675126497492;16250.18749062548;728.2935552514053;733.1422235983885;863.1153068105195;891.5185799668204;892.192565728014;880.9867851982225;894.2220268366498;894.7494701483595;895.3866601378077;896.085992287866;939.4363381970797;940.8259471997668;943.235978857128;944.2257348973844;944.2351695126969;751.8872169174613;759.9734009309675;762.7749813804941;926.1757036237753;928.206383542072;700.1737949219919;700.3941590524211;701.1095908196562;706.2901783707341;706.9823254418629;15227;15245;15266.931314807856;15285;15297.541073767805;12158.635240942785;12320.691982700415;12494.625161245087;12745.61763147107;12904.354782260849;9948.950255248677;10237.23220758446;10297.53661085253;10301.845472317922;10304.896951030469;3497.0732755819727;3529.1177205698577;3530.5233793437815;3533.5406397168204;3537.4163263061564;82098.58950705208;83070;83392.74910876282;83424.74862877122;88390.98179496008;9231.169194772503;9380.48407337603;9488.098630630078;9530.475823829756;9618.759531011641;20693.89653051725;20698.58602827935;20707.4823129423;20718.896405517877;20793.688094678593;6247.500199983991;7327.303906128909;7524.774256772305;7534.434917381109;7695.538267703956;4136.255474014646;4168.749875007509;4177.289860723624;4190.266703326905;4191.015111448807;3521.6302288259876;3566.1619519412916;3568.6431356864105;3569.303985722759;3569.7679650822615;627.7520379450183;637.8150336402484;639.8752243312509;661.6460193796296;664.2626684380334;556.3935310511562;572.3990750506276;590.7341696236625;613.6900865063114;617.1914791622988;7633.885491717629;8211;8736.432131911533;9008.864867027;9048.049954754655;600.0968542343745;623.325496199899;625.9874802503924;629.6316654757019;638.419038674813;3809.181026079351;3942.329803933338;4045.3325201342036;4246.766427846436;4288.24955632763;75965.48069038699;76810;77081.22918770852;77544;81406;67443.30226790873;81616;82383.35233295421;82683.62556433813;82800.58599706963;53435.66410839682;74872;74922.62538687272;74933.25066749372;74972;8579.699710510351;8596.570171491276;8747.125287471457;8787.780305492413;8904.554772261232;46465.07069858652;48463.78840529015;49058.264126038855;49281;49595.26416575402;55172.17241741297;61637;62149.68925155526;65280;68942.65528672324;10795.784084318113;10881.455927203766;11033.337999720043;11052.336859788438;11574.47914843851;11797.154891997068;11833.467493962964;11866.40667966581;11936.164468487123;11947.641570752892;8513.503477981136;11085.27945683528;11687.590934317259;12095.21381110225;12232.143749937419;11536.307821530734;11572.59495917639;11643.184977051864;11691.941540292244;11848.466818992994;11054.668359949215;11152.275102118336;11370.772584548427;11373.772524549628;11454.255473394203;9640.132388085107;9682.661106861508;9776;9796.118349348593;9910.405375677483;8909.821803564022;9760.170385517311;9777.96413881221;9855.852162217428;9859.521071838995 17:46:16 INFO - PROCESS | 1673 | __end_tp_report 17:46:16 INFO - PROCESS | 1673 | __start_cc_report 17:46:16 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,1114 17:46:16 INFO - PROCESS | 1673 | __end_cc_report 17:46:16 INFO - PROCESS | 1673 | __startTimestamp1455932776140__endTimestamp 17:46:16 INFO - PROCESS | 1673 | 17:46:16 INFO - PROCESS | 1673 | ------- Summary: start ------- 17:46:16 INFO - PROCESS | 1673 | Number of tests: 6 17:46:16 INFO - PROCESS | 1673 | 17:46:16 INFO - PROCESS | 1673 | [#0] dojo.html Cycles:165 Average:5686.52 Median:5837.68 stddev:637.00 (10.9%) stddev-sans-first:595.32 17:46:16 INFO - PROCESS | 1673 | Values: 2732.9 3440.1 3452.2 3460.0 3513.1 5583.9 5648.1 5648.2 5684.5 5717.9 5582.3 5641.6 5649.2 5676.3 5677.5 5126.3 5134.0 5151.3 5190.6 5223.7 5228.3 5230.8 5235.5 5237.9 5252.9 5149.8 5196.0 5211.5 5217.3 5231.8 5174.5 5226.7 5233.8 5235.6 5295.9 5083.3 5091.8 5095.3 5134.9 5156.6 5526.3 5548.3 5580.7 5588.3 5611.9 6180.6 6187.9 6189.4 6207.5 6216.4 6139.3 6144.0 6202.2 6249.3 6269.3 5779.8 5794.8 5806.6 5810.1 5855.9 6229.7 6230.2 6231.2 6235.6 6237.3 5912.7 6017.6 6077.2 6107.8 6136.7 5855.6 6181.0 6232.6 6239.4 6239.6 5976.9 6113.4 6113.6 6130.2 6149.8 6157.4 6188.2 6192.0 6192.9 6217.0 4812.6 4818.2 4827.6 4858.7 4886.0 4305.0 4322.1 4385.4 4388.2 4422.7 5593.3 5601.3 5622.8 5624.9 5638.6 6226.9 6231.3 6238.8 6261.9 6271.8 5516.1 5600.2 5611.6 5672.6 5679.3 5275.6 5292.0 5312.0 5312.8 5337.8 6172.4 6245.3 6261.0 6272.9 6277.9 6178.8 6279.1 6283.6 6287.6 6290.8 6218.1 6250.9 6254.0 6260.7 6329.5 5989.0 6095.4 6133.8 6150.0 6166.0 5419.0 6231.9 6254.1 6258.9 6267.5 5797.2 5805.2 6034.3 6046.4 6062.9 5877.7 5920.7 5992.8 6000.8 6046.8 5829.6 5835.3 5837.7 5844.9 5847.1 5992.3 6000.3 6012.6 6013.8 6080.4 5760.1 5796.7 5837.0 5929.2 5959.3 17:46:16 INFO - PROCESS | 1673 | 17:46:16 INFO - PROCESS | 1673 | [#1] ext.html Cycles:180 Average:68456.10 Median:38447.21 stddev:150228.76 (390.7%) stddev-sans-first:150563.43 17:46:16 INFO - PROCESS | 1673 | Values: 452.6 489.0 490.6 541.0 577.0 29632.9 37790.0 38426.4 38468.0 38561.2 42963.7 43145.6 43184.6 43242.6 43252.6 9570.7 9812.2 9815.8 9824.4 9834.3 9667.5 9719.7 9735.9 9809.6 9827.1 9813.2 9866.6 9868.4 9875.2 9884.9 9731.9 9811.5 9817.6 9826.3 9830.1 9581.3 9720.1 9731.0 9736.0 9737.8 40055.0 40357.6 40541.4 40547.0 40560.6 3172.3 3195.1 3347.7 3583.8 4035.3 29540.9 30242.4 30925.5 30931.8 31007.7 2731.9 2794.2 2820.6 2832.2 2892.2 387455.0 390017.0 396935.0 397426.0 399050.0 66472.0 68001.7 68108.7 70773.0 71018.3 74515.9 74680.8 74801.3 74914.6 74966.0 16961.0 17147.5 17172.3 17184.5 17209.0 12998.5 13075.8 13077.2 13077.8 13109.2 17352.8 19749.7 21319.7 22598.5 22653.9 8205.3 9657.9 9858.5 9888.0 9924.5 946.0 950.6 1024.3 1092.4 1123.6 28247.4 28755.9 29105.6 29138.7 29259.3 1071.7 1086.8 1089.4 1176.9 1254.5 11693.4 14765.6 15863.0 16074.4 16218.7 649647.0 652671.0 652994.0 654750.0 657118.0 50520.5 58337.5 59605.7 59645.7 59769.1 1299.9 1447.7 1449.2 1461.5 1462.3 28300.4 28418.7 29124.1 29346.1 29440.4 46618.0 47355.0 47554.0 47988.3 48261.0 318572.0 646525.0 650876.0 655155.0 656971.0 32238.8 32497.0 32703.0 33434.8 33537.0 42405.6 42617.6 44263.0 44622.8 45520.3 35081.8 35436.9 36118.5 36171.3 36521.6 34730.5 35490.0 35536.6 35560.1 35564.6 34515.7 35479.8 35530.8 35639.6 35645.4 29391.7 31988.2 32029.4 32999.0 33079.0 21646.0 23431.4 24789.3 24910.0 25209.9 17:46:16 INFO - PROCESS | 1673 | 17:46:16 INFO - PROCESS | 1673 | [#2] jquery.html Cycles:180 Average:33574.58 Median:2205.47 stddev:105319.43 (4775.4%) stddev-sans-first:105585.31 17:46:16 INFO - PROCESS | 1673 | Values: 338.9 359.2 360.4 363.8 366.2 12302.7 15425.4 19330.9 19346.1 20213.0 19267.4 19607.6 19659.8 20277.4 20307.8 5684.0 5990.2 6001.9 6015.8 6016.4 4216.4 5853.1 5970.2 6332.6 6624.7 5541.9 6557.6 6574.2 6575.8 6582.2 5564.4 5703.5 5720.7 5756.6 5761.2 5693.9 5696.7 5707.0 5715.3 5717.5 12903.5 17003.8 23929.9 24238.8 24262.9 2019.7 2116.9 2134.5 2276.5 2749.4 9355.7 9869.4 9891.6 9952.6 10019.2 1798.3 1807.8 1850.9 1891.5 1908.5 71855.6 74889.3 76731.6 95321.0 102583.0 9215.0 10873.8 11148.2 11278.5 11287.9 13488.7 13644.3 13657.5 13674.6 13712.2 8460.0 8512.9 8517.1 8605.7 8641.8 8696.8 8700.3 8702.3 8758.8 8815.5 4396.4 4461.9 4466.4 4467.8 4531.2 1611.3 1752.4 1834.0 1864.4 1871.5 841.3 903.5 934.1 999.8 1021.4 18640.1 19352.7 19428.9 19593.6 19890.7 904.9 986.8 1002.3 1005.8 1039.4 10189.5 10665.5 10666.1 10686.6 10864.8 629399.0 640434.0 642459.0 643635.0 652400.0 78194.0 81025.2 96438.5 96707.0 98117.0 1010.1 1012.0 1046.0 1047.9 1071.3 17441.0 17764.8 17877.8 17910.8 17971.9 44816.3 45872.0 46500.8 46795.5 47167.0 62799.0 67592.0 69050.3 69470.7 74399.0 10346.6 10764.2 10915.5 11445.0 11742.5 12614.2 12939.0 12941.2 13080.3 13390.3 10867.5 11052.2 11200.6 11361.0 11475.0 10495.6 10531.6 10902.7 11314.3 11345.4 10295.8 10582.0 11496.7 11669.9 11827.6 11412.0 11495.5 11497.5 11677.2 11691.0 7785.9 8094.9 8105.0 8124.5 11788.9 17:46:16 INFO - PROCESS | 1673 | 17:46:16 INFO - PROCESS | 1673 | [#3] mootools.html Cycles:180 Average:5999.11 Median:2874.60 stddev:3197.36 (111.2%) stddev-sans-first:3187.60 17:46:16 INFO - PROCESS | 1673 | Values: 1396.1 1531.1 1550.7 1803.7 1958.8 7925.3 8537.1 8665.9 8691.0 8713.1 8326.6 8606.5 8613.2 8613.3 8646.3 2148.9 2410.1 2434.9 2451.9 2461.9 2446.1 2472.6 2479.9 2483.2 2490.7 2449.8 2471.1 2472.0 2478.6 2483.0 2384.2 2438.4 2454.9 2461.4 2462.5 2423.0 2439.4 2443.6 2463.5 2467.6 8706.0 8804.3 8804.7 8813.6 8833.2 5284.5 5465.8 5469.9 5484.9 5500.4 3613.2 3657.7 3705.6 3720.4 3731.1 1057.4 1058.7 1059.1 1096.5 1116.1 11792.5 11811.5 11862.3 11888.5 11927.6 4787.4 4829.9 4900.4 4926.7 4928.8 10168.6 10172.8 10183.1 10187.4 10197.0 4867.2 5442.6 5475.3 5478.9 5485.8 3849.3 4466.0 4467.4 4513.6 4768.8 3876.9 3884.5 3900.6 3941.9 3951.9 1300.6 1305.7 1307.6 1315.8 1318.1 1030.9 1048.6 1061.7 1310.7 1371.5 7997.2 8078.7 8098.7 8111.8 8153.9 514.0 519.1 520.7 523.8 529.1 5228.5 6119.8 6131.1 6147.0 6165.8 10229.3 10567.6 10597.0 10597.2 10610.9 10132.1 10448.1 10454.7 10468.3 10515.0 8067.5 8195.6 8204.2 8227.8 8300.6 7949.0 7966.2 8011.4 8066.0 8193.8 9515.8 9545.5 9634.9 9687.8 9768.2 9879.2 9896.0 9959.2 10204.3 10231.3 6765.5 6910.9 7395.4 7432.2 7552.2 8125.6 8135.8 8179.6 8185.7 8192.4 7188.9 7288.6 7306.9 7416.1 7438.7 7066.9 7141.0 7183.2 7205.8 7240.3 7616.2 7648.0 7703.7 7708.4 7720.4 6908.0 6947.4 7000.9 7010.5 7045.2 7013.9 7015.6 7074.5 7084.1 7086.0 17:46:16 INFO - PROCESS | 1673 | 17:46:16 INFO - PROCESS | 1673 | [#4] prototype.html Cycles:180 Average:5610.11 Median:6381.71 stddev:1802.00 (28.2%) stddev-sans-first:1762.35 17:46:16 INFO - PROCESS | 1673 | Values: 295.4 309.7 318.3 328.5 337.6 6384.6 6582.5 6612.8 6642.3 6674.5 5292.6 6422.7 6502.2 6539.4 6550.6 4562.3 4688.9 4706.6 4805.0 4807.9 4604.1 4656.0 4715.0 4717.8 4766.0 4674.5 4681.6 4692.6 4694.0 4727.4 4508.0 4693.9 4711.7 4716.2 4719.7 3913.3 3995.3 3999.3 4014.8 4043.4 6085.0 6137.0 6172.2 6193.3 6205.8 5450.6 5457.7 5461.5 5465.8 5468.7 6614.6 6782.1 6788.3 6810.8 6814.3 4402.8 4426.7 4430.1 4431.3 4442.7 6724.2 6850.3 7184.3 7260.3 7267.9 3766.0 4373.6 4492.7 4517.3 4536.7 4604.1 4617.4 4624.4 4631.7 4636.0 5479.9 5483.6 5501.8 5524.6 5525.2 6890.7 6892.8 6895.4 6897.3 6952.1 1349.6 1555.0 1573.3 1602.5 1606.5 1015.3 1020.5 1026.5 1027.9 1032.1 6258.7 6326.1 6355.0 6390.2 6445.2 7039.4 7139.7 7159.8 7176.7 7197.7 6485.7 6497.1 6504.6 6515.6 6530.3 3652.6 3847.3 3850.0 3856.4 3857.9 7517.5 7539.5 7561.1 7561.6 7561.7 6378.9 7138.9 7444.3 7453.5 7456.4 7499.7 7532.7 7548.3 7555.5 7575.5 7204.7 7209.0 7212.6 7222.2 7230.2 6818.1 7061.7 7114.4 7121.7 7142.9 6696.7 7027.9 7517.1 7522.6 7559.6 4690.5 4748.1 4763.1 4766.9 4770.8 5838.2 6910.6 7125.5 7134.6 7236.2 6955.2 6966.2 6975.1 6981.2 6997.0 5760.4 6948.7 6953.0 6960.7 6962.3 5291.3 5525.4 6708.7 6776.5 6794.8 5891.3 6621.0 6764.3 6833.9 6939.2 5635.4 6527.3 6788.0 6791.9 6823.9 17:46:16 INFO - PROCESS | 1673 | 17:46:16 INFO - PROCESS | 1673 | [#5] yui.html Cycles:180 Average:17914.83 Median:626.87 stddev:24714.84 (3942.6%) stddev-sans-first:24750.29 17:46:16 INFO - PROCESS | 1673 | Values: 680.9 733.7 750.1 756.8 780.2 12619.5 14912.7 14987.3 15052.7 15057.3 15770.9 16222.5 16237.4 16243.7 16250.2 728.3 733.1 863.1 891.5 892.2 881.0 894.2 894.7 895.4 896.1 939.4 940.8 943.2 944.2 944.2 751.9 760.0 762.8 926.2 928.2 700.2 700.4 701.1 706.3 707.0 15227.0 15245.0 15266.9 15285.0 15297.5 12158.6 12320.7 12494.6 12745.6 12904.4 9949.0 10237.2 10297.5 10301.8 10304.9 3497.1 3529.1 3530.5 3533.5 3537.4 82098.6 83070.0 83392.7 83424.7 88391.0 9231.2 9380.5 9488.1 9530.5 9618.8 20693.9 20698.6 20707.5 20718.9 20793.7 6247.5 7327.3 7524.8 7534.4 7695.5 4136.3 4168.7 4177.3 4190.3 4191.0 3521.6 3566.2 3568.6 3569.3 3569.8 627.8 637.8 639.9 661.6 664.3 556.4 572.4 590.7 613.7 617.2 7633.9 8211.0 8736.4 9008.9 9048.0 600.1 623.3 626.0 629.6 638.4 3809.2 3942.3 4045.3 4246.8 4288.2 75965.5 76810.0 77081.2 77544.0 81406.0 67443.3 81616.0 82383.4 82683.6 82800.6 53435.7 74872.0 74922.6 74933.3 74972.0 8579.7 8596.6 8747.1 8787.8 8904.6 46465.1 48463.8 49058.3 49281.0 49595.3 55172.2 61637.0 62149.7 65280.0 68942.7 10795.8 10881.5 11033.3 11052.3 11574.5 11797.2 11833.5 11866.4 11936.2 11947.6 8513.5 11085.3 11687.6 12095.2 12232.1 11536.3 11572.6 11643.2 11691.9 11848.5 11054.7 11152.3 11370.8 11373.8 11454.3 9640.1 9682.7 9776.0 9796.1 9910.4 8909.8 9760.2 9778.0 9855.9 9859.5 17:46:16 INFO - PROCESS | 1673 | -------- Summary: end -------- 17:46:16 INFO - PROCESS | 1673 | 17:46:16 INFO - TEST-INFO | 1673: exit 0 17:46:16 INFO - TEST-OK | dromaeo_css | took 1113090ms 17:46:16 INFO - TEST-START | kraken 17:46:16 INFO - operating with platform_type : mac_ 17:46:16 INFO - Initialising browser for kraken test... 17:46:16 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmpzc1Xyr/profile http://localhost:49274/getInfo.html) 17:46:18 INFO - PROCESS | 1681 | __metrics Screen width/height:1600/1200 17:46:18 INFO - PROCESS | 1681 | colorDepth:24 17:46:18 INFO - PROCESS | 1681 | Browser inner width/height: 1024/689 17:46:18 INFO - PROCESS | 1681 | __metrics 17:46:18 INFO - PROCESS | 1681 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:46:18 INFO - PROCESS | 1681 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:46:19 INFO - TEST-INFO | 1681: exit 0 17:46:19 INFO - Browser initialized. 17:46:19 INFO - Running cycle 1/1 for kraken test... 17:46:19 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmpzc1Xyr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:46:31 INFO - PROCESS | 1683 | RSS: Main: 244473856 17:46:31 INFO - PROCESS | 1683 | 17:46:34 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 17:46:34 INFO - PROCESS | 1683 | RSS: Main: 290234368 17:46:34 INFO - PROCESS | 1683 | 17:46:37 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 17:46:37 INFO - PROCESS | 1683 | RSS: Main: 301719552 17:46:37 INFO - PROCESS | 1683 | 17:46:41 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 17:46:41 INFO - PROCESS | 1683 | RSS: Main: 288956416 17:46:41 INFO - PROCESS | 1683 | 17:46:43 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 17:46:44 INFO - PROCESS | 1683 | RSS: Main: 290177024 17:46:44 INFO - PROCESS | 1683 | 17:46:46 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:46:46 INFO - PROCESS | 1683 | RSS: Main: 291590144 17:46:46 INFO - PROCESS | 1683 | 17:46:49 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 17:46:50 INFO - PROCESS | 1683 | RSS: Main: 291344384 17:46:50 INFO - PROCESS | 1683 | 17:46:53 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 17:46:53 INFO - PROCESS | 1683 | RSS: Main: 291569664 17:46:53 INFO - PROCESS | 1683 | 17:46:56 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 17:46:57 INFO - PROCESS | 1683 | RSS: Main: 292003840 17:46:57 INFO - PROCESS | 1683 | 17:46:58 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:46:59 INFO - PROCESS | 1683 | RSS: Main: 327671808 17:46:59 INFO - PROCESS | 1683 | 17:47:01 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:47:01 INFO - PROCESS | 1683 | RSS: Main: 328749056 17:47:01 INFO - PROCESS | 1683 | 17:47:03 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:47:04 INFO - PROCESS | 1683 | RSS: Main: 334237696 17:47:04 INFO - PROCESS | 1683 | 17:47:07 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:47:07 INFO - PROCESS | 1683 | RSS: Main: 334962688 17:47:07 INFO - PROCESS | 1683 | 17:47:10 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:47:10 INFO - PROCESS | 1683 | RSS: Main: 334696448 17:47:10 INFO - PROCESS | 1683 | 17:47:12 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 17:47:12 INFO - PROCESS | 1683 | RSS: Main: 394383360 17:47:12 INFO - PROCESS | 1683 | 17:47:12 INFO - PROCESS | 1683 | __start_tp_report 17:47:12 INFO - PROCESS | 1683 | _x_x_mozilla_page_load 17:47:12 INFO - PROCESS | 1683 | _x_x_mozilla_page_load_details 17:47:12 INFO - PROCESS | 1683 | |i|pagename|runs| 17:47:12 INFO - PROCESS | 1683 | |0;ai-astar;110;109;111;112;112;110;117;112;111;111 17:47:12 INFO - PROCESS | 1683 | |1;audio-beat-detection;159;123;145;155;120;143;140;119;159;119 17:47:12 INFO - PROCESS | 1683 | |2;audio-dft;185;188;191;262;211;188;187;182;183;186 17:47:12 INFO - PROCESS | 1683 | |3;audio-fft;74;78;92;81;55;59;59;80;74;55 17:47:12 INFO - PROCESS | 1683 | |4;audio-oscillator;93;91;123;79;78;82;110;77;81;107 17:47:12 INFO - PROCESS | 1683 | |5;imaging-gaussian-blur;85;90;83;90;84;90;83;90;83;90 17:47:12 INFO - PROCESS | 1683 | |6;imaging-darkroom;93;92;95;93;94;93;94;93;93;94 17:47:12 INFO - PROCESS | 1683 | |7;imaging-desaturate;85;85;85;86;88;95;127;136;86;86 17:47:12 INFO - PROCESS | 1683 | |8;json-parse-financial;53;54;53;53;60;76;80;92;80;81 17:47:12 INFO - PROCESS | 1683 | |9;json-stringify-tinderbox;65;67;71;75;70;67;65;69;93;97 17:47:12 INFO - PROCESS | 1683 | |10;stanford-crypto-aes;85;83;82;83;81;82;84;82;83;83 17:47:12 INFO - PROCESS | 1683 | |11;stanford-crypto-ccm;130;130;131;130;121;120;126;130;131;124 17:47:12 INFO - PROCESS | 1683 | |12;stanford-crypto-pbkdf2;138;125;139;134;137;127;140;138;139;137 17:47:12 INFO - PROCESS | 1683 | |13;stanford-crypto-sha256-iterative;67;84;93;96;94;72;68;67;65;67 17:47:12 INFO - PROCESS | 1683 | __end_tp_report 17:47:12 INFO - PROCESS | 1683 | __start_cc_report 17:47:12 INFO - PROCESS | 1683 | _x_x_mozilla_cycle_collect,1164 17:47:12 INFO - PROCESS | 1683 | __end_cc_report 17:47:12 INFO - PROCESS | 1683 | __startTimestamp1455932832985__endTimestamp 17:47:12 INFO - PROCESS | 1683 | 17:47:12 INFO - PROCESS | 1683 | ------- Summary: start ------- 17:47:12 INFO - PROCESS | 1683 | Number of tests: 14 17:47:12 INFO - PROCESS | 1683 | 17:47:12 INFO - PROCESS | 1683 | [#0] ai-astar Cycles:10 Average:111.50 Median:111.50 stddev:2.17 (1.9%) stddev-sans-first:2.24 17:47:12 INFO - PROCESS | 1683 | Values: 110.0 109.0 111.0 112.0 112.0 110.0 117.0 112.0 111.0 111.0 17:47:12 INFO - PROCESS | 1683 | 17:47:12 INFO - PROCESS | 1683 | [#1] audio-beat-detection Cycles:10 Average:138.20 Median:144.00 stddev:16.73 (11.6%) stddev-sans-first:15.96 17:47:12 INFO - PROCESS | 1683 | Values: 159.0 123.0 145.0 155.0 120.0 143.0 140.0 119.0 159.0 119.0 17:47:12 INFO - PROCESS | 1683 | 17:47:12 INFO - PROCESS | 1683 | [#2] audio-dft Cycles:10 Average:196.30 Median:188.00 stddev:24.50 (13.0%) stddev-sans-first:25.64 17:47:12 INFO - PROCESS | 1683 | Values: 185.0 188.0 191.0 262.0 211.0 188.0 187.0 182.0 183.0 186.0 17:47:12 INFO - PROCESS | 1683 | 17:47:12 INFO - PROCESS | 1683 | [#3] audio-fft Cycles:10 Average:70.70 Median:76.00 stddev:12.86 (16.9%) stddev-sans-first:13.58 17:47:12 INFO - PROCESS | 1683 | Values: 74.0 78.0 92.0 81.0 55.0 59.0 59.0 80.0 74.0 55.0 17:47:12 INFO - PROCESS | 1683 | 17:47:12 INFO - PROCESS | 1683 | [#4] audio-oscillator Cycles:10 Average:92.10 Median:80.00 stddev:16.07 (20.1%) stddev-sans-first:17.04 17:47:12 INFO - PROCESS | 1683 | Values: 93.0 91.0 123.0 79.0 78.0 82.0 110.0 77.0 81.0 107.0 17:47:12 INFO - PROCESS | 1683 | 17:47:12 INFO - PROCESS | 1683 | [#5] imaging-gaussian-blur Cycles:10 Average:86.80 Median:90.00 stddev:3.43 (3.8%) stddev-sans-first:3.57 17:47:12 INFO - PROCESS | 1683 | Values: 85.0 90.0 83.0 90.0 84.0 90.0 83.0 90.0 83.0 90.0 17:47:12 INFO - PROCESS | 1683 | 17:47:12 INFO - PROCESS | 1683 | [#6] imaging-darkroom Cycles:10 Average:93.40 Median:93.50 stddev:0.84 (0.9%) stddev-sans-first:0.88 17:47:12 INFO - PROCESS | 1683 | Values: 93.0 92.0 95.0 93.0 94.0 93.0 94.0 93.0 93.0 94.0 17:47:12 INFO - PROCESS | 1683 | 17:47:12 INFO - PROCESS | 1683 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:86.00 stddev:19.12 (22.2%) stddev-sans-first:19.86 17:47:12 INFO - PROCESS | 1683 | Values: 85.0 85.0 85.0 86.0 88.0 95.0 127.0 136.0 86.0 86.0 17:47:12 INFO - PROCESS | 1683 | 17:47:12 INFO - PROCESS | 1683 | [#8] json-parse-financial Cycles:10 Average:68.20 Median:78.00 stddev:15.02 (19.3%) stddev-sans-first:14.90 17:47:12 INFO - PROCESS | 1683 | Values: 53.0 54.0 53.0 53.0 60.0 76.0 80.0 92.0 80.0 81.0 17:47:12 INFO - PROCESS | 1683 | 17:47:12 INFO - PROCESS | 1683 | [#9] json-stringify-tinderbox Cycles:10 Average:73.90 Median:70.50 stddev:11.55 (16.4%) stddev-sans-first:11.79 17:47:12 INFO - PROCESS | 1683 | Values: 65.0 67.0 71.0 75.0 70.0 67.0 65.0 69.0 93.0 97.0 17:47:12 INFO - PROCESS | 1683 | 17:47:12 INFO - PROCESS | 1683 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.00 stddev:1.14 (1.4%) stddev-sans-first:0.88 17:47:12 INFO - PROCESS | 1683 | Values: 85.0 83.0 82.0 83.0 81.0 82.0 84.0 82.0 83.0 83.0 17:47:12 INFO - PROCESS | 1683 | 17:47:12 INFO - PROCESS | 1683 | [#11] stanford-crypto-ccm Cycles:10 Average:127.30 Median:130.00 stddev:4.24 (3.3%) stddev-sans-first:4.39 17:47:12 INFO - PROCESS | 1683 | Values: 130.0 130.0 131.0 130.0 121.0 120.0 126.0 130.0 131.0 124.0 17:47:12 INFO - PROCESS | 1683 | 17:47:12 INFO - PROCESS | 1683 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.40 Median:138.00 stddev:5.23 (3.8%) stddev-sans-first:5.46 17:47:12 INFO - PROCESS | 1683 | Values: 138.0 125.0 139.0 134.0 137.0 127.0 140.0 138.0 139.0 137.0 17:47:12 INFO - PROCESS | 1683 | 17:47:12 INFO - PROCESS | 1683 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.30 Median:78.00 stddev:12.93 (16.6%) stddev-sans-first:13.16 17:47:12 INFO - PROCESS | 1683 | Values: 67.0 84.0 93.0 96.0 94.0 72.0 68.0 67.0 65.0 67.0 17:47:12 INFO - PROCESS | 1683 | -------- Summary: end -------- 17:47:12 INFO - PROCESS | 1683 | 17:47:13 INFO - TEST-INFO | 1683: exit 0 17:47:13 INFO - TEST-OK | kraken | took 57086ms 17:47:13 INFO - SUITE-END | took 1170s 17:47:14 INFO - Completed test suite (00:19:30) 17:47:14 INFO - Working with test: dromaeo_css 17:47:14 INFO - Generating results file: dromaeo_css 17:47:14 INFO - Working with test: kraken 17:47:14 INFO - Generating results file: kraken 17:47:14 INFO - javascript benchmark 17:47:14 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:47:14 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 17:47:14 INFO - process_Request line: dromaeo_css 7475.74 graph.html#tests=[[72,64,59]] 17:47:14 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:47:14 INFO - process_Request line: kraken 1449.80 graph.html#tests=[[232,64,59]] 17:47:14 INFO - RETURN: dromaeo_css: 7475.74 17:47:14 INFO - RETURN: kraken: 1449.80 17:47:14 INFO - javascript benchmark 17:47:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2732.8633568321584, 3440.105572551136, 3452.205992621697, 3460.0, 3513.1041584395975, 5583.888322233553, 5648.096304591266, 5648.152777083439, 5684.459976302255, 5717.857053573663, 5582.27430434044, 5641.633293835908, 5649.23735295735, 5676.347220069693, 5677.517411020068, 5126.282320475137, 5133.974330128362, 5151.304573882534, 5190.558802501791, 5223.686578805265, 5228.320318358608, 5230.843074707765, 5235.528802407783, 5237.8952420951555, 5252.868678283055, 5149.768260428271, 5196.038732834438, 5211.5049070338255, 5217.295665085203, 5231.790728370861, 5174.508421699932, 5226.660267082628, 5233.764480598382, 5235.55497782689, 5295.947040529584, 5083.262926875619, 5091.79632814687, 5095.286659867622, 5134.897302053975, 5156.613254005927, 5526.253955715967, 5548.334199895998, 5580.693061881595, 5588.329400471969, 5611.887762244733, 6180.567360284782, 6187.938120618826, 6189.38106189382, 6207.503399728011, 6216.409441103088, 6139.324674285825, 6144.047672610708, 6202.162708034402, 6249.25008998923, 6269.279032911182, 5779.797707080316, 5794.797182098607, 5806.59353845231, 5810.099434587646, 5855.853603659943, 6229.657368844757, 6230.158928544589, 6231.22109736283, 6235.625862448177, 6237.282712488031, 5912.70436478183, 6017.608855424471, 6077.246020137703, 6107.755689772448, 6136.723847426876, 5855.59010869235, 6181.041938499539, 6232.626042437469, 6239.376062393724, 6239.594426362272, 5976.85057873548, 6113.4154954094565, 6113.584860652744, 6130.2414262968205, 6149.800788846222, 6157.415045570664, 6188.195534580475, 6192.0, 6192.8761424771255, 6216.968915155486, 4812.590929771009, 4818.180909245437, 4827.589654879374, 4858.732769697701, 4886.0, 4304.978475107604, 4322.092360604308, 4385.386045953569, 4388.188185185751, 4422.7346359218545, 5593.328800543961, 5601.327840659147, 5622.7750889963945, 5624.943750562442, 5638.577106717013, 6226.906596401058, 6231.3145553989025, 6238.75044998195, 6261.906071408933, 6271.843203919939, 5516.117421212667, 5600.159976003632, 5611.6352437091455, 5672.602917795797, 5679.261695979496, 5275.63070585063, 5292.0, 5312.043832110257, 5312.840614781563, 5337.8131765388025, 6172.444479996821, 6245.250569931637, 6261.029540421151, 6272.933601287792, 6277.937220627735, 6178.845528861814, 6279.058141278845, 6283.5601507895835, 6287.591306565058, 6290.811275661737, 6218.06728990655, 6250.906236406367, 6254.0, 6260.655663938345, 6329.5252856036905, 5988.970055149696, 6095.35998720128, 6133.754649813957, 6150.0, 6166.0, 5418.972905135449, 6231.875362492634, 6254.061890716429, 6258.937410625836, 6267.529935254783, 5797.246357973437, 5805.216295800013, 6034.275886893601, 6046.395360463918, 6062.878742425215, 5877.73550190251, 5920.73356698941, 5992.820215393545, 6000.849978750566, 6046.848828779316, 5829.562782791223, 5835.328937172279, 5837.67892765902, 5844.912326315194, 5847.1229315603, 5992.340842507408, 6000.309964354155, 6012.609180403259, 6013.789517366871, 6080.422359875804, 5760.0783874579865, 5796.652200867961, 5837.0368889132815, 5929.229200203946, 5959.28488581373], "unit": "score", "name": "dojo.html", "value": 5645.064118023515}, {"lowerIsBetter": false, "replicates": [452.60849365299003, 488.99755501222484, 490.5977098779002, 540.9621326507145, 576.9845072672096, 29632.851835740817, 37790.0, 38426.42360364597, 38467.99999999996, 38561.228775424475, 42963.71108866731, 43145.56854431455, 43184.56815431845, 43242.56757432425, 43252.567474325246, 9570.712878613653, 9812.165965892907, 9815.754606134833, 9824.410535367864, 9834.26243031772, 9667.516624168798, 9719.708408747714, 9735.853962190573, 9809.558569864374, 9827.066428689299, 9813.214942804594, 9866.556004979793, 9868.407895526256, 9875.209983201363, 9884.90115098847, 9731.902680973171, 9811.509424528746, 9817.6072957082, 9826.312158148932, 9830.115289623896, 9581.329306948517, 9720.125188733047, 9731.0, 9735.951320243425, 9737.756556086084, 40055.0, 40357.59642403568, 40541.39187912184, 40547.0, 40560.594394055974, 3172.254520187754, 3195.137312925497, 3347.748918831073, 3583.7670551414076, 4035.293823580891, 29540.852295738383, 30242.395152096833, 30925.536116958265, 30931.84534077315, 31007.68992310093, 2731.877065532036, 2794.18968499135, 2820.562812764025, 2832.1645114691214, 2892.2335581071034, 387455.0, 390017.0, 396935.0, 397426.0, 399050.0, 66472.0, 68001.65999169972, 68108.65945670339, 70773.0, 71018.28981710116, 74515.88226176612, 74680.78511363745, 74801.25198748051, 74914.62542687252, 74966.0, 16961.0, 17147.48557543276, 17172.31310747581, 17184.484465466056, 17209.0, 12998.480060797652, 13075.823175914024, 13077.215367078006, 13077.803832942513, 13109.213447193199, 17352.826471735374, 19749.703754443693, 21319.68020479663, 22598.548029039328, 22653.941717868205, 8205.251240834268, 9657.855132172883, 9858.507074646239, 9887.950560247153, 9924.454155021398, 945.9810803783886, 950.5674917912334, 1024.3239461955075, 1092.4210168610648, 1123.5955056179769, 28247.43505129886, 28755.856220718764, 29105.563416548768, 29138.708612914023, 29259.268518287212, 1071.7052810477026, 1086.8316559698355, 1089.3518356577824, 1176.9411529423494, 1254.4605819497522, 11693.356865372316, 14765.608283947022, 15863.04821710701, 16074.43739469113, 16218.673353680895, 649647.0, 652671.0, 652994.0, 654750.0, 657118.0, 50520.49479505158, 58337.49975001514, 59605.70197148986, 59645.701771490865, 59769.10346344808, 1299.876511731384, 1447.7466443372577, 1449.1956963885145, 1461.4811741831497, 1462.3419461242484, 28300.433991319645, 28418.71581284161, 29124.126276211748, 29346.119616411543, 29440.41119177647, 46618.0, 47355.0, 47554.0, 47988.28017579809, 48261.0, 318572.0, 646525.0, 650876.0, 655155.0, 656971.0, 32238.838805805823, 32497.0, 32703.0, 33434.83282583669, 33537.0, 42405.57594424016, 42617.5738242626, 44263.0, 44622.77688611536, 45520.31719524276, 35081.82459087688, 35436.93689189328, 36118.45822312615, 36171.27657446889, 36521.63478365289, 34730.47904281387, 35490.0, 35536.64463355333, 35560.110997225274, 35564.64435355717, 34515.65484345225, 35479.82260088683, 35530.82234588914, 35639.64360356363, 35645.39595718251, 29391.706082938897, 31988.20029499281, 32029.359412811147, 32999.0, 33079.0, 21646.0, 23431.41421464477, 24789.25632231036, 24910.0, 25209.873950630128], "unit": "score", "name": "ext.html", "value": 20111.513157318088}, {"lowerIsBetter": false, "replicates": [338.94576867701164, 359.24379181822263, 360.40713027070484, 363.75264819922444, 366.1961993424431, 12302.692432689188, 15425.3829846806, 19330.936798476097, 19346.12942417591, 20212.989350532487, 19267.421977340666, 19607.607847843035, 19659.803401965975, 20277.391678249638, 20307.796922030775, 5683.971580142103, 5990.161377407145, 6001.909971350433, 6015.819525414245, 6016.4357267110645, 4216.388623649569, 5853.09277062056, 5970.194023806774, 6332.556721029529, 6624.701888415008, 5541.889162216753, 6557.573757705758, 6574.178227721535, 6575.835604109888, 6582.243042050178, 5564.387917329091, 5703.54371650267, 5720.742566584514, 5756.568257380693, 5761.193432919395, 5693.914591281134, 5696.743646535916, 5707.0, 5715.257016587859, 5717.48542631161, 12903.548375806895, 17003.829961700347, 23929.880350598134, 24238.7880605969, 24262.878685606636, 2019.6970454431805, 2116.883571403572, 2134.4557137929883, 2276.4877902471976, 2749.408877091435, 9355.672551460735, 9869.407835529892, 9891.604335826558, 9952.552135153863, 10019.198464122852, 1798.3166396769143, 1807.7649905512199, 1850.9352172673891, 1891.4798430431604, 1908.5228692826793, 71855.64072179605, 74889.25110748931, 76731.61634191849, 95321.0, 102583.0, 9215.0, 10873.782524349626, 11148.219624626361, 11278.54885804575, 11287.887121128684, 13488.662783430493, 13644.317784110755, 13657.453701852013, 13674.589762307147, 13712.24582647944, 8460.0, 8512.872306915402, 8517.148285171557, 8605.65577376898, 8641.783955401039, 8696.826063478695, 8700.34747393948, 8702.347323950602, 8758.781030474289, 8815.515146666867, 4396.4284642996845, 4461.933071003938, 4466.3523789050405, 4467.843625473093, 4531.18438681034, 1611.3151910438016, 1752.4041825779295, 1834.0371305064948, 1864.3567969050655, 1871.4759867237196, 841.3143288220081, 903.4714691905177, 934.0566028311318, 999.8350272205005, 1021.3769600543662, 18640.067996600115, 19352.70970935437, 19428.902855485914, 19593.608127837364, 19890.70163947542, 904.8778414914034, 986.8470387090013, 1002.2533212756543, 1005.8038682456997, 1039.428314427062, 10189.54147063384, 10665.520051597698, 10666.146708263475, 10686.625968091079, 10864.782704346027, 629399.0, 640434.0, 642459.0, 643635.0, 652400.0, 78194.0, 81025.18974810294, 96438.51780741192, 96707.0329296698, 98117.0, 1010.1312870930993, 1012.0233974214918, 1045.994770026145, 1047.9214058945608, 1071.2929466552193, 17441.0, 17764.822351776318, 17877.821221787617, 17910.820891791438, 17971.910140449214, 44816.32775508435, 45872.0, 46500.767496162305, 46795.532044680476, 47167.0, 62799.0, 67592.0, 69050.30949690439, 69470.65264673645, 74399.0, 10346.586136554453, 10764.192685548458, 10915.454227288763, 11445.027172690414, 11742.530298787953, 12614.243145411305, 12939.0, 12941.223526588436, 13080.345982701017, 13390.26353550564, 10867.510962006887, 11052.171087168334, 11200.551977920792, 11361.0, 11475.0, 10495.580176792842, 10531.57873685044, 10902.727431814268, 11314.264572802742, 11345.432728363714, 10295.845562316721, 10581.99471050249, 11496.712582185512, 11669.88330116722, 11827.645170644895, 11412.02997745201, 11495.48270327854, 11497.540098396305, 11677.182597218452, 11691.0, 7785.948896898846, 8094.919050809416, 8104.959475202586, 8124.471909325875, 11788.941055294668], "unit": "score", "name": "jquery.html", "value": 9288.778113497217}, {"lowerIsBetter": false, "replicates": [1396.0506855338365, 1531.1043039821704, 1550.6588550518886, 1803.7294405839123, 1958.7943265957074, 7925.326347260482, 8537.14628537146, 8665.87001194981, 8691.0, 8713.128687131291, 8326.625301861415, 8606.526641034741, 8613.181747733955, 8613.310935125191, 8646.308295336374, 2148.871067735933, 2410.144398738449, 2434.926952191437, 2451.8774061296954, 2461.876906154694, 2446.0949448704005, 2472.6414669872856, 2479.8636075015866, 2483.242611003643, 2490.68866391701, 2449.7672721091467, 2471.1351027140536, 2471.9752802472017, 2478.615814548748, 2482.962755558668, 2384.177458776728, 2438.3904023994, 2454.8527088374753, 2461.4092617771694, 2462.5198086373166, 2422.9636555451684, 2439.3657649011207, 2443.572374834415, 2463.519613675334, 2467.605183170684, 8705.956470217672, 8804.339674524435, 8804.691835785781, 8813.647454101829, 8833.160849719266, 5284.524392804666, 5465.754041068121, 5469.945300546983, 5484.890302193934, 5500.367457742371, 3613.1689711366535, 3657.6708096271464, 3705.6109108543756, 3720.3675375186012, 3731.1418373773913, 1057.444841458233, 1058.6929790360864, 1059.1368035051407, 1096.4627332607045, 1116.1405717597486, 11792.469338879686, 11811.527538898434, 11862.347570883598, 11888.524459021628, 11927.582534611247, 4787.3537072495465, 4829.879253018703, 4900.387451568554, 4926.704397736075, 4928.778204980785, 10168.593256269814, 10172.796544069077, 10183.083522482864, 10187.439690817077, 10196.980301969743, 4867.196912509467, 5442.564594832483, 5475.288212532345, 5478.945210547843, 5485.753141108659, 3849.345611246039, 4466.0, 4467.441569803775, 4513.593776560126, 4768.7615619218905, 3876.8836934891997, 3884.533855937306, 3900.64894159527, 3941.9356773670947, 3951.920961580752, 1300.5838131797734, 1305.7127431964952, 1307.5750381126172, 1315.8420989481324, 1318.0773458579033, 1030.8762948446235, 1048.5858086056119, 1061.6549621373085, 1310.698539335939, 1371.4651285998468, 7997.240262175084, 8078.7172448964, 8098.676052957933, 8111.797205069803, 8153.8776918346275, 513.956313713331, 519.1382305373063, 520.6667732651106, 523.7616884317626, 529.100529100523, 5228.529432351107, 6119.84700382494, 6131.110988906584, 6146.985747351726, 6165.84585385369, 10229.283950123569, 10567.577296908037, 10597.0, 10597.152227821756, 10610.938906109328, 10132.138768204637, 10448.111910487694, 10454.738631534272, 10468.267221294436, 10515.0, 8067.475614085066, 8195.590220488952, 8204.220599043081, 8227.753167404868, 8300.626471808782, 7949.0, 7966.203379661987, 8011.439199255996, 8065.9596702016115, 8193.836123277382, 9515.762105947406, 9545.474998875128, 9634.90365096368, 9687.806243874942, 9768.169705575106, 9879.209663227068, 9896.0, 9959.203263738738, 10204.285700000928, 10231.28381013322, 6765.458763299022, 6910.8617827644175, 7395.445341599294, 7432.182459929295, 7552.244775522404, 8125.634346454542, 8135.75592732219, 8179.63191656365, 8185.672573097248, 8192.385571082312, 7188.856222875618, 7288.562686238843, 7306.926930730625, 7416.1471430783995, 7438.70245190208, 7066.929330706833, 7141.035960145314, 7183.20984691694, 7205.819854503679, 7240.275972402717, 7616.200298968529, 7647.961760191163, 7703.653335599799, 7708.383329333752, 7720.382369410321, 6908.0, 6947.374736273558, 7000.859982800417, 7010.509264351446, 7045.1898031727005, 7013.859722805618, 7015.649217539205, 7074.469414793808, 7084.149902011792, 7086.0433841432805], "unit": "score", "name": "mootools.html", "value": 4801.2049454542885}, {"lowerIsBetter": false, "replicates": [295.4489876380551, 309.6903096903097, 318.27115904578517, 328.5285615142271, 337.61849110505125, 6384.553081284312, 6582.539222254444, 6612.801615951529, 6642.3025582313885, 6674.466042716583, 5292.629515933886, 6422.710978005989, 6502.2197336319705, 6539.4114529692315, 6550.639714815683, 4562.292844609075, 4688.859334219962, 4706.576408123268, 4805.0, 4807.8798030049265, 4604.125216208927, 4656.0, 4715.009847931939, 4717.764111794414, 4766.0, 4674.532546745332, 4681.648876334271, 4692.648051396141, 4694.0, 4727.432708075035, 4508.030773383738, 4693.929591056137, 4711.670183087185, 4716.221823399135, 4719.740414277197, 3913.25648126855, 3995.2808494470983, 3999.280129576675, 4014.7791871447057, 4043.4137050127565, 6084.995975664055, 6136.96931515344, 6172.1667574877265, 6193.2877719062435, 6205.782797602063, 5450.5639548836, 5457.727113644302, 5461.481159289861, 5465.808696695636, 5468.7265636718, 6614.603123812587, 6782.118324617768, 6788.253292137861, 6810.795676129724, 6814.250432452426, 4402.811240964921, 4426.690131690783, 4430.069685366077, 4431.313146462304, 4442.73343599385, 6724.159480064992, 6850.314968503159, 7184.31748983851, 7260.2739726026975, 7267.89098163528, 3766.0, 4373.5726671696875, 4492.707973981681, 4517.2772356423475, 4536.682432229778, 4604.102200070954, 4617.353570500132, 4624.398828152386, 4631.675782695179, 4635.976820115945, 5479.945200548023, 5483.643563168382, 5501.779928802883, 5524.558035357162, 5525.226468294442, 6890.655467226618, 6892.827679308058, 6895.448364130857, 6897.3447522485285, 6952.096227490394, 1349.561392547426, 1555.0281074328545, 1573.2920185916385, 1602.4631748364195, 1606.4618352851692, 1015.2740790334946, 1020.4897551224387, 1026.4559783314855, 1027.9434631095362, 1032.0762917189074, 6258.687065646699, 6326.082718005863, 6355.0, 6390.233172019387, 6445.1621289233035, 7039.436845052383, 7139.678714457862, 7159.821004474929, 7176.7488137914925, 7197.748078817216, 6485.7405703772265, 6497.122888410098, 6504.60972341661, 6515.641639709766, 6530.314316996742, 3652.6164752701116, 3847.3459511883048, 3850.0182453474185, 3856.402257650069, 3857.942130867983, 7517.548947063194, 7539.472236943361, 7561.130469996021, 7561.621918904033, 7561.735339263099, 6378.872422551616, 7138.892916606255, 7444.255574442513, 7453.515521491086, 7456.40348772097, 7499.737509187153, 7532.661030253652, 7548.282913123245, 7555.546667199876, 7575.545467271982, 7204.675789589586, 7208.9639551804, 7212.603306818175, 7222.205557388788, 7230.240824713329, 6818.113645226089, 7061.682224299816, 7114.430845532448, 7121.679524421517, 7142.857142857218, 6696.698648560924, 7027.9458081286175, 7517.1355294139685, 7522.5862577558755, 7559.584222867795, 4690.507496712932, 4748.145333839942, 4763.095011947719, 4766.928496072493, 4770.785314660918, 5838.153467747238, 6910.585364878123, 7125.5368401053765, 7134.643267836484, 7236.167840698387, 6955.23492415844, 6966.198887127843, 6975.058367120577, 6981.197162326397, 6996.965015174892, 5760.395158508296, 6948.687309071003, 6952.965235173791, 6960.686769095301, 6962.338577835098, 5291.3121294231505, 5525.392206857323, 6708.6981085850275, 6776.509167983036, 6794.76218332356, 5891.3224979126235, 6621.0, 6764.2559318475915, 6833.863322733617, 6939.167299924042, 5635.408282130317, 6527.281998980204, 6788.0, 6791.93208067913, 6823.931760682528], "unit": "score", "name": "prototype.html", "value": 5004.619491685973}, {"lowerIsBetter": false, "replicates": [680.9216940051895, 733.70285034561, 750.0923882102655, 756.8372799848031, 780.1925007617117, 12619.495220191193, 14912.701745965074, 14987.250637468138, 15052.698946021073, 15057.322420491077, 15770.921145394286, 16222.51332460028, 16237.350505979746, 16243.675126497492, 16250.18749062548, 728.2935552514053, 733.1422235983885, 863.1153068105195, 891.5185799668204, 892.192565728014, 880.9867851982225, 894.2220268366498, 894.7494701483595, 895.3866601378077, 896.085992287866, 939.4363381970797, 940.8259471997668, 943.235978857128, 944.2257348973844, 944.2351695126969, 751.8872169174613, 759.9734009309675, 762.7749813804941, 926.1757036237753, 928.206383542072, 700.1737949219919, 700.3941590524211, 701.1095908196562, 706.2901783707341, 706.9823254418629, 15227.0, 15245.0, 15266.931314807856, 15285.0, 15297.541073767805, 12158.635240942785, 12320.691982700415, 12494.625161245087, 12745.61763147107, 12904.354782260849, 9948.950255248677, 10237.23220758446, 10297.53661085253, 10301.845472317922, 10304.896951030469, 3497.0732755819727, 3529.1177205698577, 3530.5233793437815, 3533.5406397168204, 3537.4163263061564, 82098.58950705208, 83070.0, 83392.74910876282, 83424.74862877122, 88390.98179496008, 9231.169194772503, 9380.48407337603, 9488.098630630078, 9530.475823829756, 9618.759531011641, 20693.89653051725, 20698.58602827935, 20707.4823129423, 20718.896405517877, 20793.688094678593, 6247.500199983991, 7327.303906128909, 7524.774256772305, 7534.434917381109, 7695.538267703956, 4136.255474014646, 4168.749875007509, 4177.289860723624, 4190.266703326905, 4191.015111448807, 3521.6302288259876, 3566.1619519412916, 3568.6431356864105, 3569.303985722759, 3569.7679650822615, 627.7520379450183, 637.8150336402484, 639.8752243312509, 661.6460193796296, 664.2626684380334, 556.3935310511562, 572.3990750506276, 590.7341696236625, 613.6900865063114, 617.1914791622988, 7633.885491717629, 8211.0, 8736.432131911533, 9008.864867027, 9048.049954754655, 600.0968542343745, 623.325496199899, 625.9874802503924, 629.6316654757019, 638.419038674813, 3809.181026079351, 3942.329803933338, 4045.3325201342036, 4246.766427846436, 4288.24955632763, 75965.48069038699, 76810.0, 77081.22918770852, 77544.0, 81406.0, 67443.30226790873, 81616.0, 82383.35233295421, 82683.62556433813, 82800.58599706963, 53435.66410839682, 74872.0, 74922.62538687272, 74933.25066749372, 74972.0, 8579.699710510351, 8596.570171491276, 8747.125287471457, 8787.780305492413, 8904.554772261232, 46465.07069858652, 48463.78840529015, 49058.264126038855, 49281.0, 49595.26416575402, 55172.17241741297, 61637.0, 62149.68925155526, 65280.0, 68942.65528672324, 10795.784084318113, 10881.455927203766, 11033.337999720043, 11052.336859788438, 11574.47914843851, 11797.154891997068, 11833.467493962964, 11866.40667966581, 11936.164468487123, 11947.641570752892, 8513.503477981136, 11085.27945683528, 11687.590934317259, 12095.21381110225, 12232.143749937419, 11536.307821530734, 11572.59495917639, 11643.184977051864, 11691.941540292244, 11848.466818992994, 11054.668359949215, 11152.275102118336, 11370.772584548427, 11373.772524549628, 11454.255473394203, 9640.132388085107, 9682.661106861508, 9776.0, 9796.118349348593, 9910.405375677483, 8909.821803564022, 9760.170385517311, 9777.96413881221, 9855.852162217428, 9859.521071838995], "unit": "score", "name": "yui.html", "value": 6888.033585424593}], "name": "dromaeo_css", "value": 7475.741843823721}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 109.0, 111.0, 112.0, 112.0, 110.0, 117.0, 112.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.5}, {"lowerIsBetter": true, "replicates": [159.0, 123.0, 145.0, 155.0, 120.0, 143.0, 140.0, 119.0, 159.0, 119.0], "unit": "score", "name": "audio-beat-detection", "value": 138.2}, {"lowerIsBetter": true, "replicates": [185.0, 188.0, 191.0, 262.0, 211.0, 188.0, 187.0, 182.0, 183.0, 186.0], "unit": "score", "name": "audio-dft", "value": 196.3}, {"lowerIsBetter": true, "replicates": [74.0, 78.0, 92.0, 81.0, 55.0, 59.0, 59.0, 80.0, 74.0, 55.0], "unit": "score", "name": "audio-fft", "value": 70.7}, {"lowerIsBetter": true, "replicates": [93.0, 91.0, 123.0, 79.0, 78.0, 82.0, 110.0, 77.0, 81.0, 107.0], "unit": "score", "name": "audio-oscillator", "value": 92.1}, {"lowerIsBetter": true, "replicates": [85.0, 90.0, 83.0, 90.0, 84.0, 90.0, 83.0, 90.0, 83.0, 90.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 86.8}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 95.0, 93.0, 94.0, 93.0, 94.0, 93.0, 93.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 93.4}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 85.0, 86.0, 88.0, 95.0, 127.0, 136.0, 86.0, 86.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [53.0, 54.0, 53.0, 53.0, 60.0, 76.0, 80.0, 92.0, 80.0, 81.0], "unit": "score", "name": "json-parse-financial", "value": 68.2}, {"lowerIsBetter": true, "replicates": [65.0, 67.0, 71.0, 75.0, 70.0, 67.0, 65.0, 69.0, 93.0, 97.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 73.9}, {"lowerIsBetter": true, "replicates": [85.0, 83.0, 82.0, 83.0, 81.0, 82.0, 84.0, 82.0, 83.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.8}, {"lowerIsBetter": true, "replicates": [130.0, 130.0, 131.0, 130.0, 121.0, 120.0, 126.0, 130.0, 131.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.3}, {"lowerIsBetter": true, "replicates": [138.0, 125.0, 139.0, 134.0, 137.0, 127.0, 140.0, 138.0, 139.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.4}, {"lowerIsBetter": true, "replicates": [67.0, 84.0, 93.0, 96.0, 94.0, 72.0, 68.0, 67.0, 65.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 77.3}], "name": "kraken", "value": 1449.8}]} 17:47:14 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1449.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7475.74"}}} 17:47:14 INFO - Return code: 0 17:47:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:47:14 INFO - # TBPL SUCCESS # 17:47:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:47:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:47:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:47:14 INFO - 2016-02-19 17:47:14.362 screenresolution[1687:10563] starting screenresolution argv=screenresolution get 17:47:14 INFO - 2016-02-19 17:47:14.365 screenresolution[1687:10563] Display 0: 1600x1200x32@60 17:47:14 INFO - 2016-02-19 17:47:14.371 screenresolution[1688:10566] starting screenresolution argv=screenresolution list 17:47:14 INFO - Available Modes on Display 0 17:47:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:47:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:47:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:47:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:47:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:47:14 INFO - Intel Iris: 17:47:14 INFO - Chipset Model: Intel Iris 17:47:14 INFO - Type: GPU 17:47:14 INFO - Bus: Built-In 17:47:14 INFO - VRAM (Dynamic, Max): 1536 MB 17:47:14 INFO - Vendor: Intel (0x8086) 17:47:14 INFO - Device ID: 0x0a2e 17:47:14 INFO - Revision ID: 0x0009 17:47:14 INFO - Displays: 17:47:14 INFO - Display: 17:47:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:47:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:47:14 INFO - Display Serial Number: 1600x1200 60 17:47:14 INFO - Main Display: Yes 17:47:14 INFO - Mirror: Off 17:47:14 INFO - Online: Yes 17:47:14 INFO - Rotation: Supported 17:47:14 INFO - Return code: 0 17:47:14 INFO - Running post-action listener: _resource_record_post_action 17:47:14 INFO - Running post-run listener: _resource_record_post_run 17:47:15 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 34004480; Write bytes: 709608448; Read time: 356; Write time: 3743 17:47:15 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 404797952; Write bytes: 406329344; Read time: 30010; Write time: 722 17:47:15 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 32189952; Write bytes: 302382080; Read time: 336; Write time: 3018 17:47:15 INFO - Running post-run listener: _upload_blobber_files 17:47:15 INFO - Blob upload gear active. 17:47:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:47:15 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:47:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:47:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:47:16 INFO - (blobuploader) - INFO - Open directory for files ... 17:47:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:47:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:47:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:47:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:47:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:47:17 INFO - (blobuploader) - INFO - Done attempting. 17:47:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:47:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:47:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:47:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:47:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:47:18 INFO - (blobuploader) - INFO - Done attempting. 17:47:18 INFO - (blobuploader) - INFO - Iteration through files over. 17:47:18 INFO - Return code: 0 17:47:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:47:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:47:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b3a4a33650476d6fcfaae0db52293e82cb78860908313dc481416fc651f80df35be966fa2d93c9da59a2b02168eeecc8a37bcca5177729314098fc640b1ce7e1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cfc32f562e439dede6551057490d85b913a6250887f49a4f905b8fb2275cca7931141c619864d057b7779fc6ff2c4bfc6d432b4697c9cd8373ae5b95ffb15707"} 17:47:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:47:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:47:18 INFO - Contents: 17:47:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b3a4a33650476d6fcfaae0db52293e82cb78860908313dc481416fc651f80df35be966fa2d93c9da59a2b02168eeecc8a37bcca5177729314098fc640b1ce7e1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cfc32f562e439dede6551057490d85b913a6250887f49a4f905b8fb2275cca7931141c619864d057b7779fc6ff2c4bfc6d432b4697c9cd8373ae5b95ffb15707"} 17:47:18 INFO - Running post-run listener: copy_logs_to_upload_dir 17:47:18 INFO - Copying logs to upload dir... 17:47:18 INFO - mkdir: /builds/slave/test/build/upload/logs 17:47:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1294.340958 ========= master_lag: 6.16 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 40 secs) (at 2016-02-19 17:47:24.424331) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-19 17:47:24.425408) ========= 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.GSd7eqlxZy/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.hXOme0ztH9/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b3a4a33650476d6fcfaae0db52293e82cb78860908313dc481416fc651f80df35be966fa2d93c9da59a2b02168eeecc8a37bcca5177729314098fc640b1ce7e1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cfc32f562e439dede6551057490d85b913a6250887f49a4f905b8fb2275cca7931141c619864d057b7779fc6ff2c4bfc6d432b4697c9cd8373ae5b95ffb15707"} build_url:https://queue.taskcluster.net/v1/task/Mz6b8TcNSx6k7HISslQkeA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011140 build_url: 'https://queue.taskcluster.net/v1/task/Mz6b8TcNSx6k7HISslQkeA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b3a4a33650476d6fcfaae0db52293e82cb78860908313dc481416fc651f80df35be966fa2d93c9da59a2b02168eeecc8a37bcca5177729314098fc640b1ce7e1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cfc32f562e439dede6551057490d85b913a6250887f49a4f905b8fb2275cca7931141c619864d057b7779fc6ff2c4bfc6d432b4697c9cd8373ae5b95ffb15707"}' ========= master_lag: 0.49 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-19 17:47:24.925995) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 17:47:24.926290) ========= 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.GSd7eqlxZy/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.hXOme0ztH9/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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.004953 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 17:47:24.951857) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-19 17:47:24.952155) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-19 17:47:24.953349) ========= ========= Total master_lag: 6.97 =========