builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0047 starttime: 1455571092.83 results: success (0) buildid: 20160215114221 builduid: 078e32efb6ec4e508300153bd57cc33f revision: a60bad5487ccea8b8102680cb92f105f9e6b16cd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-15 13:18:12.825595) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-15 13:18:12.825964) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-15 13:18:12.826295) ========= 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.R10AJ0dcGK/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.eXMI7GeK5K/Listeners TMPDIR=/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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.005679 basedir: '/builds/slave/test' ========= master_lag: 0.10 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-15 13:18:12.933570) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-15 13:18:12.933884) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-15 13:18:13.134924) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 13:18:13.135186) ========= 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.R10AJ0dcGK/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.eXMI7GeK5K/Listeners TMPDIR=/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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.005253 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 13:18:13.193511) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-15 13:18:13.193783) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-15 13:18:13.194113) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 13:18:13.198435) ========= 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.R10AJ0dcGK/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.eXMI7GeK5K/Listeners TMPDIR=/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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-15 13:18:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 43.9M=0s 2016-02-15 13:18:14 (43.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.622814 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 13:18:13.846757) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 13:18:13.847035) ========= 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.R10AJ0dcGK/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.eXMI7GeK5K/Listeners TMPDIR=/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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.019819 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 13:18:13.899188) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-15 13:18:13.902561) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a60bad5487ccea8b8102680cb92f105f9e6b16cd --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 a60bad5487ccea8b8102680cb92f105f9e6b16cd --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.R10AJ0dcGK/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.eXMI7GeK5K/Listeners TMPDIR=/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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-15 13:18:14,178 truncating revision to first 12 chars 2016-02-15 13:18:14,178 Setting DEBUG logging. 2016-02-15 13:18:14,178 attempt 1/10 2016-02-15 13:18:14,178 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a60bad5487cc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-15 13:18:15,271 unpacking tar archive at: fx-team-a60bad5487cc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.328696 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-15 13:18:15.246306) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-15 13:18:15.249675) ========= echo a60bad5487ccea8b8102680cb92f105f9e6b16cd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'a60bad5487ccea8b8102680cb92f105f9e6b16cd'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.R10AJ0dcGK/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.eXMI7GeK5K/Listeners TMPDIR=/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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 a60bad5487ccea8b8102680cb92f105f9e6b16cd program finished with exit code 0 elapsedTime=0.005352 script_repo_revision: 'a60bad5487ccea8b8102680cb92f105f9e6b16cd' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-15 13:18:15.302962) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-15 13:18:15.303237) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-15 13:18:15.324661) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-02-15 13:18:15.324958) ========= /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.R10AJ0dcGK/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.eXMI7GeK5K/Listeners TMPDIR=/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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 13:18:15 INFO - MultiFileLogger online at 20160215 13:18:15 in /builds/slave/test 13:18:15 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 13:18:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:18:15 INFO - {'append_to_log': False, 13:18:15 INFO - 'base_work_dir': '/builds/slave/test', 13:18:15 INFO - 'blob_upload_branch': 'Fx-Team', 13:18:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:18:15 INFO - 'branch': 'Fx-Team', 13:18:15 INFO - 'buildbot_json_path': 'buildprops.json', 13:18:15 INFO - 'config_files': ('talos/mac_config.py',), 13:18:15 INFO - 'default_actions': ('clobber', 13:18:15 INFO - 'read-buildbot-config', 13:18:15 INFO - 'download-and-extract', 13:18:15 INFO - 'populate-webroot', 13:18:15 INFO - 'create-virtualenv', 13:18:15 INFO - 'install', 13:18:15 INFO - 'run-tests'), 13:18:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:18:15 INFO - 'download_minidump_stackwalk': True, 13:18:15 INFO - 'download_symbols': 'ondemand', 13:18:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:18:15 INFO - 'tooltool.py': '/tools/tooltool.py', 13:18:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:18:15 INFO - '/tools/misc-python/virtualenv.py')}, 13:18:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:18:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:18:15 INFO - 'installer_path': 'installer.exe', 13:18:15 INFO - 'log_level': 'info', 13:18:15 INFO - 'log_name': 'talos', 13:18:15 INFO - 'log_to_console': True, 13:18:15 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:18:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:18:15 INFO - 'opt_config_files': (), 13:18:15 INFO - 'pip_index': False, 13:18:15 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:18:15 INFO - 'cmd': ('bash', 13:18:15 INFO - '-c', 13:18:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:18:15 INFO - 'enabled': True, 13:18:15 INFO - 'halt_on_failure': False, 13:18:15 INFO - 'name': 'check_screen_resolution'},), 13:18:15 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:18:15 INFO - 'cmd': ('bash', 13:18:15 INFO - '-c', 13:18:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:18:15 INFO - 'enabled': True, 13:18:15 INFO - 'halt_on_failure': False, 13:18:15 INFO - 'name': 'check_screen_resolution'},), 13:18:15 INFO - 'run_cmd_checks_enabled': True, 13:18:15 INFO - 'sps_profile': False, 13:18:15 INFO - 'sps_profile_interval': 0, 13:18:15 INFO - 'suite': 'dromaeojs', 13:18:15 INFO - 'system_bits': '32', 13:18:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:18:15 INFO - 'title': 't-yosemite-r7-0047', 13:18:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:18:15 INFO - 'use_talos_json': True, 13:18:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:18:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:18:15 INFO - 'work_dir': 'build'} 13:18:15 INFO - ##### 13:18:15 INFO - ##### Running clobber step. 13:18:15 INFO - ##### 13:18:15 INFO - Running pre-action listener: _resource_record_pre_action 13:18:15 INFO - Running main action method: clobber 13:18:15 INFO - rmtree: /builds/slave/test/build 13:18:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:18:17 INFO - Running post-action listener: _resource_record_post_action 13:18:17 INFO - ##### 13:18:17 INFO - ##### Running read-buildbot-config step. 13:18:17 INFO - ##### 13:18:17 INFO - Running pre-action listener: _resource_record_pre_action 13:18:17 INFO - Running main action method: read_buildbot_config 13:18:17 INFO - Using buildbot properties: 13:18:17 INFO - { 13:18:17 INFO - "project": "", 13:18:17 INFO - "product": "firefox", 13:18:17 INFO - "script_repo_revision": "production", 13:18:17 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 13:18:17 INFO - "repository": "", 13:18:17 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 13:18:17 INFO - "buildid": "20160215114221", 13:18:17 INFO - "pgo_build": "False", 13:18:17 INFO - "basedir": "/builds/slave/test", 13:18:17 INFO - "buildnumber": 356, 13:18:17 INFO - "slavename": "t-yosemite-r7-0047", 13:18:17 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 13:18:17 INFO - "platform": "yosemite_r7", 13:18:17 INFO - "scheduler": "tests-fx-team-macosx64-talos", 13:18:17 INFO - "branch": "fx-team", 13:18:17 INFO - "repo_path": "integration/fx-team", 13:18:17 INFO - "revision": "a60bad5487ccea8b8102680cb92f105f9e6b16cd", 13:18:17 INFO - "stage_platform": "macosx64", 13:18:17 INFO - "builduid": "078e32efb6ec4e508300153bd57cc33f", 13:18:17 INFO - "slavebuilddir": "test" 13:18:17 INFO - } 13:18:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/ToQcqWkSSe2tfnjSuTWARg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 13:18:17 INFO - Running post-action listener: _resource_record_post_action 13:18:17 INFO - ##### 13:18:17 INFO - ##### Running download-and-extract step. 13:18:17 INFO - ##### 13:18:17 INFO - Running pre-action listener: _resource_record_pre_action 13:18:17 INFO - Running main action method: download_and_extract 13:18:17 INFO - mkdir: /builds/slave/test/build/tests 13:18:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:18:17 INFO - https://queue.taskcluster.net/v1/task/ToQcqWkSSe2tfnjSuTWARg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 13:18:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ToQcqWkSSe2tfnjSuTWARg/artifacts/public/build/test_packages.json 13:18:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ToQcqWkSSe2tfnjSuTWARg/artifacts/public/build/test_packages.json 13:18:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ToQcqWkSSe2tfnjSuTWARg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 13:18:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ToQcqWkSSe2tfnjSuTWARg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 13:18:21 INFO - Downloaded 1277 bytes. 13:18:21 INFO - Reading from file /builds/slave/test/build/test_packages.json 13:18:21 INFO - Using the following test package requirements: 13:18:21 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 13:18:21 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 13:18:21 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 13:18:21 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 13:18:21 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 13:18:21 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 13:18:21 INFO - u'jsshell-mac.zip'], 13:18:21 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 13:18:21 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 13:18:21 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 13:18:21 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 13:18:21 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 13:18:21 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 13:18:21 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 13:18:21 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 13:18:21 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 13:18:21 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 13:18:21 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 13:18:21 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 13:18:21 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:18:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:18:21 INFO - https://queue.taskcluster.net/v1/task/ToQcqWkSSe2tfnjSuTWARg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:18:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ToQcqWkSSe2tfnjSuTWARg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 13:18:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ToQcqWkSSe2tfnjSuTWARg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 13:18:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ToQcqWkSSe2tfnjSuTWARg/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 13:18:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ToQcqWkSSe2tfnjSuTWARg/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 13:18:24 INFO - Downloaded 17758924 bytes. 13:18:24 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'] 13:18:24 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 13:18:27 INFO - Return code: 0 13:18:27 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 13:18:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:18:27 INFO - https://queue.taskcluster.net/v1/task/ToQcqWkSSe2tfnjSuTWARg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:18:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ToQcqWkSSe2tfnjSuTWARg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 13:18:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ToQcqWkSSe2tfnjSuTWARg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 13:18:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ToQcqWkSSe2tfnjSuTWARg/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 13:18:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ToQcqWkSSe2tfnjSuTWARg/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 13:18:34 INFO - Downloaded 17758924 bytes. 13:18:34 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'] 13:18:34 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 13:18:38 INFO - Return code: 0 13:18:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:18:38 INFO - https://queue.taskcluster.net/v1/task/ToQcqWkSSe2tfnjSuTWARg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 13:18:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ToQcqWkSSe2tfnjSuTWARg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 13:18:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ToQcqWkSSe2tfnjSuTWARg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 13:18:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ToQcqWkSSe2tfnjSuTWARg/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 13:18:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ToQcqWkSSe2tfnjSuTWARg/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 13:18:39 INFO - Downloaded 10707070 bytes. 13:18:39 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'] 13:18:39 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 13:18:39 INFO - Return code: 0 13:18:39 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')]} 13:18:39 INFO - https://queue.taskcluster.net/v1/task/ToQcqWkSSe2tfnjSuTWARg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 13:18:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ToQcqWkSSe2tfnjSuTWARg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 13:18:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ToQcqWkSSe2tfnjSuTWARg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 13:18:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ToQcqWkSSe2tfnjSuTWARg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 13:18:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ToQcqWkSSe2tfnjSuTWARg/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 13:18:45 INFO - Downloaded 111150950 bytes. 13:18:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ToQcqWkSSe2tfnjSuTWARg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 13:18:45 INFO - mkdir: /builds/slave/test/properties 13:18:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:18:45 INFO - Writing to file /builds/slave/test/properties/build_url 13:18:45 INFO - Contents: 13:18:45 INFO - build_url:https://queue.taskcluster.net/v1/task/ToQcqWkSSe2tfnjSuTWARg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 13:18:45 INFO - Running post-action listener: _resource_record_post_action 13:18:45 INFO - Running post-action listener: set_extra_try_arguments 13:18:45 INFO - ##### 13:18:45 INFO - ##### Running populate-webroot step. 13:18:45 INFO - ##### 13:18:45 INFO - Running pre-action listener: _resource_record_pre_action 13:18:45 INFO - Running main action method: populate_webroot 13:18:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:18:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:18:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:18:45 INFO - '--tppagecycles', 13:18:45 INFO - '7'], 13:18:45 INFO - 'tests': ['tsvgm']}}, 13:18:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:18:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:18:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:18:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 13:18:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:18:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:18:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:18:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:18:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:18:45 INFO - 'talos_options': ['--e10s'], 13:18:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:18:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:18:45 INFO - 'tests': ['damp', 'tps']}, 13:18:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:18:45 INFO - 'talos_options': ['--e10s'], 13:18:45 INFO - 'tests': ['damp', 'tps']}, 13:18:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:18:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:18:45 INFO - 'other': {'tests': ['a11yr', 13:18:45 INFO - 'ts_paint', 13:18:45 INFO - 'tpaint', 13:18:45 INFO - 'sessionrestore', 13:18:45 INFO - 'sessionrestore_no_auto_restore']}, 13:18:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:18:45 INFO - 'tests': ['a11yr', 13:18:45 INFO - 'ts_paint', 13:18:45 INFO - 'tpaint', 13:18:45 INFO - 'sessionrestore', 13:18:45 INFO - 'sessionrestore_no_auto_restore']}, 13:18:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:18:45 INFO - 'tests': ['a11yr', 13:18:45 INFO - 'ts_paint', 13:18:45 INFO - 'tpaint', 13:18:45 INFO - 'sessionrestore', 13:18:45 INFO - 'sessionrestore_no_auto_restore']}, 13:18:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:18:45 INFO - 'tests': ['a11yr', 13:18:45 INFO - 'ts_paint', 13:18:45 INFO - 'tpaint', 13:18:45 INFO - 'sessionrestore', 13:18:45 INFO - 'sessionrestore_no_auto_restore']}, 13:18:45 INFO - 'other_l64': {'tests': ['a11yr', 13:18:45 INFO - 'ts_paint', 13:18:45 INFO - 'tpaint', 13:18:45 INFO - 'sessionrestore', 13:18:45 INFO - 'sessionrestore_no_auto_restore']}, 13:18:45 INFO - 'other_nol64': {'tests': ['a11yr', 13:18:45 INFO - 'ts_paint', 13:18:45 INFO - 'tpaint', 13:18:45 INFO - 'sessionrestore', 13:18:45 INFO - 'sessionrestore_no_auto_restore']}, 13:18:45 INFO - 'svgr': {'tests': ['tsvgx', 13:18:45 INFO - 'tsvgr_opacity', 13:18:45 INFO - 'tart', 13:18:45 INFO - 'tscrollx', 13:18:45 INFO - 'cart']}, 13:18:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:18:45 INFO - 'tests': ['tsvgx', 13:18:45 INFO - 'tsvgr_opacity', 13:18:45 INFO - 'tart', 13:18:45 INFO - 'tscrollx', 13:18:45 INFO - 'cart']}, 13:18:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:18:45 INFO - 'tests': ['tp5o']}, 13:18:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:18:45 INFO - 'talos_options': ['--e10s'], 13:18:45 INFO - 'tests': ['tp5o']}, 13:18:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:18:45 INFO - 'talos_options': ['--xperf_path', 13:18:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:18:45 INFO - 'tests': ['tp5n']}, 13:18:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:18:45 INFO - 'talos_options': ['--e10s', 13:18:45 INFO - '--xperf_path', 13:18:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:18:45 INFO - 'tests': ['tp5n']}}, 13:18:45 INFO - 'talos.zip': {'path': '', 13:18:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:18:45 INFO - Running post-action listener: _resource_record_post_action 13:18:45 INFO - ##### 13:18:45 INFO - ##### Running create-virtualenv step. 13:18:45 INFO - ##### 13:18:45 INFO - Running pre-action listener: _resource_record_pre_action 13:18:45 INFO - Running main action method: create_virtualenv 13:18:45 INFO - Creating virtualenv /builds/slave/test/build/venv 13:18:45 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 13:18:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:18:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:18:45 INFO - Using real prefix '/tools/python27' 13:18:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:18:46 INFO - Installing distribute.............................................................................................................................................................................................done. 13:18:49 INFO - Installing pip.................done. 13:18:49 INFO - Return code: 0 13:18:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:18: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')]} 13:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18: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')]} 13:18:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:49 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 0x10ae5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae674c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8fb46fbd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad03d30>, '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 0x10ab27db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10acfab20>, '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.R10AJ0dcGK/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.eXMI7GeK5K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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 13:18:49 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 13:18:49 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 13:18:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.R10AJ0dcGK/Render', 13:18:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:18:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:18:49 INFO - 'HOME': '/Users/cltbld', 13:18:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:18:49 INFO - 'LOGNAME': 'cltbld', 13:18:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:49 INFO - 'MOZ_NO_REMOTE': '1', 13:18:49 INFO - 'NO_EM_RESTART': '1', 13:18:49 INFO - 'PAGER': '/bin/cat', 13:18:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:18:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:49 INFO - 'PWD': '/builds/slave/test', 13:18:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:18:49 INFO - 'SHELL': '/bin/bash', 13:18:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eXMI7GeK5K/Listeners', 13:18:49 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 13:18:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:18:49 INFO - 'USER': 'cltbld', 13:18:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:18:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:18:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:49 INFO - 'XPC_FLAGS': '0x0', 13:18:49 INFO - 'XPC_SERVICE_NAME': '0', 13:18:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:18:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:49 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 13:18:49 INFO - Cleaning up... 13:18:49 INFO - Return code: 0 13:18:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:18: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')]} 13:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18: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')]} 13:18:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:49 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 0x10ae5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae674c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8fb46fbd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad03d30>, '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 0x10ab27db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10acfab20>, '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.R10AJ0dcGK/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.eXMI7GeK5K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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 13:18:49 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 13:18:49 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 13:18:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.R10AJ0dcGK/Render', 13:18:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:18:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:18:49 INFO - 'HOME': '/Users/cltbld', 13:18:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:18:49 INFO - 'LOGNAME': 'cltbld', 13:18:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:49 INFO - 'MOZ_NO_REMOTE': '1', 13:18:49 INFO - 'NO_EM_RESTART': '1', 13:18:49 INFO - 'PAGER': '/bin/cat', 13:18:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:18:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:49 INFO - 'PWD': '/builds/slave/test', 13:18:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:18:49 INFO - 'SHELL': '/bin/bash', 13:18:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eXMI7GeK5K/Listeners', 13:18:49 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 13:18:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:18:49 INFO - 'USER': 'cltbld', 13:18:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:18:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:18:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:49 INFO - 'XPC_FLAGS': '0x0', 13:18:49 INFO - 'XPC_SERVICE_NAME': '0', 13:18:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:18:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:50 INFO - Downloading/unpacking psutil>=0.7.1 13:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:18:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:18:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:18:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:18:52 INFO - Installing collected packages: psutil 13:18:52 INFO - Running setup.py install for psutil 13:18:52 INFO - building 'psutil._psutil_osx' extension 13:18:52 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 13:18:53 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 13:18:53 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 13:18:53 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 13:18:53 INFO - building 'psutil._psutil_posix' extension 13:18:53 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 13:18:53 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:18:53 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:18:53 INFO - ^ 13:18:53 INFO - 1 warning generated. 13:18:53 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 13:18:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:18:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:18:53 INFO - Successfully installed psutil 13:18:53 INFO - Cleaning up... 13:18:53 INFO - Return code: 0 13:18:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:18:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:18:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ae5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae674c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8fb46fbd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad03d30>, '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 0x10ab27db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10acfab20>, '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.R10AJ0dcGK/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.eXMI7GeK5K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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 13:18:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 13:18:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 13:18:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.R10AJ0dcGK/Render', 13:18:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:18:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:18:53 INFO - 'HOME': '/Users/cltbld', 13:18:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:18:53 INFO - 'LOGNAME': 'cltbld', 13:18:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:53 INFO - 'MOZ_NO_REMOTE': '1', 13:18:53 INFO - 'NO_EM_RESTART': '1', 13:18:53 INFO - 'PAGER': '/bin/cat', 13:18:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:18:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:53 INFO - 'PWD': '/builds/slave/test', 13:18:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:18:53 INFO - 'SHELL': '/bin/bash', 13:18:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eXMI7GeK5K/Listeners', 13:18:53 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 13:18:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:18:53 INFO - 'USER': 'cltbld', 13:18:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:18:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:18:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:53 INFO - 'XPC_FLAGS': '0x0', 13:18:53 INFO - 'XPC_SERVICE_NAME': '0', 13:18:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:18:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:18:54 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 13:18:54 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 13:18:54 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 13:18:54 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 13:18:54 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 13:18:54 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 13:18:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:18:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:18:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:18:56 INFO - Installing collected packages: mozsystemmonitor 13:18:56 INFO - Running setup.py install for mozsystemmonitor 13:18:56 INFO - Successfully installed mozsystemmonitor 13:18:56 INFO - Cleaning up... 13:18:56 INFO - Return code: 0 13:18:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:18:56 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')]} 13:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:56 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')]} 13:18:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:56 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 0x10ae5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae674c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8fb46fbd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad03d30>, '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 0x10ab27db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10acfab20>, '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.R10AJ0dcGK/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.eXMI7GeK5K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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 13:18:56 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 13:18:56 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 13:18:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.R10AJ0dcGK/Render', 13:18:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:18:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:18:56 INFO - 'HOME': '/Users/cltbld', 13:18:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:18:56 INFO - 'LOGNAME': 'cltbld', 13:18:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:56 INFO - 'MOZ_NO_REMOTE': '1', 13:18:56 INFO - 'NO_EM_RESTART': '1', 13:18:56 INFO - 'PAGER': '/bin/cat', 13:18:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:18:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:56 INFO - 'PWD': '/builds/slave/test', 13:18:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:18:56 INFO - 'SHELL': '/bin/bash', 13:18:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eXMI7GeK5K/Listeners', 13:18:56 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 13:18:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:18:56 INFO - 'USER': 'cltbld', 13:18:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:18:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:18:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:56 INFO - 'XPC_FLAGS': '0x0', 13:18:56 INFO - 'XPC_SERVICE_NAME': '0', 13:18:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:18:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:56 INFO - Downloading/unpacking blobuploader==1.2.4 13:18: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 13:18: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 13:18: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 13:18: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 13:18: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 13:18: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 13:18:59 INFO - Downloading blobuploader-1.2.4.tar.gz 13:18:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:18:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:18:59 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 13:18:59 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 13:18:59 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 13:18:59 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 13:18:59 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 13:18:59 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 13:18:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:18:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:18:59 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 13:18:59 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 13:18:59 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 13:18:59 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 13:18:59 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 13:18:59 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 13:19:00 INFO - Downloading docopt-0.6.1.tar.gz 13:19:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:19:00 INFO - Installing collected packages: blobuploader, requests, docopt 13:19:00 INFO - Running setup.py install for blobuploader 13:19:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:19:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:19:00 INFO - Running setup.py install for requests 13:19:01 INFO - Running setup.py install for docopt 13:19:01 INFO - Successfully installed blobuploader requests docopt 13:19:01 INFO - Cleaning up... 13:19:01 INFO - Return code: 0 13:19:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:01 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 0x10ae5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae674c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8fb46fbd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad03d30>, '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 0x10ab27db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10acfab20>, '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.R10AJ0dcGK/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.eXMI7GeK5K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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 13:19:01 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 13:19:01 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 13:19:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.R10AJ0dcGK/Render', 13:19:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:19:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:19:01 INFO - 'HOME': '/Users/cltbld', 13:19:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:19:01 INFO - 'LOGNAME': 'cltbld', 13:19:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:01 INFO - 'MOZ_NO_REMOTE': '1', 13:19:01 INFO - 'NO_EM_RESTART': '1', 13:19:01 INFO - 'PAGER': '/bin/cat', 13:19:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:19:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:01 INFO - 'PWD': '/builds/slave/test', 13:19:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:19:01 INFO - 'SHELL': '/bin/bash', 13:19:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eXMI7GeK5K/Listeners', 13:19:01 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 13:19:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:19:01 INFO - 'USER': 'cltbld', 13:19:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:19:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:19:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:01 INFO - 'XPC_FLAGS': '0x0', 13:19:01 INFO - 'XPC_SERVICE_NAME': '0', 13:19:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:19:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:19:01 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-xV74HJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:19:01 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-CfCtGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:19:01 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-NrXr78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:19:01 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-lP_rAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:19:01 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-_zhdLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:19:02 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-WHPOrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:19:02 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-unvOSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:19:02 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-s6nqMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:19:02 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-zazXTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:19:02 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-hwKuHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:19:02 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-HFWPs5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:19:02 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-uyoZfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:19:02 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-TRtUUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:19:02 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-w_bT8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:19:03 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-CWh9U6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:19:03 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-Y8XGGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:19:03 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-y1XXuu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:19:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:19:03 INFO - Running setup.py install for manifestparser 13:19:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:19:03 INFO - Running setup.py install for mozcrash 13:19:03 INFO - Running setup.py install for mozdebug 13:19:03 INFO - Running setup.py install for mozdevice 13:19:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:19:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:19:03 INFO - Running setup.py install for mozfile 13:19:04 INFO - Running setup.py install for mozhttpd 13:19:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:19:04 INFO - Running setup.py install for mozinfo 13:19:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:19:04 INFO - Running setup.py install for mozInstall 13:19:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:19:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:19:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:19:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:19:04 INFO - Running setup.py install for mozleak 13:19:04 INFO - Running setup.py install for mozlog 13:19:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:19:04 INFO - Running setup.py install for moznetwork 13:19:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:19:04 INFO - Running setup.py install for mozprocess 13:19:05 INFO - Running setup.py install for mozprofile 13:19:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:19:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:19:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:19:05 INFO - Running setup.py install for mozrunner 13:19:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:19:05 INFO - Running setup.py install for mozscreenshot 13:19:05 INFO - Running setup.py install for moztest 13:19:05 INFO - Running setup.py install for mozversion 13:19:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:19:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:19:05 INFO - Cleaning up... 13:19:05 INFO - Return code: 0 13:19:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:05 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 0x10ae5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae674c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8fb46fbd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad03d30>, '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 0x10ab27db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10acfab20>, '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.R10AJ0dcGK/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.eXMI7GeK5K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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 13:19:05 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 13:19:05 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 13:19:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.R10AJ0dcGK/Render', 13:19:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:19:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:19:05 INFO - 'HOME': '/Users/cltbld', 13:19:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:19:05 INFO - 'LOGNAME': 'cltbld', 13:19:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:05 INFO - 'MOZ_NO_REMOTE': '1', 13:19:05 INFO - 'NO_EM_RESTART': '1', 13:19:05 INFO - 'PAGER': '/bin/cat', 13:19:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:19:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:05 INFO - 'PWD': '/builds/slave/test', 13:19:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:19:05 INFO - 'SHELL': '/bin/bash', 13:19:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eXMI7GeK5K/Listeners', 13:19:05 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 13:19:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:19:05 INFO - 'USER': 'cltbld', 13:19:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:19:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:19:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:05 INFO - 'XPC_FLAGS': '0x0', 13:19:05 INFO - 'XPC_SERVICE_NAME': '0', 13:19:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:19:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:19:06 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-pZbUjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:19:06 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)) 13:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:19:06 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-WWQqz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:19:06 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)) 13:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:19:06 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-r5ScMc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:19:06 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)) 13:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:19:06 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-WrD756-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:19:06 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)) 13:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:19:06 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-tb79ws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:19:06 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)) 13:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:19:06 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-8BAO03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:19:06 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)) 13:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:19:06 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-JzblJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:19:06 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)) 13:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:19:06 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-4mxmht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:19:07 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)) 13:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:19:07 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-kKPe6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:19:07 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)) 13:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:19:07 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-xzgtB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:19:07 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)) 13:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:19:07 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-ukB_kl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:19:07 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)) 13:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:19:07 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-3DTfUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:19:07 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)) 13:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:19:07 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-taBGmc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:19:07 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)) 13:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:19:07 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-EHbsc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:19:07 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)) 13:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:19:07 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-a01nBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:19:07 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)) 13:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:19:07 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-I7SfXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:19:07 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)) 13:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:19:07 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-CFOtIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:19:07 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)) 13:19:07 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)) 13:19:07 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)) 13:19:07 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)) 13:19:07 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)) 13:19:07 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)) 13:19:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:19:07 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 13:19:07 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 13:19:07 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 13:19:07 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 13:19:07 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 13:19:07 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 13:19:10 INFO - Downloading blessings-1.6.tar.gz 13:19:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:19:10 INFO - Installing collected packages: blessings 13:19:10 INFO - Running setup.py install for blessings 13:19:10 INFO - Successfully installed blessings 13:19:10 INFO - Cleaning up... 13:19:10 INFO - Return code: 0 13:19:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:19:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:19:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:19:10 INFO - Reading from file tmpfile_stdout 13:19:10 INFO - Current package versions: 13:19:10 INFO - blessings == 1.6 13:19:10 INFO - blobuploader == 1.2.4 13:19:10 INFO - docopt == 0.6.1 13:19:10 INFO - manifestparser == 1.1 13:19:10 INFO - mozInstall == 1.12 13:19:10 INFO - mozcrash == 0.16 13:19:10 INFO - mozdebug == 0.1 13:19:10 INFO - mozdevice == 0.48 13:19:10 INFO - mozfile == 1.2 13:19:10 INFO - mozhttpd == 0.7 13:19:10 INFO - mozinfo == 0.9 13:19:10 INFO - mozleak == 0.1 13:19:10 INFO - mozlog == 3.1 13:19:10 INFO - moznetwork == 0.27 13:19:10 INFO - mozprocess == 0.22 13:19:10 INFO - mozprofile == 0.28 13:19:10 INFO - mozrunner == 6.11 13:19:10 INFO - mozscreenshot == 0.1 13:19:10 INFO - mozsystemmonitor == 0.0 13:19:10 INFO - moztest == 0.7 13:19:10 INFO - mozversion == 1.4 13:19:10 INFO - psutil == 3.1.1 13:19:10 INFO - requests == 1.2.3 13:19:10 INFO - wsgiref == 0.1.2 13:19:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:19:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:10 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 0x10ae5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae674c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8fb46fbd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad03d30>, '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 0x10ab27db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10acfab20>, '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.R10AJ0dcGK/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.eXMI7GeK5K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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 13:19:10 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 13:19:10 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 13:19:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.R10AJ0dcGK/Render', 13:19:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:19:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:19:10 INFO - 'HOME': '/Users/cltbld', 13:19:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:19:10 INFO - 'LOGNAME': 'cltbld', 13:19:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:10 INFO - 'MOZ_NO_REMOTE': '1', 13:19:10 INFO - 'NO_EM_RESTART': '1', 13:19:10 INFO - 'PAGER': '/bin/cat', 13:19:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:19:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:10 INFO - 'PWD': '/builds/slave/test', 13:19:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:19:10 INFO - 'SHELL': '/bin/bash', 13:19:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eXMI7GeK5K/Listeners', 13:19:10 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 13:19:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:19:10 INFO - 'USER': 'cltbld', 13:19:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:19:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:19:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:10 INFO - 'XPC_FLAGS': '0x0', 13:19:10 INFO - 'XPC_SERVICE_NAME': '0', 13:19:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:19:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:11 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)) 13:19:11 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)) 13:19:11 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)) 13:19:11 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)) 13:19:11 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)) 13:19:11 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)) 13:19:11 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)) 13:19:11 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)) 13:19:11 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)) 13:19:11 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)) 13:19:11 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)) 13:19:11 INFO - Cleaning up... 13:19:11 INFO - Return code: 0 13:19:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:19:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:11 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 0x10ae5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae674c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8fb46fbd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad03d30>, '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 0x10ab27db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10acfab20>, '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.R10AJ0dcGK/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.eXMI7GeK5K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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 13:19:11 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 13:19:11 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 13:19:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.R10AJ0dcGK/Render', 13:19:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:19:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:19:11 INFO - 'HOME': '/Users/cltbld', 13:19:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:19:11 INFO - 'LOGNAME': 'cltbld', 13:19:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:11 INFO - 'MOZ_NO_REMOTE': '1', 13:19:11 INFO - 'NO_EM_RESTART': '1', 13:19:11 INFO - 'PAGER': '/bin/cat', 13:19:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:19:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:11 INFO - 'PWD': '/builds/slave/test', 13:19:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:19:11 INFO - 'SHELL': '/bin/bash', 13:19:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eXMI7GeK5K/Listeners', 13:19:11 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 13:19:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:19:11 INFO - 'USER': 'cltbld', 13:19:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:19:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:19:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:11 INFO - 'XPC_FLAGS': '0x0', 13:19:11 INFO - 'XPC_SERVICE_NAME': '0', 13:19:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:19:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:11 INFO - Downloading/unpacking jsonschema 13:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:19:13 INFO - Downloading/unpacking functools32 (from jsonschema) 13:19:13 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 13:19:13 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 13:19:13 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 13:19:13 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 13:19:13 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 13:19:13 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 13:19:14 INFO - Downloading functools32-3.2.3-2.tar.gz 13:19:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:19:14 INFO - warning: no files found matching '*.txt' 13:19:14 INFO - no previously-included directories found matching 'build' 13:19:14 INFO - no previously-included directories found matching 'dist' 13:19:14 INFO - no previously-included directories found matching '.git*' 13:19:14 INFO - Installing collected packages: jsonschema, functools32 13:19:14 INFO - Running setup.py install for functools32 13:19:14 INFO - warning: no files found matching '*.txt' 13:19:14 INFO - no previously-included directories found matching 'build' 13:19:14 INFO - no previously-included directories found matching 'dist' 13:19:14 INFO - no previously-included directories found matching '.git*' 13:19:14 INFO - Successfully installed jsonschema functools32 13:19:14 INFO - Cleaning up... 13:19:14 INFO - Return code: 0 13:19:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:19:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ae5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae674c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8fb46fbd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad03d30>, '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 0x10ab27db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10acfab20>, '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.R10AJ0dcGK/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.eXMI7GeK5K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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 13:19:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 13:19:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 13:19:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.R10AJ0dcGK/Render', 13:19:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:19:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:19:14 INFO - 'HOME': '/Users/cltbld', 13:19:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:19:14 INFO - 'LOGNAME': 'cltbld', 13:19:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:14 INFO - 'MOZ_NO_REMOTE': '1', 13:19:14 INFO - 'NO_EM_RESTART': '1', 13:19:14 INFO - 'PAGER': '/bin/cat', 13:19:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:19:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:14 INFO - 'PWD': '/builds/slave/test', 13:19:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:19:14 INFO - 'SHELL': '/bin/bash', 13:19:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eXMI7GeK5K/Listeners', 13:19:14 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 13:19:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:19:14 INFO - 'USER': 'cltbld', 13:19:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:19:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:19:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:14 INFO - 'XPC_FLAGS': '0x0', 13:19:14 INFO - 'XPC_SERVICE_NAME': '0', 13:19:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:19:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:19:14 INFO - Downloading/unpacking flake8 13:19:14 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 13:19:14 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 13:19:14 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 13:19:14 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 13:19:14 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 13:19:14 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 13:19:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:19:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:19:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:19:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:19:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:19:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:19:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:19:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:19:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:19:18 INFO - no previously-included directories found matching 'docs/_build' 13:19:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:19:18 INFO - Running setup.py install for pep8 13:19:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:19:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:19:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:19:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:19:18 INFO - no previously-included directories found matching 'docs/_build' 13:19:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:19:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:19:18 INFO - Cleaning up... 13:19:18 INFO - Return code: 0 13:19:18 INFO - Running post-action listener: _resource_record_post_action 13:19:18 INFO - Running post-action listener: _start_resource_monitoring 13:19:18 INFO - Starting resource monitoring. 13:19:18 INFO - ##### 13:19:18 INFO - ##### Running install step. 13:19:18 INFO - ##### 13:19:18 INFO - Running pre-action listener: _resource_record_pre_action 13:19:18 INFO - Running main action method: install 13:19:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:19:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:19:18 INFO - Reading from file tmpfile_stdout 13:19:18 INFO - Detecting whether we're running mozinstall >=1.0... 13:19:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:19:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:19:19 INFO - Reading from file tmpfile_stdout 13:19:19 INFO - Output received: 13:19:19 INFO - Usage: mozinstall [options] installer 13:19:19 INFO - Options: 13:19:19 INFO - -h, --help show this help message and exit 13:19:19 INFO - -d DEST, --destination=DEST 13:19:19 INFO - Directory to install application into. [default: 13:19:19 INFO - "/builds/slave/test"] 13:19:19 INFO - --app=APP Application being installed. [default: firefox] 13:19:19 INFO - mkdir: /builds/slave/test/build/application 13:19:19 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'] 13:19:19 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 13:19:52 INFO - Reading from file tmpfile_stdout 13:19:52 INFO - Output received: 13:19:52 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:19:52 INFO - Running post-action listener: _resource_record_post_action 13:19:52 INFO - ##### 13:19:52 INFO - ##### Running run-tests step. 13:19:52 INFO - ##### 13:19:52 INFO - Running pre-action listener: _resource_record_pre_action 13:19:52 INFO - Running main action method: run_tests 13:19:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:19:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:19:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:19:52 INFO - 2016-02-15 13:19:52.534 screenresolution[2240:23645] starting screenresolution argv=screenresolution get 13:19:52 INFO - 2016-02-15 13:19:52.536 screenresolution[2240:23645] Display 0: 1600x1200x32@60 13:19:52 INFO - 2016-02-15 13:19:52.543 screenresolution[2241:23647] starting screenresolution argv=screenresolution list 13:19:52 INFO - Available Modes on Display 0 13:19:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:19:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:19:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:19:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:19:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:19:52 INFO - Intel Iris: 13:19:52 INFO - Chipset Model: Intel Iris 13:19:52 INFO - Type: GPU 13:19:52 INFO - Bus: Built-In 13:19:52 INFO - VRAM (Dynamic, Max): 1536 MB 13:19:52 INFO - Vendor: Intel (0x8086) 13:19:52 INFO - Device ID: 0x0a2e 13:19:52 INFO - Revision ID: 0x0009 13:19:52 INFO - Displays: 13:19:52 INFO - Display: 13:19:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:19:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:19:52 INFO - Display Serial Number: 1600x1200 60 13:19:52 INFO - Main Display: Yes 13:19:52 INFO - Mirror: Off 13:19:52 INFO - Online: Yes 13:19:52 INFO - Rotation: Supported 13:19:52 INFO - Return code: 0 13:19:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:19:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:19:52 INFO - Python 2.7.3 13:19:52 INFO - Return code: 0 13:19:52 INFO - grabbing minidump binary from tooltool 13:19:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:52 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 0x10ad03d30>, '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 0x10ab27db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10acfab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:19:52 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 13:19:52 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 13:19:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:19:52 INFO - Return code: 0 13:19:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:19:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:19:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:19:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:19:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:19:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:19:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:19:54 INFO - Return code: 0 13:19:54 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/ToQcqWkSSe2tfnjSuTWARg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0047', '--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 13:19:54 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/ToQcqWkSSe2tfnjSuTWARg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0047 --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 13:19:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.R10AJ0dcGK/Render', 13:19:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:19:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:19:54 INFO - 'HOME': '/Users/cltbld', 13:19:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:19:54 INFO - 'LOGNAME': 'cltbld', 13:19:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:19:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:19:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:54 INFO - 'MOZ_NO_REMOTE': '1', 13:19:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:19:54 INFO - 'NO_EM_RESTART': '1', 13:19:54 INFO - 'PAGER': '/bin/cat', 13:19:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:19:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:54 INFO - 'PWD': '/builds/slave/test', 13:19:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:19:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:19:54 INFO - 'SHELL': '/bin/bash', 13:19:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eXMI7GeK5K/Listeners', 13:19:54 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 13:19:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:19:54 INFO - 'USER': 'cltbld', 13:19:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:19:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:19:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:54 INFO - 'XPC_FLAGS': '0x0', 13:19:54 INFO - 'XPC_SERVICE_NAME': '0', 13:19:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:19:54 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/ToQcqWkSSe2tfnjSuTWARg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0047', '--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 13:19:54 INFO - mozversion application_buildid: 20160215114221 13:19:54 INFO - mozversion application_changeset: a60bad5487ccea8b8102680cb92f105f9e6b16cd 13:19:54 INFO - mozversion application_display_name: Nightly 13:19:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:19:54 INFO - mozversion application_name: Firefox 13:19:54 INFO - mozversion application_remotingname: firefox 13:19:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:19:54 INFO - mozversion application_vendor: Mozilla 13:19:54 INFO - mozversion application_version: 47.0a1 13:19:54 INFO - mozversion platform_buildid: 20160215114221 13:19:54 INFO - mozversion platform_changeset: a60bad5487ccea8b8102680cb92f105f9e6b16cd 13:19:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:19:54 INFO - mozversion platform_version: 47.0a1 13:19:54 INFO - using testdate: 1455571194 13:19:54 INFO - actual date: 1455571194 13:19:54 INFO - starting webserver on 'localhost:57678' 13:19:54 INFO - SUITE-START | Running 2 tests 13:19:54 INFO - TEST-START | dromaeo_css 13:19:54 INFO - operating with platform_type : mac_ 13:19:54 INFO - Initialising browser for dromaeo_css test... 13:19:54 INFO - TEST-INFO | started process 2259 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/tmpHzCQt8/profile http://localhost:57678/getInfo.html) 13:19:57 INFO - PROCESS | 2259 | __metrics Screen width/height:1600/1200 13:19:57 INFO - PROCESS | 2259 | colorDepth:24 13:19:57 INFO - PROCESS | 2259 | Browser inner width/height: 1024/689 13:19:57 INFO - PROCESS | 2259 | __metrics 13:19:57 INFO - PROCESS | 2259 | 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" 13:19:57 INFO - PROCESS | 2259 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:19:57 INFO - TEST-INFO | 2259: exit 0 13:19:57 INFO - Browser initialized. 13:19:57 INFO - Running cycle 1/1 for dromaeo_css test... 13:19:57 INFO - TEST-INFO | started process 2263 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/tmpHzCQt8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:20:09 INFO - PROCESS | 2263 | RSS: Main: 246317056 13:20:09 INFO - PROCESS | 2263 | 13:21:00 INFO - PROCESS | 2263 | 1455571260983 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] 13:23:11 INFO - PROCESS | 2263 | Cycle 1(1): loaded http://localhost:57678/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57678/tests/dromaeo/cssquery-ext.html) 13:23:13 INFO - PROCESS | 2263 | RSS: Main: 433008640 13:23:13 INFO - PROCESS | 2263 | 13:26:16 INFO - PROCESS | 2263 | Cycle 1(1): loaded http://localhost:57678/tests/dromaeo/cssquery-ext.html (next: http://localhost:57678/tests/dromaeo/cssquery-jquery.html) 13:26:16 INFO - PROCESS | 2263 | RSS: Main: 382164992 13:26:16 INFO - PROCESS | 2263 | 13:29:18 INFO - PROCESS | 2263 | Cycle 1(1): loaded http://localhost:57678/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57678/tests/dromaeo/cssquery-mootools.html) 13:29:19 INFO - PROCESS | 2263 | RSS: Main: 376512512 13:29:19 INFO - PROCESS | 2263 | 13:32:21 INFO - PROCESS | 2263 | Cycle 1(1): loaded http://localhost:57678/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57678/tests/dromaeo/cssquery-prototype.html) 13:32:22 INFO - PROCESS | 2263 | RSS: Main: 369479680 13:32:22 INFO - PROCESS | 2263 | 13:35:25 INFO - PROCESS | 2263 | Cycle 1(1): loaded http://localhost:57678/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57678/tests/dromaeo/cssquery-yui.html) 13:35:25 INFO - PROCESS | 2263 | RSS: Main: 338374656 13:35:25 INFO - PROCESS | 2263 | 13:38:28 INFO - PROCESS | 2263 | Cycle 1(1): loaded http://localhost:57678/tests/dromaeo/cssquery-yui.html (next: http://localhost:57678/tests/dromaeo/cssquery-dojo.html) 13:38:29 INFO - PROCESS | 2263 | RSS: Main: 381497344 13:38:29 INFO - PROCESS | 2263 | 13:38:29 INFO - PROCESS | 2263 | __start_tp_report 13:38:29 INFO - PROCESS | 2263 | _x_x_mozilla_page_load 13:38:29 INFO - PROCESS | 2263 | _x_x_mozilla_page_load_details 13:38:29 INFO - PROCESS | 2263 | |i|pagename|runs| 13:38:29 INFO - PROCESS | 2263 | |0;dojo.html;3352.580927384077;3390.779599326042;3411.3518431498023;3426.16059065529;3464.411050121479;5583.246261754662;5602.46776556227;5609.411011843759;5661.122526008465;5682.119271512912;4691.920858202616;5652.236948012017;5697.088465845465;5822.4177582241755;5825.330087039992;4190.53904070552;5053.963937392826;5080.669756465836;5135.947130838169;5232.005918875401;4365.279728844736;5213.869653258661;5218.0607490651855;5278.604104692145;5289.233061206123;4150.667946564267;5129.333186685744;5171.482851714836;5185.792568297264;5260.263563101169;4216.536181020086;5193.143131383317;5222.791088356461;5230.320058392384;5268.446813084609;5128.820491282787;5146.8198613048735;5159.613029022801;5177.8187763428095;5180.6373553851245;5394.271773310592;5539.25220095286;5547.389787123413;5625.831225063254;5665.943340566583;6174.691265436711;6176.907346389808;6195.16365290689;6201.81394558164;6204.9689751551405;5340.866478338073;6104.2980057293535;6241.78153764616;6261.154744109578;6261.87476250477;4801.567858892717;5708.942910570882;5741.569382296303;5784.652920824764;5864.413558644187;6244.531660125509;6254.468370188585;6268.937310626835;6273.309935907047;6283.183186185766;5993.340732519419;6031.306399763996;6133.29467111279;6139.416755408319;6147.508199344042;6135.355158799479;6158.261008678987;6210.627362358183;6223.533235007392;6230.6573138476915;6112;6150.569460137837;6156.322804491502;6170.50635949123;6186.783462578788;6074.240719910012;6144.586745048664;6153.015517517265;6182.196314479089;6209.223847019122;4823.927641085386;4866.343043689057;4883.877903052452;4894.363732714724;4894.657373983858;4350.543192964693;4376.299792033323;4393.033532622818;4435.711678740871;4439.289713645866;5520.089185284383;5555.666660000413;5610.747516361774;5621.550275977912;5651.547876169979;6124.448799607968;6130;6185.350538193515;6207.441330280206;6222.533310001678;5566.693831839207;5599.664020158803;5601.551875849922;5604.8038318658655;5606.187102870143;5318.149096144598;5319.9202011969855;5323.2015197719875;5323.86690332737;5324.4675532446445;5208.635395522277;6190.41191086846;6241.625502469867;6248.218972628421;6255.718492667841;6175.752969881154;6225.968870155621;6258.468030217483;6264.561480696308;6269.028300613412;6279.340669229848;6304.684765761602;6306.495480361652;6317.147185130132;6335.429811317003;6022;6145.72344244519;6145.938540614537;6177.351378105414;6186.628802271698;6129.603311142764;6151.507879369729;6164.291106522807;6165.815025549241;6221.906671400023;6096.207493025879;6103.908441373472;6105.945000794801;6122.265328160649;6138.891802656385;4936.777844996912;6062.211912451353;6097.252466529944;6111.105587097722;6122.489639783254;5862.12068189775;5865.354810970875;5883.2057672213705;5888.411158884077;5891.852703682443;5989.700514974146;6015.616408226045;6019.0369540875;6050.727717252822;6061.7575296987625;5924.970375148269;5930.495907847709;5952.702364881825;5985.940140598713;6043.486303664238 13:38:29 INFO - PROCESS | 2263 | |1;ext.html;447.84325486079877;511.3071787727629;536.5224949794681;556.9916451253231;570.7431655754908;24346.87826560869;28919.397254247113;30779.23051923703;30797.538036929436;30830.7667693292;31909.840450797714;32669.019929402097;39565.406518902164;40139.39790903139;40370.596294037125;9659.806803863936;9853.310268281188;9866.309358344883;9867.555959981819;9874.308798384116;9638.469884156368;9811.607535698564;9812.509374531244;9813.90186098137;9817.95091024544;9754.0733630305;9827.017298270152;9849.65526206583;9858.211343092535;9866.753331166707;9697.95151024244;9798.65704700332;9800.019998000214;9806.411615303105;9810.264230182693;8344.582770861432;9530.666426675103;9638.90361096394;9665.27510436713;9674.70975870725;38529;39439.40840887389;39478.802605986784;39483;39562.60437395618;3168.8415579221178;3218.034589623127;3591.281743651254;3698.204885949534;4001.3997900314894;29115.854420727974;29448.67480963362;29531.704682953325;29593.964211252718;29676.10971670853;2756.3522572195516;2774.750272475487;2877.7266159714795;2998.3703422281346;3008.413359394897;457015;457809;458245;458889.5832812519;492531;45399.54600453953;45456.86357841014;45484;45570.772146139054;45710.08579828451;67204.32795672078;68168.6591567039;68524.3147568528;68573.31426685769;68704.3129568708;16220.594485137966;16250.431234906722;16447.177641117898;16483.83516164847;16491.17544122789;12598.55905043319;12685.429155688016;12697.492100315883;12703.047271454678;12723.172993755376;17946.91026544859;18241.817581824278;18291;18304.725429118575;19571.412857614294;8420.4947703138;8744.606492707844;8831.823363532694;8890.73327800167;8970.506622135714;861.0055386029146;890.617034675083;909.4588719711761;940.7836197674436;993.8558908958161;26623.600645990326;26890.5966410504;27186;27263.045793397137;27424.862875685893;1082.5832054658856;1128.9435528223555;1141.4121727310442;1165.3299352872132;1190.863050749175;12881.549145779853;13983.79024314636;14251.714965700628;15755;16271.593210169603;500252;507497;509770;510730;512149;57262.7136864313;57697;57732.4226757727;57767.8446431069;58015.41984580184;1140.8534422904927;1277.3421687830776;1439.172475826383;1457.9125252484885;1474.4765608209361;28026.738796754602;28455.430891381642;29071.563926540697;29159.562606560496;29253.85373073121;48285;57660.1350979744;58557;58634.42972917566;58764.412355877605;316004;492302;494346;496172;496680;30607.54088688716;30652.693473064985;30907.536386954664;30935.69064309418;30981.070567882998;44191.55808442003;44805.55194448144;44992.65022049344;45496.77251613721;46268;37174.814125929195;37458.812705936296;38183;38378.61621383751;38477;34749.47875781815;36504.72233471816;37199.81400092982;37320.06699832526;37686.81156594199;36899.44650830186;37619.811900941415;37782.2443551133;38007.66973155926;38054.619453805106;22941.655875161552;31568.36863262676;31646.208844778143;31707;31777.68222317747;23878.88060559686;24189.79051047476;24216.636750448404;24230.87884560566;24434.26697199087 13:38:29 INFO - PROCESS | 2263 | |2;jquery.html;369.40156945747884;372.61620530853213;374.7732621763832;375.0417682820393;379.1752937361242;15517.275853795092;15858.920705396486;18598.442046738586;18819.153138108803;20482.89758551205;11571.479283432245;11917.284962902231;11930.522779088826;20124.59750804987;20661.793382066175;3221.2269055426764;5133.666311689728;5310.256564081032;5316.441773613754;5324.068288049576;4066.1054567994993;7337.816554586125;7629.80925476862;7644.6559904804135;7649.464537482379;7387.852242955138;7507.512011719221;7612.809679757995;7624.885626715603;7701.922980770177;7292.562446253241;7560.584167870765;7597.658105385271;7597.924020759777;7616.847663046736;6961.129858767654;7151.606661633608;7158.821029474253;7165.534240274365;7244.565326080452;19528;26569.601455978176;26632.341685966192;27437.725622743917;27718.445631087267;2065.390709740615;2090.9477263068393;2211.7677643847487;2354.7292061412986;2416.7220769611367;11627.59303424376;14732.263386830615;15470.226488675522;15752.68494630101;16031.599210019844;1841.4659748672868;1881.9341323053764;1885.4720678210124;1909.255390397746;2066.5350296183237;95186;102251;102826;103841;105146.94853051448;14510.419583216764;15077.924610376878;18766;19324.42026739172;19334.80665193358;12222.20555663879;28262;28272.575911361346;28423.28941776472;28529.144125676263;8207.097219305871;8408.621612027473;8413.45312554682;8459.873101903477;8515.403921725543;8649.870251946226;8665.566721664018;8707.12928707137;8734.86897696535;8754.86867696985;4093.2222877653153;4211.178820130107;4217;4223.13425747721;4225.3873188387515;1586.7461206207183;1836.8007973090819;1838.5212068037324;1839.642652159787;1850.4726153046317;899.869518919753;927.5315965437546;966.2511553545918;984.6701355045997;1053.1890444357955;20013.799862001484;20755.273565425137;21160.576788464143;21415.46461338448;21525.46186345354;894.3024440936081;941.5339406993583;981.3375971219398;1035.0787798859021;1038.9428581427942;10847.349159050482;11008.73399559045;11160.497777600027;11282.605108821315;11455.255408398427;716815;721236.3629091135;731994;737389;739294;109152.4542377299;115106.84893151128;115986.4200679008;116521.4173929125;117762;1135.784201001807;1170.30951738473;1183.2841131115551;1192.7316353820322;1196.0371900620084;15595.922020389826;17960.730589041435;18293.17680704398;18332.633347333245;18386.540336491697;46291.305630416246;46942.76528617335;47142.29286560636;47735;48111;68870.31129688639;72525;73646.26353736394;73969;74418;6160.845978850564;6389.9361006389345;7693.884591731016;7806;7848.9215107848195;9303.860442093239;10741.838872417076;11743.882561174622;12084.274943503418;12114.377688799803;6506.339574175763;9758.219342452729;10054.396736195558;10520.736981575521;10625;9884.851727223953;10362;10447;10629.690373241701;10963.56145754161;10734.302270352402;10906.945465272624;10937.56249750001;10950.890491094988;11100.833487497855;7685.193054729173;7836.804079898048;7844.607769611611;7848.882266765889;7879.881801772864;9314.72055838326;10842.349459032483;10957.780844383227;10984.835227471434;11034.668959931216 13:38:29 INFO - PROCESS | 2263 | |3;mootools.html;1394.9372278247479;1510.9773353399698;1536.8155821301445;1759.4985429152694;1923.1730355946945;8026.558539280337;8745.038045814963;8939.642414303436;8968.775780605489;8974.012858585551;8599.871001934976;8910.95544522278;8916.108389161096;8917.286617070635;8932.106789321064;2215.2246713650256;2268.886555672218;2272.9772702273012;2511.3972646564785;2538.0228611984426;2291.2667946257206;2294.6443301288327;2498.0757119865584;2548.2227920484247;2562.6284188792615;2446.645236440715;2500.4499010217814;2509.560826855293;2512.648229247907;2539.1240022192405;2449.2407353720405;2503.0738626708235;2503.949921001579;2505.987470062656;2512.170983575416;2478.913238036678;2485.9875700621383;2487.502499500107;2490.7882829959476;2491.825572209946;8945.776355591097;9027.277817774562;9037.864432033524;9040.68357607487;9040.954795226047;5499.202615620753;5676.971615141898;5680.488756011938;5687.40282270364;5697.4587414195585;3654.14127679995;3695.981520092382;3807.505024346817;3824.598417166213;3832.0994566276904;1068.3216157739892;1069.35838496902;1100.8458815765798;1112.6995711158022;1115.1580556679655;12290.569830055905;12308.384580770926;12312.199707019015;12341.69145771354;12342.629721108291;4958.107540642719;4999.875003124878;5014.52362025607;5043.722595257296;5094.617903657167;10389.220808439397;10416.427096509613;10419.687409377731;10422.635207767691;10429.9478502607;5594.664320140804;5643.181738647955;5651.378348381675;5652.434756524397;5666.235058267163;5085.186370180753;5121.334226550524;5125.564327032244;5125.794968201305;5132.204508301144;3722.2555488902326;3995.5405128410025;4036.1725846201457;4038.273110840018;4098.344264917599;1233;1304.2044352944697;1310.5151094095245;1321.6497628128554;1326.197650421481;1305.288617703354;1307.7123032932739;1309.0901823232762;1325.0923117664238;1351.2095424176966;6750.932490675031;8084.231997960184;8106;8166.877496837552;8217.178282171855;1168.6026750904732;1180.3272134883034;1181.3030312115893;1184.4492311075392;1189.7204157023093;6232.937670623326;6322.0200868865395;6327.841803954938;6328;6331.556791024584;8881.200691937627;10607.681769546925;10896.836547451636;10968.17738669603;10993.450327483593;10352.223583231287;10834.566617335377;10848.294860834021;10854.891451085547;10868.184886133413;8285.212904774158;8428.915710842935;8508.489490630705;8521.744347669579;8531.74404767858;6644.302348253364;8027.719029833927;8227.259546640831;8275.83448331018;8287.337013039063;9554.989451896823;9729.951350243204;9750.414975101517;9841.311108222355;9861.408315501092;8391.741238814227;9094.181523662903;9525.666406702929;10006.44964526958;10162.542685579314;6757.256701762703;7532.435067370079;7585.544867307979;7610.391168706379;7614.543127412373;7412.147603025721;8237.83524329522;8302;8302.128276530877;8302.335813134814;6913.827154321182;7782.2217778223985;7791.337736292478;7792.844143116992;7969;7542.698292068256;7648;7676.53940763556;7685.730999414994;7792.883106753517;7990.440669153103;8059.717909873127;8067.798305042186;8075.959620201861;8109.635066422144;7166.462515311268;7211.747588834365;7237;7254.927450725425;7266.600336981517;7326.926730732837;7383.926160738324;7392.223816499405;7395;7424.257574242532 13:38:29 INFO - PROCESS | 2263 | |4;prototype.html;319.4218464579111;324.4662530137925;325.2162288883789;328.5580893697977;332.81362437035256;5353.812616558426;6522.85849976254;6563.278039415661;6675.7663481778145;6696.966515167417;6230.9095908215995;6382.297947225801;6442.838929026777;6541.803745887619;6619.271880093186;4828.73441960692;4870.245112007645;4892.094962431953;4908.558229759321;4915.705057696549;4690.624750019991;4901.65688401812;4903.436104847935;4906.779194936219;4908.460069392364;4737.952620473803;4753.714777113367;4812.10975969445;4815.7110573365535;4816.97591512042;4745.240761478147;4797.952020479803;4808.787957539518;4812.133815913135;4827.25177597473;4111.876643700693;4122.670186385082;4127.855525056639;4128.91742165158;4142.855000075013;6184.690765461709;6327.5570710050315;6371.39471750183;6390;6408.51936104794;5794.913076303858;5805.564582656318;5819.185314056035;5827.300723913115;5833.4749872511675;7057.258987806258;7060.129065797568;7061.646917654148;7064.258252883425;7066.222715501291;4095.201435720036;4703.811847526094;4706.434992928862;4719.268513380432;4722;7092.751753688596;7348.154962179311;7362.5950572718475;7364.668589913466;7441.995330630404;4593.54064593538;4630.6063984561015;4634.652401069866;4640.559146881041;4646.256598944153;4698.013417182362;4704.600108990706;4706.835260765857;4712.198926182557;4716.033213191287;5450.482204190675;5605.299337582802;5612;5642.548596112301;5645.802396916089;7077.398421134261;7082.964585177144;7087.220405755363;7093.538919970186;7100.68046937889;1614.0799744145959;1635.8445947634955;1639.2131776747228;1639.8934069285458;1640.3848556791204;1025.6922923123034;1034.632705389576;1042.1975079188983;1050.7110544600296;1054.984175237372;6421.197350331208;6467.288598254188;6605.966970165215;6647.202335719648;6661.933380666228;7148.678309476086;7337.88993165103;7339;7345.338919497271;7346.52247603904;5568.415316391721;5971.775785963867;6589.945608702585;6676.332366763285;6723.5293529452465;3880.6895448364626;3928.489296391451;3932.4494570760116;3932.488776459042;3938.291107600602;7450.925490745023;7736.458447908705;7736.92263077362;7753.147153813189;7772.844543109106;7654.158042615308;7662.923370766221;7665.961670191613;7671.693132274758;7672.808179795438;7710.306072453506;7712.190220026929;7713.575753333621;7718.652660630285;7737.458377913492;5647.971760141173;7299.489035767658;7333.889991650236;7419.629018549159;7420.40636749048;6449.645269510222;6810.353016463428;7269.200387957426;7282.089738782653;7286.16209135935;7443;7714.15144334134;7718.189590092959;7724.575148366894;7725.768226953201;4619.491855895916;4655.906881862276;4673.252279635242;4674.368960190467;4677.368555244999;7362.6686799093095;7365.243725699825;7379.262073792578;7383.15093764224;7384.409247260313;6907.723691052302;7133.464990125657;7162.283771622796;7169.820754481179;7196.748113815991;7152.284771523015;7153.928460715326;7156.427485801019;7159.534630249017;7161.85676286461;6995.370416662525;7000.404965577983;7000.50996430245;7007.054047703495;7014.228434872262;6149.661768602769;6798.966005169942;6864.450843932574;7141.964290178724;7142.857142857218;5147.510986456281;6247.96876015617;6584.868302633825;7002;7010.47421443404 13:38:29 INFO - PROCESS | 2263 | |5;yui.html;613.6532858934704;626.83388901941;735.4814855526851;736.6869080640728;789.5578476053411;14348;15220.847791522081;15222.847771522282;15224.23878806058;15254.542363729079;13109.868901311007;13717;13774.517891873786;13788.724225515483;13789.172649641028;859.3511898516626;883.3242569434387;888.103015953888;888.2760550151638;888.506878682331;867.5011868175824;874.0909454167657;877.385829919056;877.7673916412124;879.2921698033081;916.0427353415663;917.9311551633621;919.2002957427014;920.1534588178858;922.6586163119622;899.9550022498881;906.6600024990629;908.62746274028;908.8545832666774;913.968011119611;683.9842833392408;684.6234570985938;685.4858855858106;689.2108535726564;689.2521614048763;12942.223466592035;12955.48178072876;13088;13287.335633218301;13310.866891331156;11462.426878656033;11481.88518114825;11499.942500287529;11570.652880413601;11686.047663384754;9489.952550237274;9581.185599224005;9604.375715578535;9694.612215511372;10245.48772561369;3400.2009527760956;3446.7931924084637;3461.6192218855904;3468.1849765305133;3469.3928562501715;56085.33867341892;75724;77510.22489775087;78460.82308765373;80187.5990620049;9478.146966772885;9535.332526723201;9535.61857525705;9612.423254604746;10076.49617519121;20657.586848262952;20665.966701664856;20674.75951442918;20681.379558613266;20690.896545517477;7046.612436316052;7602.973598564234;7871;7965.761027169194;7965.800854978672;3953.387224980075;4043.8786836394956;4073.9592604073578;4095.5494895561465;4113.1568028554075;3578.4095624221713;3623.58328792187;3633.8728144514816;3636;3637.1452708613456;640.3724350136799;644.9516286278548;646.4311405962817;654.0744846042796;662.5991275278484;509.9056674515227;547.4761350175687;556.6409665765558;598.2043881637412;625.4308579192913;8246.793830154174;8265.173482651686;8421;8602.483850968962;8897.288216942628;456.98400555981044;545.1033050631688;566.8271177290883;604.851811306224;614.797116951405;3971.0866500704424;4069.1251380952644;4102.753834769924;4115.218108559364;4201.558836322142;88198;89703.55148224217;99351.50324248332;99688;99829;60660.78678426495;78372.60813695895;78597;78862.21137788548;79298;59270.407295927354;65831;65898.67050664812;68967.31006694071;69531;8690.261327786957;9011.23404510624;9027.187553120251;9036.954815226145;9049.366544341832;47688;48154.75922620364;48472.757636211594;49028.26457603068;49979.75010124926;60205.69897150486;68368.97446538406;68652;69419.26451838744;72189;10761.784764304513;10778.514966826355;10955.34267943926;11141.88858111441;11732.178747487935;11807.173497855068;11903.172119629753;12186.939065304618;12431.564895228623;12695.492180312684;11670.474828632561;11740.178187526792;11747.353895535827;11822.640396354529;11891.940540297242;11243.85171655586;11303.776552328296;11761.705957351134;11795.056395488169;11929.164958452826;11122.499487523242;11299.209055366046;11673.474693638977;11729.941350293195;11873.940630296793;9342.813143736952;9376.437413755197;9623.56693948788;9666.75833104178;9679.366615613957;9558.330916836034;9939.155171810477;10029.348092373972;10057.748556286151;10068.04353586408 13:38:29 INFO - PROCESS | 2263 | __end_tp_report 13:38:29 INFO - PROCESS | 2263 | __start_cc_report 13:38:29 INFO - PROCESS | 2263 | _x_x_mozilla_cycle_collect,1684 13:38:29 INFO - PROCESS | 2263 | __end_cc_report 13:38:29 INFO - PROCESS | 2263 | __startTimestamp1455572309184__endTimestamp 13:38:29 INFO - PROCESS | 2263 | 13:38:29 INFO - PROCESS | 2263 | ------- Summary: start ------- 13:38:29 INFO - PROCESS | 2263 | Number of tests: 6 13:38:29 INFO - PROCESS | 2263 | 13:38:29 INFO - PROCESS | 2263 | [#0] dojo.html Cycles:165 Average:5656.29 Median:5891.85 stddev:672.14 (11.4%) stddev-sans-first:649.45 13:38:29 INFO - PROCESS | 2263 | Values: 3352.6 3390.8 3411.4 3426.2 3464.4 5583.2 5602.5 5609.4 5661.1 5682.1 4691.9 5652.2 5697.1 5822.4 5825.3 4190.5 5054.0 5080.7 5135.9 5232.0 4365.3 5213.9 5218.1 5278.6 5289.2 4150.7 5129.3 5171.5 5185.8 5260.3 4216.5 5193.1 5222.8 5230.3 5268.4 5128.8 5146.8 5159.6 5177.8 5180.6 5394.3 5539.3 5547.4 5625.8 5665.9 6174.7 6176.9 6195.2 6201.8 6205.0 5340.9 6104.3 6241.8 6261.2 6261.9 4801.6 5708.9 5741.6 5784.7 5864.4 6244.5 6254.5 6268.9 6273.3 6283.2 5993.3 6031.3 6133.3 6139.4 6147.5 6135.4 6158.3 6210.6 6223.5 6230.7 6112.0 6150.6 6156.3 6170.5 6186.8 6074.2 6144.6 6153.0 6182.2 6209.2 4823.9 4866.3 4883.9 4894.4 4894.7 4350.5 4376.3 4393.0 4435.7 4439.3 5520.1 5555.7 5610.7 5621.6 5651.5 6124.4 6130.0 6185.4 6207.4 6222.5 5566.7 5599.7 5601.6 5604.8 5606.2 5318.1 5319.9 5323.2 5323.9 5324.5 5208.6 6190.4 6241.6 6248.2 6255.7 6175.8 6226.0 6258.5 6264.6 6269.0 6279.3 6304.7 6306.5 6317.1 6335.4 6022.0 6145.7 6145.9 6177.4 6186.6 6129.6 6151.5 6164.3 6165.8 6221.9 6096.2 6103.9 6105.9 6122.3 6138.9 4936.8 6062.2 6097.3 6111.1 6122.5 5862.1 5865.4 5883.2 5888.4 5891.9 5989.7 6015.6 6019.0 6050.7 6061.8 5925.0 5930.5 5952.7 5985.9 6043.5 13:38:29 INFO - PROCESS | 2263 | 13:38:29 INFO - PROCESS | 2263 | [#1] ext.html Cycles:180 Average:61746.90 Median:38427.81 stddev:127594.13 (332.0%) stddev-sans-first:127869.06 13:38:29 INFO - PROCESS | 2263 | Values: 447.8 511.3 536.5 557.0 570.7 24346.9 28919.4 30779.2 30797.5 30830.8 31909.8 32669.0 39565.4 40139.4 40370.6 9659.8 9853.3 9866.3 9867.6 9874.3 9638.5 9811.6 9812.5 9813.9 9818.0 9754.1 9827.0 9849.7 9858.2 9866.8 9698.0 9798.7 9800.0 9806.4 9810.3 8344.6 9530.7 9638.9 9665.3 9674.7 38529.0 39439.4 39478.8 39483.0 39562.6 3168.8 3218.0 3591.3 3698.2 4001.4 29115.9 29448.7 29531.7 29594.0 29676.1 2756.4 2774.8 2877.7 2998.4 3008.4 457015.0 457809.0 458245.0 458889.6 492531.0 45399.5 45456.9 45484.0 45570.8 45710.1 67204.3 68168.7 68524.3 68573.3 68704.3 16220.6 16250.4 16447.2 16483.8 16491.2 12598.6 12685.4 12697.5 12703.0 12723.2 17946.9 18241.8 18291.0 18304.7 19571.4 8420.5 8744.6 8831.8 8890.7 8970.5 861.0 890.6 909.5 940.8 993.9 26623.6 26890.6 27186.0 27263.0 27424.9 1082.6 1128.9 1141.4 1165.3 1190.9 12881.5 13983.8 14251.7 15755.0 16271.6 500252.0 507497.0 509770.0 510730.0 512149.0 57262.7 57697.0 57732.4 57767.8 58015.4 1140.9 1277.3 1439.2 1457.9 1474.5 28026.7 28455.4 29071.6 29159.6 29253.9 48285.0 57660.1 58557.0 58634.4 58764.4 316004.0 492302.0 494346.0 496172.0 496680.0 30607.5 30652.7 30907.5 30935.7 30981.1 44191.6 44805.6 44992.7 45496.8 46268.0 37174.8 37458.8 38183.0 38378.6 38477.0 34749.5 36504.7 37199.8 37320.1 37686.8 36899.4 37619.8 37782.2 38007.7 38054.6 22941.7 31568.4 31646.2 31707.0 31777.7 23878.9 24189.8 24216.6 24230.9 24434.3 13:38:29 INFO - PROCESS | 2263 | 13:38:29 INFO - PROCESS | 2263 | [#2] jquery.html Cycles:180 Average:37894.50 Median:27035.03 stddev:120038.85 (444.0%) stddev-sans-first:120342.52 13:38:29 INFO - PROCESS | 2263 | Values: 369.4 372.6 374.8 375.0 379.2 15517.3 15858.9 18598.4 18819.2 20482.9 11571.5 11917.3 11930.5 20124.6 20661.8 3221.2 5133.7 5310.3 5316.4 5324.1 4066.1 7337.8 7629.8 7644.7 7649.5 7387.9 7507.5 7612.8 7624.9 7701.9 7292.6 7560.6 7597.7 7597.9 7616.8 6961.1 7151.6 7158.8 7165.5 7244.6 19528.0 26569.6 26632.3 27437.7 27718.4 2065.4 2090.9 2211.8 2354.7 2416.7 11627.6 14732.3 15470.2 15752.7 16031.6 1841.5 1881.9 1885.5 1909.3 2066.5 95186.0 102251.0 102826.0 103841.0 105146.9 14510.4 15077.9 18766.0 19324.4 19334.8 12222.2 28262.0 28272.6 28423.3 28529.1 8207.1 8408.6 8413.5 8459.9 8515.4 8649.9 8665.6 8707.1 8734.9 8754.9 4093.2 4211.2 4217.0 4223.1 4225.4 1586.7 1836.8 1838.5 1839.6 1850.5 899.9 927.5 966.3 984.7 1053.2 20013.8 20755.3 21160.6 21415.5 21525.5 894.3 941.5 981.3 1035.1 1038.9 10847.3 11008.7 11160.5 11282.6 11455.3 716815.0 721236.4 731994.0 737389.0 739294.0 109152.5 115106.8 115986.4 116521.4 117762.0 1135.8 1170.3 1183.3 1192.7 1196.0 15595.9 17960.7 18293.2 18332.6 18386.5 46291.3 46942.8 47142.3 47735.0 48111.0 68870.3 72525.0 73646.3 73969.0 74418.0 6160.8 6389.9 7693.9 7806.0 7848.9 9303.9 10741.8 11743.9 12084.3 12114.4 6506.3 9758.2 10054.4 10520.7 10625.0 9884.9 10362.0 10447.0 10629.7 10963.6 10734.3 10906.9 10937.6 10950.9 11100.8 7685.2 7836.8 7844.6 7848.9 7879.9 9314.7 10842.3 10957.8 10984.8 11034.7 13:38:29 INFO - PROCESS | 2263 | 13:38:29 INFO - PROCESS | 2263 | [#3] mootools.html Cycles:180 Average:6160.03 Median:5315.70 stddev:3220.27 (60.6%) stddev-sans-first:3209.38 13:38:29 INFO - PROCESS | 2263 | Values: 1394.9 1511.0 1536.8 1759.5 1923.2 8026.6 8745.0 8939.6 8968.8 8974.0 8599.9 8911.0 8916.1 8917.3 8932.1 2215.2 2268.9 2273.0 2511.4 2538.0 2291.3 2294.6 2498.1 2548.2 2562.6 2446.6 2500.4 2509.6 2512.6 2539.1 2449.2 2503.1 2503.9 2506.0 2512.2 2478.9 2486.0 2487.5 2490.8 2491.8 8945.8 9027.3 9037.9 9040.7 9041.0 5499.2 5677.0 5680.5 5687.4 5697.5 3654.1 3696.0 3807.5 3824.6 3832.1 1068.3 1069.4 1100.8 1112.7 1115.2 12290.6 12308.4 12312.2 12341.7 12342.6 4958.1 4999.9 5014.5 5043.7 5094.6 10389.2 10416.4 10419.7 10422.6 10429.9 5594.7 5643.2 5651.4 5652.4 5666.2 5085.2 5121.3 5125.6 5125.8 5132.2 3722.3 3995.5 4036.2 4038.3 4098.3 1233.0 1304.2 1310.5 1321.6 1326.2 1305.3 1307.7 1309.1 1325.1 1351.2 6750.9 8084.2 8106.0 8166.9 8217.2 1168.6 1180.3 1181.3 1184.4 1189.7 6232.9 6322.0 6327.8 6328.0 6331.6 8881.2 10607.7 10896.8 10968.2 10993.5 10352.2 10834.6 10848.3 10854.9 10868.2 8285.2 8428.9 8508.5 8521.7 8531.7 6644.3 8027.7 8227.3 8275.8 8287.3 9555.0 9730.0 9750.4 9841.3 9861.4 8391.7 9094.2 9525.7 10006.4 10162.5 6757.3 7532.4 7585.5 7610.4 7614.5 7412.1 8237.8 8302.0 8302.1 8302.3 6913.8 7782.2 7791.3 7792.8 7969.0 7542.7 7648.0 7676.5 7685.7 7792.9 7990.4 8059.7 8067.8 8076.0 8109.6 7166.5 7211.7 7237.0 7254.9 7266.6 7326.9 7383.9 7392.2 7395.0 7424.3 13:38:29 INFO - PROCESS | 2263 | 13:38:29 INFO - PROCESS | 2263 | [#4] prototype.html Cycles:180 Average:5772.51 Median:6446.24 stddev:1853.50 (28.8%) stddev-sans-first:1812.95 13:38:29 INFO - PROCESS | 2263 | Values: 319.4 324.5 325.2 328.6 332.8 5353.8 6522.9 6563.3 6675.8 6697.0 6230.9 6382.3 6442.8 6541.8 6619.3 4828.7 4870.2 4892.1 4908.6 4915.7 4690.6 4901.7 4903.4 4906.8 4908.5 4738.0 4753.7 4812.1 4815.7 4817.0 4745.2 4798.0 4808.8 4812.1 4827.3 4111.9 4122.7 4127.9 4128.9 4142.9 6184.7 6327.6 6371.4 6390.0 6408.5 5794.9 5805.6 5819.2 5827.3 5833.5 7057.3 7060.1 7061.6 7064.3 7066.2 4095.2 4703.8 4706.4 4719.3 4722.0 7092.8 7348.2 7362.6 7364.7 7442.0 4593.5 4630.6 4634.7 4640.6 4646.3 4698.0 4704.6 4706.8 4712.2 4716.0 5450.5 5605.3 5612.0 5642.5 5645.8 7077.4 7083.0 7087.2 7093.5 7100.7 1614.1 1635.8 1639.2 1639.9 1640.4 1025.7 1034.6 1042.2 1050.7 1055.0 6421.2 6467.3 6606.0 6647.2 6661.9 7148.7 7337.9 7339.0 7345.3 7346.5 5568.4 5971.8 6589.9 6676.3 6723.5 3880.7 3928.5 3932.4 3932.5 3938.3 7450.9 7736.5 7736.9 7753.1 7772.8 7654.2 7662.9 7666.0 7671.7 7672.8 7710.3 7712.2 7713.6 7718.7 7737.5 5648.0 7299.5 7333.9 7419.6 7420.4 6449.6 6810.4 7269.2 7282.1 7286.2 7443.0 7714.2 7718.2 7724.6 7725.8 4619.5 4655.9 4673.3 4674.4 4677.4 7362.7 7365.2 7379.3 7383.2 7384.4 6907.7 7133.5 7162.3 7169.8 7196.7 7152.3 7153.9 7156.4 7159.5 7161.9 6995.4 7000.4 7000.5 7007.1 7014.2 6149.7 6799.0 6864.5 7142.0 7142.9 5147.5 6248.0 6584.9 7002.0 7010.5 13:38:29 INFO - PROCESS | 2263 | 13:38:29 INFO - PROCESS | 2263 | [#5] yui.html Cycles:180 Average:17905.59 Median:30632.82 stddev:25116.51 (82.0%) stddev-sans-first:25153.41 13:38:29 INFO - PROCESS | 2263 | Values: 613.7 626.8 735.5 736.7 789.6 14348.0 15220.8 15222.8 15224.2 15254.5 13109.9 13717.0 13774.5 13788.7 13789.2 859.4 883.3 888.1 888.3 888.5 867.5 874.1 877.4 877.8 879.3 916.0 917.9 919.2 920.2 922.7 900.0 906.7 908.6 908.9 914.0 684.0 684.6 685.5 689.2 689.3 12942.2 12955.5 13088.0 13287.3 13310.9 11462.4 11481.9 11499.9 11570.7 11686.0 9490.0 9581.2 9604.4 9694.6 10245.5 3400.2 3446.8 3461.6 3468.2 3469.4 56085.3 75724.0 77510.2 78460.8 80187.6 9478.1 9535.3 9535.6 9612.4 10076.5 20657.6 20666.0 20674.8 20681.4 20690.9 7046.6 7603.0 7871.0 7965.8 7965.8 3953.4 4043.9 4074.0 4095.5 4113.2 3578.4 3623.6 3633.9 3636.0 3637.1 640.4 645.0 646.4 654.1 662.6 509.9 547.5 556.6 598.2 625.4 8246.8 8265.2 8421.0 8602.5 8897.3 457.0 545.1 566.8 604.9 614.8 3971.1 4069.1 4102.8 4115.2 4201.6 88198.0 89703.6 99351.5 99688.0 99829.0 60660.8 78372.6 78597.0 78862.2 79298.0 59270.4 65831.0 65898.7 68967.3 69531.0 8690.3 9011.2 9027.2 9037.0 9049.4 47688.0 48154.8 48472.8 49028.3 49979.8 60205.7 68369.0 68652.0 69419.3 72189.0 10761.8 10778.5 10955.3 11141.9 11732.2 11807.2 11903.2 12186.9 12431.6 12695.5 11670.5 11740.2 11747.4 11822.6 11891.9 11243.9 11303.8 11761.7 11795.1 11929.2 11122.5 11299.2 11673.5 11729.9 11873.9 9342.8 9376.4 9623.6 9666.8 9679.4 9558.3 9939.2 10029.3 10057.7 10068.0 13:38:29 INFO - PROCESS | 2263 | -------- Summary: end -------- 13:38:29 INFO - PROCESS | 2263 | 13:38:29 INFO - TEST-INFO | 2263: exit 0 13:38:29 INFO - TEST-OK | dromaeo_css | took 1114927ms 13:38:29 INFO - TEST-START | kraken 13:38:29 INFO - operating with platform_type : mac_ 13:38:29 INFO - Initialising browser for kraken test... 13:38:29 INFO - TEST-INFO | started process 2266 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/tmpXFvHnq/profile http://localhost:57678/getInfo.html) 13:38:31 INFO - PROCESS | 2266 | __metrics Screen width/height:1600/1200 13:38:31 INFO - PROCESS | 2266 | colorDepth:24 13:38:31 INFO - PROCESS | 2266 | Browser inner width/height: 1024/689 13:38:31 INFO - PROCESS | 2266 | __metrics 13:38:32 INFO - PROCESS | 2266 | 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" 13:38:32 INFO - PROCESS | 2266 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:38:32 INFO - TEST-INFO | 2266: exit 0 13:38:32 INFO - Browser initialized. 13:38:32 INFO - Running cycle 1/1 for kraken test... 13:38:32 INFO - TEST-INFO | started process 2268 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/tmpXFvHnq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:38:44 INFO - PROCESS | 2268 | RSS: Main: 244568064 13:38:44 INFO - PROCESS | 2268 | 13:38:47 INFO - PROCESS | 2268 | Cycle 1(1): loaded http://localhost:57678/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57678/tests/kraken/driver.html?testName=audio-beat-detection) 13:38:47 INFO - PROCESS | 2268 | RSS: Main: 290091008 13:38:47 INFO - PROCESS | 2268 | 13:38:50 INFO - PROCESS | 2268 | Cycle 1(1): loaded http://localhost:57678/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57678/tests/kraken/driver.html?testName=audio-dft) 13:38:51 INFO - PROCESS | 2268 | RSS: Main: 301740032 13:38:51 INFO - PROCESS | 2268 | 13:38:54 INFO - PROCESS | 2268 | Cycle 1(1): loaded http://localhost:57678/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57678/tests/kraken/driver.html?testName=audio-fft) 13:38:55 INFO - PROCESS | 2268 | RSS: Main: 286736384 13:38:55 INFO - PROCESS | 2268 | 13:38:57 INFO - PROCESS | 2268 | Cycle 1(1): loaded http://localhost:57678/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57678/tests/kraken/driver.html?testName=audio-oscillator) 13:38:57 INFO - PROCESS | 2268 | RSS: Main: 287809536 13:38:57 INFO - PROCESS | 2268 | 13:38:59 INFO - PROCESS | 2268 | Cycle 1(1): loaded http://localhost:57678/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57678/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:39:00 INFO - PROCESS | 2268 | RSS: Main: 291319808 13:39:00 INFO - PROCESS | 2268 | 13:39:03 INFO - PROCESS | 2268 | Cycle 1(1): loaded http://localhost:57678/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57678/tests/kraken/driver.html?testName=imaging-darkroom) 13:39:03 INFO - PROCESS | 2268 | RSS: Main: 291676160 13:39:03 INFO - PROCESS | 2268 | 13:39:06 INFO - PROCESS | 2268 | Cycle 1(1): loaded http://localhost:57678/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57678/tests/kraken/driver.html?testName=imaging-desaturate) 13:39:07 INFO - PROCESS | 2268 | RSS: Main: 290869248 13:39:07 INFO - PROCESS | 2268 | 13:39:09 INFO - PROCESS | 2268 | Cycle 1(1): loaded http://localhost:57678/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57678/tests/kraken/driver.html?testName=json-parse-financial) 13:39:10 INFO - PROCESS | 2268 | RSS: Main: 292315136 13:39:10 INFO - PROCESS | 2268 | 13:39:11 INFO - PROCESS | 2268 | Cycle 1(1): loaded http://localhost:57678/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57678/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:39:12 INFO - PROCESS | 2268 | RSS: Main: 326070272 13:39:12 INFO - PROCESS | 2268 | 13:39:14 INFO - PROCESS | 2268 | Cycle 1(1): loaded http://localhost:57678/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57678/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:39:14 INFO - PROCESS | 2268 | RSS: Main: 325623808 13:39:14 INFO - PROCESS | 2268 | 13:39:16 INFO - PROCESS | 2268 | Cycle 1(1): loaded http://localhost:57678/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57678/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:39:17 INFO - PROCESS | 2268 | RSS: Main: 331812864 13:39:17 INFO - PROCESS | 2268 | 13:39:20 INFO - PROCESS | 2268 | Cycle 1(1): loaded http://localhost:57678/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57678/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:39:20 INFO - PROCESS | 2268 | RSS: Main: 333447168 13:39:20 INFO - PROCESS | 2268 | 13:39:23 INFO - PROCESS | 2268 | Cycle 1(1): loaded http://localhost:57678/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57678/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:39:23 INFO - PROCESS | 2268 | RSS: Main: 333852672 13:39:23 INFO - PROCESS | 2268 | 13:39:25 INFO - PROCESS | 2268 | Cycle 1(1): loaded http://localhost:57678/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57678/tests/kraken/driver.html?testName=ai-astar) 13:39:25 INFO - PROCESS | 2268 | RSS: Main: 394301440 13:39:25 INFO - PROCESS | 2268 | 13:39:25 INFO - PROCESS | 2268 | __start_tp_report 13:39:25 INFO - PROCESS | 2268 | _x_x_mozilla_page_load 13:39:25 INFO - PROCESS | 2268 | _x_x_mozilla_page_load_details 13:39:25 INFO - PROCESS | 2268 | |i|pagename|runs| 13:39:25 INFO - PROCESS | 2268 | |0;ai-astar;109;105;109;109;110;109;121;160;161;110 13:39:25 INFO - PROCESS | 2268 | |1;audio-beat-detection;160;126;159;155;116;145;147;144;193;146 13:39:25 INFO - PROCESS | 2268 | |2;audio-dft;184;186;184;184;184;184;183;185;179;180 13:39:25 INFO - PROCESS | 2268 | |3;audio-fft;79;81;85;76;59;69;89;107;101;60 13:39:25 INFO - PROCESS | 2268 | |4;audio-oscillator;92;93;130;78;81;81;109;77;77;106 13:39:25 INFO - PROCESS | 2268 | |5;imaging-gaussian-blur;88;92;84;90;84;89;83;89;83;89 13:39:25 INFO - PROCESS | 2268 | |6;imaging-darkroom;92;92;93;92;93;92;92;93;93;92 13:39:25 INFO - PROCESS | 2268 | |7;imaging-desaturate;84;85;84;84;84;86;85;84;84;84 13:39:25 INFO - PROCESS | 2268 | |8;json-parse-financial;57;55;54;53;53;52;54;63;52;53 13:39:25 INFO - PROCESS | 2268 | |9;json-stringify-tinderbox;63;64;75;79;70;68;65;69;67;70 13:39:25 INFO - PROCESS | 2268 | |10;stanford-crypto-aes;84;83;84;83;83;83;81;95;74;95 13:39:25 INFO - PROCESS | 2268 | |11;stanford-crypto-ccm;127;124;121;123;125;122;123;128;123;123 13:39:25 INFO - PROCESS | 2268 | |12;stanford-crypto-pbkdf2;138;129;139;137;137;122;137;137;138;136 13:39:25 INFO - PROCESS | 2268 | |13;stanford-crypto-sha256-iterative;66;67;67;66;67;67;66;67;70;67 13:39:25 INFO - PROCESS | 2268 | __end_tp_report 13:39:25 INFO - PROCESS | 2268 | __start_cc_report 13:39:25 INFO - PROCESS | 2268 | _x_x_mozilla_cycle_collect,1140 13:39:25 INFO - PROCESS | 2268 | __end_cc_report 13:39:25 INFO - PROCESS | 2268 | __startTimestamp1455572365638__endTimestamp 13:39:25 INFO - PROCESS | 2268 | 13:39:25 INFO - PROCESS | 2268 | ------- Summary: start ------- 13:39:25 INFO - PROCESS | 2268 | Number of tests: 14 13:39:25 INFO - PROCESS | 2268 | 13:39:25 INFO - PROCESS | 2268 | [#0] ai-astar Cycles:10 Average:120.30 Median:110.00 stddev:21.58 (19.6%) stddev-sans-first:22.50 13:39:25 INFO - PROCESS | 2268 | Values: 109.0 105.0 109.0 109.0 110.0 109.0 121.0 160.0 161.0 110.0 13:39:25 INFO - PROCESS | 2268 | 13:39:25 INFO - PROCESS | 2268 | [#1] audio-beat-detection Cycles:10 Average:149.10 Median:151.00 stddev:20.72 (13.7%) stddev-sans-first:21.60 13:39:25 INFO - PROCESS | 2268 | Values: 160.0 126.0 159.0 155.0 116.0 145.0 147.0 144.0 193.0 146.0 13:39:25 INFO - PROCESS | 2268 | 13:39:25 INFO - PROCESS | 2268 | [#2] audio-dft Cycles:10 Average:183.30 Median:184.00 stddev:2.16 (1.2%) stddev-sans-first:2.28 13:39:25 INFO - PROCESS | 2268 | Values: 184.0 186.0 184.0 184.0 184.0 184.0 183.0 185.0 179.0 180.0 13:39:25 INFO - PROCESS | 2268 | 13:39:25 INFO - PROCESS | 2268 | [#3] audio-fft Cycles:10 Average:80.60 Median:77.50 stddev:15.82 (20.4%) stddev-sans-first:16.77 13:39:25 INFO - PROCESS | 2268 | Values: 79.0 81.0 85.0 76.0 59.0 69.0 89.0 107.0 101.0 60.0 13:39:25 INFO - PROCESS | 2268 | 13:39:25 INFO - PROCESS | 2268 | [#4] audio-oscillator Cycles:10 Average:92.40 Median:79.50 stddev:17.69 (22.3%) stddev-sans-first:18.76 13:39:25 INFO - PROCESS | 2268 | Values: 92.0 93.0 130.0 78.0 81.0 81.0 109.0 77.0 77.0 106.0 13:39:25 INFO - PROCESS | 2268 | 13:39:25 INFO - PROCESS | 2268 | [#5] imaging-gaussian-blur Cycles:10 Average:87.10 Median:89.00 stddev:3.28 (3.7%) stddev-sans-first:3.46 13:39:25 INFO - PROCESS | 2268 | Values: 88.0 92.0 84.0 90.0 84.0 89.0 83.0 89.0 83.0 89.0 13:39:25 INFO - PROCESS | 2268 | 13:39:25 INFO - PROCESS | 2268 | [#6] imaging-darkroom Cycles:10 Average:92.40 Median:92.50 stddev:0.52 (0.6%) stddev-sans-first:0.53 13:39:25 INFO - PROCESS | 2268 | Values: 92.0 92.0 93.0 92.0 93.0 92.0 92.0 93.0 93.0 92.0 13:39:25 INFO - PROCESS | 2268 | 13:39:25 INFO - PROCESS | 2268 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.00 stddev:0.70 (0.8%) stddev-sans-first:0.73 13:39:25 INFO - PROCESS | 2268 | Values: 84.0 85.0 84.0 84.0 84.0 86.0 85.0 84.0 84.0 84.0 13:39:25 INFO - PROCESS | 2268 | 13:39:25 INFO - PROCESS | 2268 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:54.00 stddev:3.31 (6.1%) stddev-sans-first:3.39 13:39:25 INFO - PROCESS | 2268 | Values: 57.0 55.0 54.0 53.0 53.0 52.0 54.0 63.0 52.0 53.0 13:39:25 INFO - PROCESS | 2268 | 13:39:25 INFO - PROCESS | 2268 | [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:69.50 stddev:4.94 (7.1%) stddev-sans-first:4.74 13:39:25 INFO - PROCESS | 2268 | Values: 63.0 64.0 75.0 79.0 70.0 68.0 65.0 69.0 67.0 70.0 13:39:25 INFO - PROCESS | 2268 | 13:39:25 INFO - PROCESS | 2268 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:83.50 stddev:6.26 (7.5%) stddev-sans-first:6.64 13:39:25 INFO - PROCESS | 2268 | Values: 84.0 83.0 84.0 83.0 83.0 83.0 81.0 95.0 74.0 95.0 13:39:25 INFO - PROCESS | 2268 | 13:39:25 INFO - PROCESS | 2268 | [#11] stanford-crypto-ccm Cycles:10 Average:123.90 Median:123.50 stddev:2.18 (1.8%) stddev-sans-first:2.01 13:39:25 INFO - PROCESS | 2268 | Values: 127.0 124.0 121.0 123.0 125.0 122.0 123.0 128.0 123.0 123.0 13:39:25 INFO - PROCESS | 2268 | 13:39:25 INFO - PROCESS | 2268 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.00 Median:137.00 stddev:5.33 (3.9%) stddev-sans-first:5.55 13:39:25 INFO - PROCESS | 2268 | Values: 138.0 129.0 139.0 137.0 137.0 122.0 137.0 137.0 138.0 136.0 13:39:25 INFO - PROCESS | 2268 | 13:39:25 INFO - PROCESS | 2268 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:1.15 (1.7%) stddev-sans-first:1.17 13:39:25 INFO - PROCESS | 2268 | Values: 66.0 67.0 67.0 66.0 67.0 67.0 66.0 67.0 70.0 67.0 13:39:25 INFO - PROCESS | 2268 | -------- Summary: end -------- 13:39:25 INFO - PROCESS | 2268 | 13:39:26 INFO - TEST-INFO | 2268: exit 0 13:39:26 INFO - TEST-OK | kraken | took 56658ms 13:39:26 INFO - SUITE-END | took 1171s 13:39:26 INFO - Completed test suite (00:19:32) 13:39:26 INFO - Working with test: dromaeo_css 13:39:26 INFO - Generating results file: dromaeo_css 13:39:26 INFO - Working with test: kraken 13:39:26 INFO - Generating results file: kraken 13:39:26 INFO - javascript benchmark 13:39:26 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:39:27 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 13:39:27 INFO - process_Request line: dromaeo_css 7570.36 graph.html#tests=[[72,64,59]] 13:39:27 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:39:27 INFO - process_Request line: kraken 1423.60 graph.html#tests=[[232,64,59]] 13:39:27 INFO - RETURN: dromaeo_css: 7570.36 13:39:27 INFO - RETURN: kraken: 1423.60 13:39:27 INFO - javascript benchmark 13:39:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3352.580927384077, 3390.779599326042, 3411.3518431498023, 3426.16059065529, 3464.411050121479, 5583.246261754662, 5602.46776556227, 5609.411011843759, 5661.122526008465, 5682.119271512912, 4691.920858202616, 5652.236948012017, 5697.088465845465, 5822.4177582241755, 5825.330087039992, 4190.53904070552, 5053.963937392826, 5080.669756465836, 5135.947130838169, 5232.005918875401, 4365.279728844736, 5213.869653258661, 5218.0607490651855, 5278.604104692145, 5289.233061206123, 4150.667946564267, 5129.333186685744, 5171.482851714836, 5185.792568297264, 5260.263563101169, 4216.536181020086, 5193.143131383317, 5222.791088356461, 5230.320058392384, 5268.446813084609, 5128.820491282787, 5146.8198613048735, 5159.613029022801, 5177.8187763428095, 5180.6373553851245, 5394.271773310592, 5539.25220095286, 5547.389787123413, 5625.831225063254, 5665.943340566583, 6174.691265436711, 6176.907346389808, 6195.16365290689, 6201.81394558164, 6204.9689751551405, 5340.866478338073, 6104.2980057293535, 6241.78153764616, 6261.154744109578, 6261.87476250477, 4801.567858892717, 5708.942910570882, 5741.569382296303, 5784.652920824764, 5864.413558644187, 6244.531660125509, 6254.468370188585, 6268.937310626835, 6273.309935907047, 6283.183186185766, 5993.340732519419, 6031.306399763996, 6133.29467111279, 6139.416755408319, 6147.508199344042, 6135.355158799479, 6158.261008678987, 6210.627362358183, 6223.533235007392, 6230.6573138476915, 6112.0, 6150.569460137837, 6156.322804491502, 6170.50635949123, 6186.783462578788, 6074.240719910012, 6144.586745048664, 6153.015517517265, 6182.196314479089, 6209.223847019122, 4823.927641085386, 4866.343043689057, 4883.877903052452, 4894.363732714724, 4894.657373983858, 4350.543192964693, 4376.299792033323, 4393.033532622818, 4435.711678740871, 4439.289713645866, 5520.089185284383, 5555.666660000413, 5610.747516361774, 5621.550275977912, 5651.547876169979, 6124.448799607968, 6130.0, 6185.350538193515, 6207.441330280206, 6222.533310001678, 5566.693831839207, 5599.664020158803, 5601.551875849922, 5604.8038318658655, 5606.187102870143, 5318.149096144598, 5319.9202011969855, 5323.2015197719875, 5323.86690332737, 5324.4675532446445, 5208.635395522277, 6190.41191086846, 6241.625502469867, 6248.218972628421, 6255.718492667841, 6175.752969881154, 6225.968870155621, 6258.468030217483, 6264.561480696308, 6269.028300613412, 6279.340669229848, 6304.684765761602, 6306.495480361652, 6317.147185130132, 6335.429811317003, 6022.0, 6145.72344244519, 6145.938540614537, 6177.351378105414, 6186.628802271698, 6129.603311142764, 6151.507879369729, 6164.291106522807, 6165.815025549241, 6221.906671400023, 6096.207493025879, 6103.908441373472, 6105.945000794801, 6122.265328160649, 6138.891802656385, 4936.777844996912, 6062.211912451353, 6097.252466529944, 6111.105587097722, 6122.489639783254, 5862.12068189775, 5865.354810970875, 5883.2057672213705, 5888.411158884077, 5891.852703682443, 5989.700514974146, 6015.616408226045, 6019.0369540875, 6050.727717252822, 6061.7575296987625, 5924.970375148269, 5930.495907847709, 5952.702364881825, 5985.940140598713, 6043.486303664238], "unit": "score", "name": "dojo.html", "value": 5614.8242757973585}, {"lowerIsBetter": false, "replicates": [447.84325486079877, 511.3071787727629, 536.5224949794681, 556.9916451253231, 570.7431655754908, 24346.87826560869, 28919.397254247113, 30779.23051923703, 30797.538036929436, 30830.7667693292, 31909.840450797714, 32669.019929402097, 39565.406518902164, 40139.39790903139, 40370.596294037125, 9659.806803863936, 9853.310268281188, 9866.309358344883, 9867.555959981819, 9874.308798384116, 9638.469884156368, 9811.607535698564, 9812.509374531244, 9813.90186098137, 9817.95091024544, 9754.0733630305, 9827.017298270152, 9849.65526206583, 9858.211343092535, 9866.753331166707, 9697.95151024244, 9798.65704700332, 9800.019998000214, 9806.411615303105, 9810.264230182693, 8344.582770861432, 9530.666426675103, 9638.90361096394, 9665.27510436713, 9674.70975870725, 38529.0, 39439.40840887389, 39478.802605986784, 39483.0, 39562.60437395618, 3168.8415579221178, 3218.034589623127, 3591.281743651254, 3698.204885949534, 4001.3997900314894, 29115.854420727974, 29448.67480963362, 29531.704682953325, 29593.964211252718, 29676.10971670853, 2756.3522572195516, 2774.750272475487, 2877.7266159714795, 2998.3703422281346, 3008.413359394897, 457015.0, 457809.0, 458245.0, 458889.5832812519, 492531.0, 45399.54600453953, 45456.86357841014, 45484.0, 45570.772146139054, 45710.08579828451, 67204.32795672078, 68168.6591567039, 68524.3147568528, 68573.31426685769, 68704.3129568708, 16220.594485137966, 16250.431234906722, 16447.177641117898, 16483.83516164847, 16491.17544122789, 12598.55905043319, 12685.429155688016, 12697.492100315883, 12703.047271454678, 12723.172993755376, 17946.91026544859, 18241.817581824278, 18291.0, 18304.725429118575, 19571.412857614294, 8420.4947703138, 8744.606492707844, 8831.823363532694, 8890.73327800167, 8970.506622135714, 861.0055386029146, 890.617034675083, 909.4588719711761, 940.7836197674436, 993.8558908958161, 26623.600645990326, 26890.5966410504, 27186.0, 27263.045793397137, 27424.862875685893, 1082.5832054658856, 1128.9435528223555, 1141.4121727310442, 1165.3299352872132, 1190.863050749175, 12881.549145779853, 13983.79024314636, 14251.714965700628, 15755.0, 16271.593210169603, 500252.0, 507497.0, 509770.0, 510730.0, 512149.0, 57262.7136864313, 57697.0, 57732.4226757727, 57767.8446431069, 58015.41984580184, 1140.8534422904927, 1277.3421687830776, 1439.172475826383, 1457.9125252484885, 1474.4765608209361, 28026.738796754602, 28455.430891381642, 29071.563926540697, 29159.562606560496, 29253.85373073121, 48285.0, 57660.1350979744, 58557.0, 58634.42972917566, 58764.412355877605, 316004.0, 492302.0, 494346.0, 496172.0, 496680.0, 30607.54088688716, 30652.693473064985, 30907.536386954664, 30935.69064309418, 30981.070567882998, 44191.55808442003, 44805.55194448144, 44992.65022049344, 45496.77251613721, 46268.0, 37174.814125929195, 37458.812705936296, 38183.0, 38378.61621383751, 38477.0, 34749.47875781815, 36504.72233471816, 37199.81400092982, 37320.06699832526, 37686.81156594199, 36899.44650830186, 37619.811900941415, 37782.2443551133, 38007.66973155926, 38054.619453805106, 22941.655875161552, 31568.36863262676, 31646.208844778143, 31707.0, 31777.68222317747, 23878.88060559686, 24189.79051047476, 24216.636750448404, 24230.87884560566, 24434.26697199087], "unit": "score", "name": "ext.html", "value": 19279.972930253916}, {"lowerIsBetter": false, "replicates": [369.40156945747884, 372.61620530853213, 374.7732621763832, 375.0417682820393, 379.1752937361242, 15517.275853795092, 15858.920705396486, 18598.442046738586, 18819.153138108803, 20482.89758551205, 11571.479283432245, 11917.284962902231, 11930.522779088826, 20124.59750804987, 20661.793382066175, 3221.2269055426764, 5133.666311689728, 5310.256564081032, 5316.441773613754, 5324.068288049576, 4066.1054567994993, 7337.816554586125, 7629.80925476862, 7644.6559904804135, 7649.464537482379, 7387.852242955138, 7507.512011719221, 7612.809679757995, 7624.885626715603, 7701.922980770177, 7292.562446253241, 7560.584167870765, 7597.658105385271, 7597.924020759777, 7616.847663046736, 6961.129858767654, 7151.606661633608, 7158.821029474253, 7165.534240274365, 7244.565326080452, 19528.0, 26569.601455978176, 26632.341685966192, 27437.725622743917, 27718.445631087267, 2065.390709740615, 2090.9477263068393, 2211.7677643847487, 2354.7292061412986, 2416.7220769611367, 11627.59303424376, 14732.263386830615, 15470.226488675522, 15752.68494630101, 16031.599210019844, 1841.4659748672868, 1881.9341323053764, 1885.4720678210124, 1909.255390397746, 2066.5350296183237, 95186.0, 102251.0, 102826.0, 103841.0, 105146.94853051448, 14510.419583216764, 15077.924610376878, 18766.0, 19324.42026739172, 19334.80665193358, 12222.20555663879, 28262.0, 28272.575911361346, 28423.28941776472, 28529.144125676263, 8207.097219305871, 8408.621612027473, 8413.45312554682, 8459.873101903477, 8515.403921725543, 8649.870251946226, 8665.566721664018, 8707.12928707137, 8734.86897696535, 8754.86867696985, 4093.2222877653153, 4211.178820130107, 4217.0, 4223.13425747721, 4225.3873188387515, 1586.7461206207183, 1836.8007973090819, 1838.5212068037324, 1839.642652159787, 1850.4726153046317, 899.869518919753, 927.5315965437546, 966.2511553545918, 984.6701355045997, 1053.1890444357955, 20013.799862001484, 20755.273565425137, 21160.576788464143, 21415.46461338448, 21525.46186345354, 894.3024440936081, 941.5339406993583, 981.3375971219398, 1035.0787798859021, 1038.9428581427942, 10847.349159050482, 11008.73399559045, 11160.497777600027, 11282.605108821315, 11455.255408398427, 716815.0, 721236.3629091135, 731994.0, 737389.0, 739294.0, 109152.4542377299, 115106.84893151128, 115986.4200679008, 116521.4173929125, 117762.0, 1135.784201001807, 1170.30951738473, 1183.2841131115551, 1192.7316353820322, 1196.0371900620084, 15595.922020389826, 17960.730589041435, 18293.17680704398, 18332.633347333245, 18386.540336491697, 46291.305630416246, 46942.76528617335, 47142.29286560636, 47735.0, 48111.0, 68870.31129688639, 72525.0, 73646.26353736394, 73969.0, 74418.0, 6160.845978850564, 6389.9361006389345, 7693.884591731016, 7806.0, 7848.9215107848195, 9303.860442093239, 10741.838872417076, 11743.882561174622, 12084.274943503418, 12114.377688799803, 6506.339574175763, 9758.219342452729, 10054.396736195558, 10520.736981575521, 10625.0, 9884.851727223953, 10362.0, 10447.0, 10629.690373241701, 10963.56145754161, 10734.302270352402, 10906.945465272624, 10937.56249750001, 10950.890491094988, 11100.833487497855, 7685.193054729173, 7836.804079898048, 7844.607769611611, 7848.882266765889, 7879.881801772864, 9314.72055838326, 10842.349459032483, 10957.780844383227, 10984.835227471434, 11034.668959931216], "unit": "score", "name": "jquery.html", "value": 9822.795633400328}, {"lowerIsBetter": false, "replicates": [1394.9372278247479, 1510.9773353399698, 1536.8155821301445, 1759.4985429152694, 1923.1730355946945, 8026.558539280337, 8745.038045814963, 8939.642414303436, 8968.775780605489, 8974.012858585551, 8599.871001934976, 8910.95544522278, 8916.108389161096, 8917.286617070635, 8932.106789321064, 2215.2246713650256, 2268.886555672218, 2272.9772702273012, 2511.3972646564785, 2538.0228611984426, 2291.2667946257206, 2294.6443301288327, 2498.0757119865584, 2548.2227920484247, 2562.6284188792615, 2446.645236440715, 2500.4499010217814, 2509.560826855293, 2512.648229247907, 2539.1240022192405, 2449.2407353720405, 2503.0738626708235, 2503.949921001579, 2505.987470062656, 2512.170983575416, 2478.913238036678, 2485.9875700621383, 2487.502499500107, 2490.7882829959476, 2491.825572209946, 8945.776355591097, 9027.277817774562, 9037.864432033524, 9040.68357607487, 9040.954795226047, 5499.202615620753, 5676.971615141898, 5680.488756011938, 5687.40282270364, 5697.4587414195585, 3654.14127679995, 3695.981520092382, 3807.505024346817, 3824.598417166213, 3832.0994566276904, 1068.3216157739892, 1069.35838496902, 1100.8458815765798, 1112.6995711158022, 1115.1580556679655, 12290.569830055905, 12308.384580770926, 12312.199707019015, 12341.69145771354, 12342.629721108291, 4958.107540642719, 4999.875003124878, 5014.52362025607, 5043.722595257296, 5094.617903657167, 10389.220808439397, 10416.427096509613, 10419.687409377731, 10422.635207767691, 10429.9478502607, 5594.664320140804, 5643.181738647955, 5651.378348381675, 5652.434756524397, 5666.235058267163, 5085.186370180753, 5121.334226550524, 5125.564327032244, 5125.794968201305, 5132.204508301144, 3722.2555488902326, 3995.5405128410025, 4036.1725846201457, 4038.273110840018, 4098.344264917599, 1233.0, 1304.2044352944697, 1310.5151094095245, 1321.6497628128554, 1326.197650421481, 1305.288617703354, 1307.7123032932739, 1309.0901823232762, 1325.0923117664238, 1351.2095424176966, 6750.932490675031, 8084.231997960184, 8106.0, 8166.877496837552, 8217.178282171855, 1168.6026750904732, 1180.3272134883034, 1181.3030312115893, 1184.4492311075392, 1189.7204157023093, 6232.937670623326, 6322.0200868865395, 6327.841803954938, 6328.0, 6331.556791024584, 8881.200691937627, 10607.681769546925, 10896.836547451636, 10968.17738669603, 10993.450327483593, 10352.223583231287, 10834.566617335377, 10848.294860834021, 10854.891451085547, 10868.184886133413, 8285.212904774158, 8428.915710842935, 8508.489490630705, 8521.744347669579, 8531.74404767858, 6644.302348253364, 8027.719029833927, 8227.259546640831, 8275.83448331018, 8287.337013039063, 9554.989451896823, 9729.951350243204, 9750.414975101517, 9841.311108222355, 9861.408315501092, 8391.741238814227, 9094.181523662903, 9525.666406702929, 10006.44964526958, 10162.542685579314, 6757.256701762703, 7532.435067370079, 7585.544867307979, 7610.391168706379, 7614.543127412373, 7412.147603025721, 8237.83524329522, 8302.0, 8302.128276530877, 8302.335813134814, 6913.827154321182, 7782.2217778223985, 7791.337736292478, 7792.844143116992, 7969.0, 7542.698292068256, 7648.0, 7676.53940763556, 7685.730999414994, 7792.883106753517, 7990.440669153103, 8059.717909873127, 8067.798305042186, 8075.959620201861, 8109.635066422144, 7166.462515311268, 7211.747588834365, 7237.0, 7254.927450725425, 7266.600336981517, 7326.926730732837, 7383.926160738324, 7392.223816499405, 7395.0, 7424.257574242532], "unit": "score", "name": "mootools.html", "value": 5032.77656502232}, {"lowerIsBetter": false, "replicates": [319.4218464579111, 324.4662530137925, 325.2162288883789, 328.5580893697977, 332.81362437035256, 5353.812616558426, 6522.85849976254, 6563.278039415661, 6675.7663481778145, 6696.966515167417, 6230.9095908215995, 6382.297947225801, 6442.838929026777, 6541.803745887619, 6619.271880093186, 4828.73441960692, 4870.245112007645, 4892.094962431953, 4908.558229759321, 4915.705057696549, 4690.624750019991, 4901.65688401812, 4903.436104847935, 4906.779194936219, 4908.460069392364, 4737.952620473803, 4753.714777113367, 4812.10975969445, 4815.7110573365535, 4816.97591512042, 4745.240761478147, 4797.952020479803, 4808.787957539518, 4812.133815913135, 4827.25177597473, 4111.876643700693, 4122.670186385082, 4127.855525056639, 4128.91742165158, 4142.855000075013, 6184.690765461709, 6327.5570710050315, 6371.39471750183, 6390.0, 6408.51936104794, 5794.913076303858, 5805.564582656318, 5819.185314056035, 5827.300723913115, 5833.4749872511675, 7057.258987806258, 7060.129065797568, 7061.646917654148, 7064.258252883425, 7066.222715501291, 4095.201435720036, 4703.811847526094, 4706.434992928862, 4719.268513380432, 4722.0, 7092.751753688596, 7348.154962179311, 7362.5950572718475, 7364.668589913466, 7441.995330630404, 4593.54064593538, 4630.6063984561015, 4634.652401069866, 4640.559146881041, 4646.256598944153, 4698.013417182362, 4704.600108990706, 4706.835260765857, 4712.198926182557, 4716.033213191287, 5450.482204190675, 5605.299337582802, 5612.0, 5642.548596112301, 5645.802396916089, 7077.398421134261, 7082.964585177144, 7087.220405755363, 7093.538919970186, 7100.68046937889, 1614.0799744145959, 1635.8445947634955, 1639.2131776747228, 1639.8934069285458, 1640.3848556791204, 1025.6922923123034, 1034.632705389576, 1042.1975079188983, 1050.7110544600296, 1054.984175237372, 6421.197350331208, 6467.288598254188, 6605.966970165215, 6647.202335719648, 6661.933380666228, 7148.678309476086, 7337.88993165103, 7339.0, 7345.338919497271, 7346.52247603904, 5568.415316391721, 5971.775785963867, 6589.945608702585, 6676.332366763285, 6723.5293529452465, 3880.6895448364626, 3928.489296391451, 3932.4494570760116, 3932.488776459042, 3938.291107600602, 7450.925490745023, 7736.458447908705, 7736.92263077362, 7753.147153813189, 7772.844543109106, 7654.158042615308, 7662.923370766221, 7665.961670191613, 7671.693132274758, 7672.808179795438, 7710.306072453506, 7712.190220026929, 7713.575753333621, 7718.652660630285, 7737.458377913492, 5647.971760141173, 7299.489035767658, 7333.889991650236, 7419.629018549159, 7420.40636749048, 6449.645269510222, 6810.353016463428, 7269.200387957426, 7282.089738782653, 7286.16209135935, 7443.0, 7714.15144334134, 7718.189590092959, 7724.575148366894, 7725.768226953201, 4619.491855895916, 4655.906881862276, 4673.252279635242, 4674.368960190467, 4677.368555244999, 7362.6686799093095, 7365.243725699825, 7379.262073792578, 7383.15093764224, 7384.409247260313, 6907.723691052302, 7133.464990125657, 7162.283771622796, 7169.820754481179, 7196.748113815991, 7152.284771523015, 7153.928460715326, 7156.427485801019, 7159.534630249017, 7161.85676286461, 6995.370416662525, 7000.404965577983, 7000.50996430245, 7007.054047703495, 7014.228434872262, 6149.661768602769, 6798.966005169942, 6864.450843932574, 7141.964290178724, 7142.857142857218, 5147.510986456281, 6247.96876015617, 6584.868302633825, 7002.0, 7010.47421443404], "unit": "score", "name": "prototype.html", "value": 5150.382696006236}, {"lowerIsBetter": false, "replicates": [613.6532858934704, 626.83388901941, 735.4814855526851, 736.6869080640728, 789.5578476053411, 14348.0, 15220.847791522081, 15222.847771522282, 15224.23878806058, 15254.542363729079, 13109.868901311007, 13717.0, 13774.517891873786, 13788.724225515483, 13789.172649641028, 859.3511898516626, 883.3242569434387, 888.103015953888, 888.2760550151638, 888.506878682331, 867.5011868175824, 874.0909454167657, 877.385829919056, 877.7673916412124, 879.2921698033081, 916.0427353415663, 917.9311551633621, 919.2002957427014, 920.1534588178858, 922.6586163119622, 899.9550022498881, 906.6600024990629, 908.62746274028, 908.8545832666774, 913.968011119611, 683.9842833392408, 684.6234570985938, 685.4858855858106, 689.2108535726564, 689.2521614048763, 12942.223466592035, 12955.48178072876, 13088.0, 13287.335633218301, 13310.866891331156, 11462.426878656033, 11481.88518114825, 11499.942500287529, 11570.652880413601, 11686.047663384754, 9489.952550237274, 9581.185599224005, 9604.375715578535, 9694.612215511372, 10245.48772561369, 3400.2009527760956, 3446.7931924084637, 3461.6192218855904, 3468.1849765305133, 3469.3928562501715, 56085.33867341892, 75724.0, 77510.22489775087, 78460.82308765373, 80187.5990620049, 9478.146966772885, 9535.332526723201, 9535.61857525705, 9612.423254604746, 10076.49617519121, 20657.586848262952, 20665.966701664856, 20674.75951442918, 20681.379558613266, 20690.896545517477, 7046.612436316052, 7602.973598564234, 7871.0, 7965.761027169194, 7965.800854978672, 3953.387224980075, 4043.8786836394956, 4073.9592604073578, 4095.5494895561465, 4113.1568028554075, 3578.4095624221713, 3623.58328792187, 3633.8728144514816, 3636.0, 3637.1452708613456, 640.3724350136799, 644.9516286278548, 646.4311405962817, 654.0744846042796, 662.5991275278484, 509.9056674515227, 547.4761350175687, 556.6409665765558, 598.2043881637412, 625.4308579192913, 8246.793830154174, 8265.173482651686, 8421.0, 8602.483850968962, 8897.288216942628, 456.98400555981044, 545.1033050631688, 566.8271177290883, 604.851811306224, 614.797116951405, 3971.0866500704424, 4069.1251380952644, 4102.753834769924, 4115.218108559364, 4201.558836322142, 88198.0, 89703.55148224217, 99351.50324248332, 99688.0, 99829.0, 60660.78678426495, 78372.60813695895, 78597.0, 78862.21137788548, 79298.0, 59270.407295927354, 65831.0, 65898.67050664812, 68967.31006694071, 69531.0, 8690.261327786957, 9011.23404510624, 9027.187553120251, 9036.954815226145, 9049.366544341832, 47688.0, 48154.75922620364, 48472.757636211594, 49028.26457603068, 49979.75010124926, 60205.69897150486, 68368.97446538406, 68652.0, 69419.26451838744, 72189.0, 10761.784764304513, 10778.514966826355, 10955.34267943926, 11141.88858111441, 11732.178747487935, 11807.173497855068, 11903.172119629753, 12186.939065304618, 12431.564895228623, 12695.492180312684, 11670.474828632561, 11740.178187526792, 11747.353895535827, 11822.640396354529, 11891.940540297242, 11243.85171655586, 11303.776552328296, 11761.705957351134, 11795.056395488169, 11929.164958452826, 11122.499487523242, 11299.209055366046, 11673.474693638977, 11729.941350293195, 11873.940630296793, 9342.813143736952, 9376.437413755197, 9623.56693948788, 9666.75833104178, 9679.366615613957, 9558.330916836034, 9939.155171810477, 10029.348092373972, 10057.748556286151, 10068.04353586408], "unit": "score", "name": "yui.html", "value": 6828.744944637565}], "name": "dromaeo_css", "value": 7570.361832323666}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 105.0, 109.0, 109.0, 110.0, 109.0, 121.0, 160.0, 161.0, 110.0], "unit": "score", "name": "ai-astar", "value": 120.3}, {"lowerIsBetter": true, "replicates": [160.0, 126.0, 159.0, 155.0, 116.0, 145.0, 147.0, 144.0, 193.0, 146.0], "unit": "score", "name": "audio-beat-detection", "value": 149.1}, {"lowerIsBetter": true, "replicates": [184.0, 186.0, 184.0, 184.0, 184.0, 184.0, 183.0, 185.0, 179.0, 180.0], "unit": "score", "name": "audio-dft", "value": 183.3}, {"lowerIsBetter": true, "replicates": [79.0, 81.0, 85.0, 76.0, 59.0, 69.0, 89.0, 107.0, 101.0, 60.0], "unit": "score", "name": "audio-fft", "value": 80.6}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 130.0, 78.0, 81.0, 81.0, 109.0, 77.0, 77.0, 106.0], "unit": "score", "name": "audio-oscillator", "value": 92.4}, {"lowerIsBetter": true, "replicates": [88.0, 92.0, 84.0, 90.0, 84.0, 89.0, 83.0, 89.0, 83.0, 89.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 87.1}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 93.0, 92.0, 93.0, 92.0, 92.0, 93.0, 93.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 92.4}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 84.0, 84.0, 84.0, 86.0, 85.0, 84.0, 84.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 84.4}, {"lowerIsBetter": true, "replicates": [57.0, 55.0, 54.0, 53.0, 53.0, 52.0, 54.0, 63.0, 52.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 54.6}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 75.0, 79.0, 70.0, 68.0, 65.0, 69.0, 67.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.0}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 84.0, 83.0, 83.0, 83.0, 81.0, 95.0, 74.0, 95.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.5}, {"lowerIsBetter": true, "replicates": [127.0, 124.0, 121.0, 123.0, 125.0, 122.0, 123.0, 128.0, 123.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.9}, {"lowerIsBetter": true, "replicates": [138.0, 129.0, 139.0, 137.0, 137.0, 122.0, 137.0, 137.0, 138.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.0}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 67.0, 66.0, 67.0, 67.0, 66.0, 67.0, 70.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.0}], "name": "kraken", "value": 1423.6}]} 13:39:27 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1423.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7570.36"}}} 13:39:27 INFO - Return code: 0 13:39:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:39:27 INFO - # TBPL SUCCESS # 13:39:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:39:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:39:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:39:27 INFO - 2016-02-15 13:39:27.496 screenresolution[2272:25729] starting screenresolution argv=screenresolution get 13:39:27 INFO - 2016-02-15 13:39:27.498 screenresolution[2272:25729] Display 0: 1600x1200x32@60 13:39:27 INFO - 2016-02-15 13:39:27.504 screenresolution[2273:25732] starting screenresolution argv=screenresolution list 13:39:27 INFO - Available Modes on Display 0 13:39:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:39:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:39:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:39:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:39:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:39:27 INFO - Intel Iris: 13:39:27 INFO - Chipset Model: Intel Iris 13:39:27 INFO - Type: GPU 13:39:27 INFO - Bus: Built-In 13:39:27 INFO - VRAM (Dynamic, Max): 1536 MB 13:39:27 INFO - Vendor: Intel (0x8086) 13:39:27 INFO - Device ID: 0x0a2e 13:39:27 INFO - Revision ID: 0x0009 13:39:27 INFO - Displays: 13:39:27 INFO - Display: 13:39:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:39:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:39:27 INFO - Display Serial Number: 1600x1200 60 13:39:27 INFO - Main Display: Yes 13:39:27 INFO - Mirror: Off 13:39:27 INFO - Online: Yes 13:39:27 INFO - Rotation: Supported 13:39:27 INFO - Return code: 0 13:39:27 INFO - Running post-action listener: _resource_record_post_action 13:39:27 INFO - Running post-run listener: _resource_record_post_run 13:39:28 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 0; Write bytes: 711738880; Read time: 0; Write time: 1929 13:39:28 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 386537984; Write bytes: 382125568; Read time: 28832; Write time: 694 13:39:28 INFO - run-tests - Wall time: 1175s; CPU: 53.0%; Read bytes: 0; Write bytes: 304214016; Read time: 0; Write time: 1185 13:39:28 INFO - Running post-run listener: _upload_blobber_files 13:39:28 INFO - Blob upload gear active. 13:39:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:39:28 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 13:39:28 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'] 13:39:28 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 13:39:29 INFO - (blobuploader) - INFO - Open directory for files ... 13:39:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:39:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:39:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:39:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:39:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:39:30 INFO - (blobuploader) - INFO - Done attempting. 13:39:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:39:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:39:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:39:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:39:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:39:31 INFO - (blobuploader) - INFO - Done attempting. 13:39:31 INFO - (blobuploader) - INFO - Iteration through files over. 13:39:31 INFO - Return code: 0 13:39:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:39:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:39:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7326fabc4e898013449c15a2e8f9dd2acf115d780061866a5a556e66df54c2592d6eef4eba5efb4747b5005d0416cc2e6d0386a26ebf1578b800101d2acc6e25", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/077ae30ec87ac395810e32398d794370f7b5e6c96fc4e2d2e0e8b68bc9c1fc97e4f1438a44cf78278e69eccc36c9917bd2a1c349ccc5e709f646f6ff40c9f702"} 13:39:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:39:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:39:31 INFO - Contents: 13:39:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7326fabc4e898013449c15a2e8f9dd2acf115d780061866a5a556e66df54c2592d6eef4eba5efb4747b5005d0416cc2e6d0386a26ebf1578b800101d2acc6e25", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/077ae30ec87ac395810e32398d794370f7b5e6c96fc4e2d2e0e8b68bc9c1fc97e4f1438a44cf78278e69eccc36c9917bd2a1c349ccc5e709f646f6ff40c9f702"} 13:39:31 INFO - Running post-run listener: copy_logs_to_upload_dir 13:39:31 INFO - Copying logs to upload dir... 13:39:31 INFO - mkdir: /builds/slave/test/build/upload/logs 13:39:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.898951 ========= master_lag: -0.17 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-02-15 13:39:31.051653) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-15 13:39:31.054827) ========= 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.R10AJ0dcGK/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.eXMI7GeK5K/Listeners TMPDIR=/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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/7326fabc4e898013449c15a2e8f9dd2acf115d780061866a5a556e66df54c2592d6eef4eba5efb4747b5005d0416cc2e6d0386a26ebf1578b800101d2acc6e25", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/077ae30ec87ac395810e32398d794370f7b5e6c96fc4e2d2e0e8b68bc9c1fc97e4f1438a44cf78278e69eccc36c9917bd2a1c349ccc5e709f646f6ff40c9f702"} build_url:https://queue.taskcluster.net/v1/task/ToQcqWkSSe2tfnjSuTWARg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011287 build_url: 'https://queue.taskcluster.net/v1/task/ToQcqWkSSe2tfnjSuTWARg/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/7326fabc4e898013449c15a2e8f9dd2acf115d780061866a5a556e66df54c2592d6eef4eba5efb4747b5005d0416cc2e6d0386a26ebf1578b800101d2acc6e25", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/077ae30ec87ac395810e32398d794370f7b5e6c96fc4e2d2e0e8b68bc9c1fc97e4f1438a44cf78278e69eccc36c9917bd2a1c349ccc5e709f646f6ff40c9f702"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-15 13:39:31.081087) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 13:39:31.084408) ========= 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.R10AJ0dcGK/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.eXMI7GeK5K/Listeners TMPDIR=/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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.005391 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 13:39:31.133189) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-15 13:39:31.136555) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-15 13:39:31.136963) ========= ========= Total master_lag: 0.16 =========