builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0003 starttime: 1455721873.53 results: success (0) buildid: 20160217053150 builduid: eef0e9f0c7064a0b8453603d445fc6d3 revision: 61c15768ee19b0158a194f725ef4454f0781662b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-17 07:11:13.527059) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-17 07:11:13.527503) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-17 07:11:13.527788) ========= 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.5v2lTH4nWf/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.r29JHfJEc2/Listeners TMPDIR=/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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.005848 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-17 07:11:13.554787) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-17 07:11:13.558093) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-17 07:11:13.577658) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 07:11:13.577957) ========= 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.5v2lTH4nWf/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.r29JHfJEc2/Listeners TMPDIR=/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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.005155 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 07:11:13.626679) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-17 07:11:13.626984) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-17 07:11:13.627341) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 07:11:13.627613) ========= 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.5v2lTH4nWf/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.r29JHfJEc2/Listeners TMPDIR=/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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-17 07:11:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 23.4M=0s 2016-02-17 07:11:13 (23.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125115 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 07:11:13.770650) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 07:11:13.772056) ========= 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.5v2lTH4nWf/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.r29JHfJEc2/Listeners TMPDIR=/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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.019005 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 07:11:13.820736) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-17 07:11:13.824135) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 61c15768ee19b0158a194f725ef4454f0781662b --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 61c15768ee19b0158a194f725ef4454f0781662b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5v2lTH4nWf/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.r29JHfJEc2/Listeners TMPDIR=/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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-17 07:11:13,872 truncating revision to first 12 chars 2016-02-17 07:11:13,873 Setting DEBUG logging. 2016-02-17 07:11:13,873 attempt 1/10 2016-02-17 07:11:13,873 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/61c15768ee19?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-17 07:11:15,199 unpacking tar archive at: fx-team-61c15768ee19/testing/mozharness/ program finished with exit code 0 elapsedTime=1.558374 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-17 07:11:15.398234) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-17 07:11:15.398581) ========= echo 61c15768ee19b0158a194f725ef4454f0781662b in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'61c15768ee19b0158a194f725ef4454f0781662b'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5v2lTH4nWf/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.r29JHfJEc2/Listeners TMPDIR=/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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 61c15768ee19b0158a194f725ef4454f0781662b program finished with exit code 0 elapsedTime=0.005266 script_repo_revision: '61c15768ee19b0158a194f725ef4454f0781662b' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-17 07:11:15.453264) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-17 07:11:15.453591) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-17 07:11:15.467359) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-02-17 07:11:15.467628) ========= /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.5v2lTH4nWf/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.r29JHfJEc2/Listeners TMPDIR=/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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 07:11:15 INFO - MultiFileLogger online at 20160217 07:11:15 in /builds/slave/test 07:11: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 07:11:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:11:15 INFO - {'append_to_log': False, 07:11:15 INFO - 'base_work_dir': '/builds/slave/test', 07:11:15 INFO - 'blob_upload_branch': 'Fx-Team', 07:11:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:11:15 INFO - 'branch': 'Fx-Team', 07:11:15 INFO - 'buildbot_json_path': 'buildprops.json', 07:11:15 INFO - 'config_files': ('talos/mac_config.py',), 07:11:15 INFO - 'default_actions': ('clobber', 07:11:15 INFO - 'read-buildbot-config', 07:11:15 INFO - 'download-and-extract', 07:11:15 INFO - 'populate-webroot', 07:11:15 INFO - 'create-virtualenv', 07:11:15 INFO - 'install', 07:11:15 INFO - 'run-tests'), 07:11:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:11:15 INFO - 'download_minidump_stackwalk': True, 07:11:15 INFO - 'download_symbols': 'ondemand', 07:11:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:11:15 INFO - 'tooltool.py': '/tools/tooltool.py', 07:11:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:11:15 INFO - '/tools/misc-python/virtualenv.py')}, 07:11:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:11:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:11:15 INFO - 'installer_path': 'installer.exe', 07:11:15 INFO - 'log_level': 'info', 07:11:15 INFO - 'log_name': 'talos', 07:11:15 INFO - 'log_to_console': True, 07:11:15 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:11:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:11:15 INFO - 'opt_config_files': (), 07:11:15 INFO - 'pip_index': False, 07:11:15 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:11:15 INFO - 'cmd': ('bash', 07:11:15 INFO - '-c', 07:11:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:11:15 INFO - 'enabled': True, 07:11:15 INFO - 'halt_on_failure': False, 07:11:15 INFO - 'name': 'check_screen_resolution'},), 07:11:15 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:11:15 INFO - 'cmd': ('bash', 07:11:15 INFO - '-c', 07:11:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:11:15 INFO - 'enabled': True, 07:11:15 INFO - 'halt_on_failure': False, 07:11:15 INFO - 'name': 'check_screen_resolution'},), 07:11:15 INFO - 'run_cmd_checks_enabled': True, 07:11:15 INFO - 'sps_profile': False, 07:11:15 INFO - 'sps_profile_interval': 0, 07:11:15 INFO - 'suite': 'dromaeojs', 07:11:15 INFO - 'system_bits': '32', 07:11:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:11:15 INFO - 'title': 't-yosemite-r7-0003', 07:11:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:11:15 INFO - 'use_talos_json': True, 07:11:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:11:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:11:15 INFO - 'work_dir': 'build'} 07:11:15 INFO - ##### 07:11:15 INFO - ##### Running clobber step. 07:11:15 INFO - ##### 07:11:15 INFO - Running pre-action listener: _resource_record_pre_action 07:11:15 INFO - Running main action method: clobber 07:11:15 INFO - rmtree: /builds/slave/test/build 07:11:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:11:16 INFO - Running post-action listener: _resource_record_post_action 07:11:16 INFO - ##### 07:11:16 INFO - ##### Running read-buildbot-config step. 07:11:16 INFO - ##### 07:11:16 INFO - Running pre-action listener: _resource_record_pre_action 07:11:16 INFO - Running main action method: read_buildbot_config 07:11:16 INFO - Using buildbot properties: 07:11:16 INFO - { 07:11:16 INFO - "project": "", 07:11:16 INFO - "product": "firefox", 07:11:16 INFO - "script_repo_revision": "production", 07:11:16 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 07:11:16 INFO - "repository": "", 07:11:16 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 07:11:16 INFO - "buildid": "20160217053150", 07:11:16 INFO - "pgo_build": "False", 07:11:16 INFO - "basedir": "/builds/slave/test", 07:11:16 INFO - "buildnumber": 378, 07:11:16 INFO - "slavename": "t-yosemite-r7-0003", 07:11:16 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 07:11:16 INFO - "platform": "yosemite_r7", 07:11:16 INFO - "scheduler": "tests-fx-team-macosx64-talos", 07:11:16 INFO - "branch": "fx-team", 07:11:16 INFO - "repo_path": "integration/fx-team", 07:11:16 INFO - "revision": "61c15768ee19b0158a194f725ef4454f0781662b", 07:11:16 INFO - "stage_platform": "macosx64", 07:11:16 INFO - "builduid": "eef0e9f0c7064a0b8453603d445fc6d3", 07:11:16 INFO - "slavebuilddir": "test" 07:11:16 INFO - } 07:11:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/LRBfrVPTRFaOgG0JeMzvwg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 07:11:16 INFO - Running post-action listener: _resource_record_post_action 07:11:16 INFO - ##### 07:11:16 INFO - ##### Running download-and-extract step. 07:11:16 INFO - ##### 07:11:16 INFO - Running pre-action listener: _resource_record_pre_action 07:11:16 INFO - Running main action method: download_and_extract 07:11:16 INFO - mkdir: /builds/slave/test/build/tests 07:11:16 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')]} 07:11:16 INFO - https://queue.taskcluster.net/v1/task/LRBfrVPTRFaOgG0JeMzvwg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:11:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LRBfrVPTRFaOgG0JeMzvwg/artifacts/public/build/test_packages.json 07:11:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LRBfrVPTRFaOgG0JeMzvwg/artifacts/public/build/test_packages.json 07:11:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LRBfrVPTRFaOgG0JeMzvwg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 07:11:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LRBfrVPTRFaOgG0JeMzvwg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 07:11:18 INFO - Downloaded 1277 bytes. 07:11:18 INFO - Reading from file /builds/slave/test/build/test_packages.json 07:11:18 INFO - Using the following test package requirements: 07:11:18 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 07:11:18 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:11:18 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 07:11:18 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:11:18 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 07:11:18 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:11:18 INFO - u'jsshell-mac.zip'], 07:11:18 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:11:18 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 07:11:18 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 07:11:18 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:11:18 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 07:11:18 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:11:18 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 07:11:18 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:11:18 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 07:11:18 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 07:11:18 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:11:18 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 07:11:18 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:11:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:18 INFO - https://queue.taskcluster.net/v1/task/LRBfrVPTRFaOgG0JeMzvwg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:11:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LRBfrVPTRFaOgG0JeMzvwg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 07:11:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LRBfrVPTRFaOgG0JeMzvwg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 07:11:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LRBfrVPTRFaOgG0JeMzvwg/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 07:11:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LRBfrVPTRFaOgG0JeMzvwg/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 07:11:22 INFO - Downloaded 17806414 bytes. 07:11:22 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'] 07:11:22 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 07:11:25 INFO - Return code: 0 07:11:25 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 07:11:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:25 INFO - https://queue.taskcluster.net/v1/task/LRBfrVPTRFaOgG0JeMzvwg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:11:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LRBfrVPTRFaOgG0JeMzvwg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 07:11:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LRBfrVPTRFaOgG0JeMzvwg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 07:11:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LRBfrVPTRFaOgG0JeMzvwg/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 07:11:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LRBfrVPTRFaOgG0JeMzvwg/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 07:11:33 INFO - Downloaded 17806414 bytes. 07:11:33 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'] 07:11:33 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 07:11:37 INFO - Return code: 0 07:11:37 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')]} 07:11:37 INFO - https://queue.taskcluster.net/v1/task/LRBfrVPTRFaOgG0JeMzvwg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 07:11:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LRBfrVPTRFaOgG0JeMzvwg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 07:11:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LRBfrVPTRFaOgG0JeMzvwg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 07:11:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LRBfrVPTRFaOgG0JeMzvwg/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 07:11:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LRBfrVPTRFaOgG0JeMzvwg/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 07:11:38 INFO - Downloaded 10707015 bytes. 07:11:38 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'] 07:11:38 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 07:11:38 INFO - Return code: 0 07:11: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')]} 07:11:38 INFO - https://queue.taskcluster.net/v1/task/LRBfrVPTRFaOgG0JeMzvwg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 07:11:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LRBfrVPTRFaOgG0JeMzvwg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 07:11:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LRBfrVPTRFaOgG0JeMzvwg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 07:11:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LRBfrVPTRFaOgG0JeMzvwg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 07:11:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LRBfrVPTRFaOgG0JeMzvwg/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 07:11:47 INFO - Downloaded 111231362 bytes. 07:11:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LRBfrVPTRFaOgG0JeMzvwg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 07:11:47 INFO - mkdir: /builds/slave/test/properties 07:11:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:11:47 INFO - Writing to file /builds/slave/test/properties/build_url 07:11:47 INFO - Contents: 07:11:47 INFO - build_url:https://queue.taskcluster.net/v1/task/LRBfrVPTRFaOgG0JeMzvwg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 07:11:48 INFO - Running post-action listener: _resource_record_post_action 07:11:48 INFO - Running post-action listener: set_extra_try_arguments 07:11:48 INFO - ##### 07:11:48 INFO - ##### Running populate-webroot step. 07:11:48 INFO - ##### 07:11:48 INFO - Running pre-action listener: _resource_record_pre_action 07:11:48 INFO - Running main action method: populate_webroot 07:11:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:11:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:11:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:11:48 INFO - '--tppagecycles', 07:11:48 INFO - '7'], 07:11:48 INFO - 'tests': ['tsvgm']}}, 07:11:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:11:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:11:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:11:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 07:11:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:11:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:11:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:11:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:48 INFO - 'talos_options': ['--e10s'], 07:11:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:11:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:48 INFO - 'tests': ['damp', 'tps']}, 07:11:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:48 INFO - 'talos_options': ['--e10s'], 07:11:48 INFO - 'tests': ['damp', 'tps']}, 07:11:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:11:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:11:48 INFO - 'other': {'tests': ['a11yr', 07:11:48 INFO - 'ts_paint', 07:11:48 INFO - 'tpaint', 07:11:48 INFO - 'sessionrestore', 07:11:48 INFO - 'sessionrestore_no_auto_restore']}, 07:11:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:11:48 INFO - 'tests': ['a11yr', 07:11:48 INFO - 'ts_paint', 07:11:48 INFO - 'tpaint', 07:11:48 INFO - 'sessionrestore', 07:11:48 INFO - 'sessionrestore_no_auto_restore']}, 07:11:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:11:48 INFO - 'tests': ['a11yr', 07:11:48 INFO - 'ts_paint', 07:11:48 INFO - 'tpaint', 07:11:48 INFO - 'sessionrestore', 07:11:48 INFO - 'sessionrestore_no_auto_restore']}, 07:11:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:11:48 INFO - 'tests': ['a11yr', 07:11:48 INFO - 'ts_paint', 07:11:48 INFO - 'tpaint', 07:11:48 INFO - 'sessionrestore', 07:11:48 INFO - 'sessionrestore_no_auto_restore']}, 07:11:48 INFO - 'other_l64': {'tests': ['a11yr', 07:11:48 INFO - 'ts_paint', 07:11:48 INFO - 'tpaint', 07:11:48 INFO - 'sessionrestore', 07:11:48 INFO - 'sessionrestore_no_auto_restore']}, 07:11:48 INFO - 'other_nol64': {'tests': ['a11yr', 07:11:48 INFO - 'ts_paint', 07:11:48 INFO - 'tpaint', 07:11:48 INFO - 'sessionrestore', 07:11:48 INFO - 'sessionrestore_no_auto_restore']}, 07:11:48 INFO - 'svgr': {'tests': ['tsvgx', 07:11:48 INFO - 'tsvgr_opacity', 07:11:48 INFO - 'tart', 07:11:48 INFO - 'tscrollx', 07:11:48 INFO - 'cart']}, 07:11:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:11:48 INFO - 'tests': ['tsvgx', 07:11:48 INFO - 'tsvgr_opacity', 07:11:48 INFO - 'tart', 07:11:48 INFO - 'tscrollx', 07:11:48 INFO - 'cart']}, 07:11:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:48 INFO - 'tests': ['tp5o']}, 07:11:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:48 INFO - 'talos_options': ['--e10s'], 07:11:48 INFO - 'tests': ['tp5o']}, 07:11:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:48 INFO - 'talos_options': ['--xperf_path', 07:11:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:11:48 INFO - 'tests': ['tp5n']}, 07:11:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:48 INFO - 'talos_options': ['--e10s', 07:11:48 INFO - '--xperf_path', 07:11:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:11:48 INFO - 'tests': ['tp5n']}}, 07:11:48 INFO - 'talos.zip': {'path': '', 07:11:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:11:48 INFO - Running post-action listener: _resource_record_post_action 07:11:48 INFO - ##### 07:11:48 INFO - ##### Running create-virtualenv step. 07:11:48 INFO - ##### 07:11:48 INFO - Running pre-action listener: _resource_record_pre_action 07:11:48 INFO - Running main action method: create_virtualenv 07:11:48 INFO - Creating virtualenv /builds/slave/test/build/venv 07:11:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:11:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:11:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:11:48 INFO - Using real prefix '/tools/python27' 07:11:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:11:48 INFO - Installing distribute.............................................................................................................................................................................................done. 07:11:51 INFO - Installing pip.................done. 07:11:51 INFO - Return code: 0 07:11:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:11:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:51 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 0x10dd2ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd364c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8c3487000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbd2d30>, '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 0x10d9f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc9b20>, '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.5v2lTH4nWf/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.r29JHfJEc2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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 07:11:51 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 07:11:51 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 07:11:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5v2lTH4nWf/Render', 07:11:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:11:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:11:51 INFO - 'HOME': '/Users/cltbld', 07:11:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:11:51 INFO - 'LOGNAME': 'cltbld', 07:11:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:51 INFO - 'MOZ_NO_REMOTE': '1', 07:11:51 INFO - 'NO_EM_RESTART': '1', 07:11:51 INFO - 'PAGER': '/bin/cat', 07:11:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:11:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:51 INFO - 'PWD': '/builds/slave/test', 07:11:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:11:51 INFO - 'SHELL': '/bin/bash', 07:11:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r29JHfJEc2/Listeners', 07:11:51 INFO - 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/', 07:11:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:11:51 INFO - 'USER': 'cltbld', 07:11:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:11:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:11:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:51 INFO - 'XPC_FLAGS': '0x0', 07:11:51 INFO - 'XPC_SERVICE_NAME': '0', 07:11:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:11:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:52 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:11:52 INFO - Cleaning up... 07:11:52 INFO - Return code: 0 07:11:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:11: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')]} 07:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11: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')]} 07:11:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dd2ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd364c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8c3487000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbd2d30>, '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 0x10d9f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc9b20>, '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.5v2lTH4nWf/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.r29JHfJEc2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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 07:11:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 07:11:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:11:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5v2lTH4nWf/Render', 07:11:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:11:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:11:52 INFO - 'HOME': '/Users/cltbld', 07:11:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:11:52 INFO - 'LOGNAME': 'cltbld', 07:11:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:52 INFO - 'MOZ_NO_REMOTE': '1', 07:11:52 INFO - 'NO_EM_RESTART': '1', 07:11:52 INFO - 'PAGER': '/bin/cat', 07:11:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:11:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:52 INFO - 'PWD': '/builds/slave/test', 07:11:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:11:52 INFO - 'SHELL': '/bin/bash', 07:11:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r29JHfJEc2/Listeners', 07:11:52 INFO - 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/', 07:11:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:11:52 INFO - 'USER': 'cltbld', 07:11:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:11:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:11:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:52 INFO - 'XPC_FLAGS': '0x0', 07:11:52 INFO - 'XPC_SERVICE_NAME': '0', 07:11:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:11:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:52 INFO - Downloading/unpacking psutil>=0.7.1 07:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:11:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:11:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:11:55 INFO - Installing collected packages: psutil 07:11:55 INFO - Running setup.py install for psutil 07:11:55 INFO - building 'psutil._psutil_osx' extension 07:11:55 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 07:11:55 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 07:11:55 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 07:11:55 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 07:11:55 INFO - building 'psutil._psutil_posix' extension 07:11:55 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 07:11:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:11:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:11:55 INFO - ^ 07:11:55 INFO - 1 warning generated. 07:11:55 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 07:11:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:11:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:11:55 INFO - Successfully installed psutil 07:11:55 INFO - Cleaning up... 07:11:56 INFO - Return code: 0 07:11:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:11: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')]} 07:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11: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')]} 07:11:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11: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', '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 0x10dd2ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd364c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8c3487000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbd2d30>, '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 0x10d9f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc9b20>, '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.5v2lTH4nWf/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.r29JHfJEc2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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 07:11: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:11: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 mozsystemmonitor==0.0.0 07:11:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5v2lTH4nWf/Render', 07:11:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:11:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:11:56 INFO - 'HOME': '/Users/cltbld', 07:11:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:11:56 INFO - 'LOGNAME': 'cltbld', 07:11:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:56 INFO - 'MOZ_NO_REMOTE': '1', 07:11:56 INFO - 'NO_EM_RESTART': '1', 07:11:56 INFO - 'PAGER': '/bin/cat', 07:11:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:11:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:56 INFO - 'PWD': '/builds/slave/test', 07:11:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:11:56 INFO - 'SHELL': '/bin/bash', 07:11:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r29JHfJEc2/Listeners', 07:11:56 INFO - 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/', 07:11:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:11:56 INFO - 'USER': 'cltbld', 07:11:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:11:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:11:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:56 INFO - 'XPC_FLAGS': '0x0', 07:11:56 INFO - 'XPC_SERVICE_NAME': '0', 07:11:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:11:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:11: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 07:11: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 07:11: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 07:11: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 07:11: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 07:11: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 07:11:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:11:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:11:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:11:58 INFO - Installing collected packages: mozsystemmonitor 07:11:58 INFO - Running setup.py install for mozsystemmonitor 07:11:58 INFO - Successfully installed mozsystemmonitor 07:11:58 INFO - Cleaning up... 07:11:58 INFO - Return code: 0 07:11:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:11:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10dd2ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd364c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8c3487000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbd2d30>, '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 0x10d9f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc9b20>, '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.5v2lTH4nWf/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.r29JHfJEc2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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 07:11:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:11:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:11:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5v2lTH4nWf/Render', 07:11:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:11:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:11:59 INFO - 'HOME': '/Users/cltbld', 07:11:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:11:59 INFO - 'LOGNAME': 'cltbld', 07:11:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:59 INFO - 'MOZ_NO_REMOTE': '1', 07:11:59 INFO - 'NO_EM_RESTART': '1', 07:11:59 INFO - 'PAGER': '/bin/cat', 07:11:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:11:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:59 INFO - 'PWD': '/builds/slave/test', 07:11:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:11:59 INFO - 'SHELL': '/bin/bash', 07:11:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r29JHfJEc2/Listeners', 07:11:59 INFO - 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/', 07:11:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:11:59 INFO - 'USER': 'cltbld', 07:11:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:11:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:11:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:59 INFO - 'XPC_FLAGS': '0x0', 07:11:59 INFO - 'XPC_SERVICE_NAME': '0', 07:11:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:12:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:00 INFO - Downloading/unpacking blobuploader==1.2.4 07:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:02 INFO - Downloading blobuploader-1.2.4.tar.gz 07:12:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:12:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:12:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:03 INFO - Downloading docopt-0.6.1.tar.gz 07:12:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:12:04 INFO - Installing collected packages: blobuploader, requests, docopt 07:12:04 INFO - Running setup.py install for blobuploader 07:12:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:12:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:12:04 INFO - Running setup.py install for requests 07:12:04 INFO - Running setup.py install for docopt 07:12:04 INFO - Successfully installed blobuploader requests docopt 07:12:04 INFO - Cleaning up... 07:12:04 INFO - Return code: 0 07:12:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:12:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:04 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 0x10dd2ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd364c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8c3487000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbd2d30>, '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 0x10d9f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc9b20>, '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.5v2lTH4nWf/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.r29JHfJEc2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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 07:12:04 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 07:12:04 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 07:12:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5v2lTH4nWf/Render', 07:12:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:12:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:12:04 INFO - 'HOME': '/Users/cltbld', 07:12:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:12:04 INFO - 'LOGNAME': 'cltbld', 07:12:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:04 INFO - 'MOZ_NO_REMOTE': '1', 07:12:04 INFO - 'NO_EM_RESTART': '1', 07:12:04 INFO - 'PAGER': '/bin/cat', 07:12:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:12:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:04 INFO - 'PWD': '/builds/slave/test', 07:12:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:12:04 INFO - 'SHELL': '/bin/bash', 07:12:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r29JHfJEc2/Listeners', 07:12:04 INFO - 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/', 07:12:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:12:04 INFO - 'USER': 'cltbld', 07:12:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:12:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:12:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:04 INFO - 'XPC_FLAGS': '0x0', 07:12:04 INFO - 'XPC_SERVICE_NAME': '0', 07:12:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:12:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:12:05 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-jGulLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:12:05 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-cvsQpD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:12:05 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-lY3Kxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:12:05 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-eY3m85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:12:05 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-opUUOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:12:05 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-CEcrHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:12:05 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-SPJM2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:12:05 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-T_g4lN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:12:06 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-nrY003-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:12:06 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-XzNPLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:12:06 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-YyRcwq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:12:06 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-lILNLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:12:06 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-O6mJMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:12:06 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-zRbDZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:12:06 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-QHrUfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:12:06 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-WDlQoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:12:06 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-pcMYXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:12:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:12:06 INFO - Running setup.py install for manifestparser 07:12:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:12:07 INFO - Running setup.py install for mozcrash 07:12:07 INFO - Running setup.py install for mozdebug 07:12:07 INFO - Running setup.py install for mozdevice 07:12:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:12:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:12:07 INFO - Running setup.py install for mozfile 07:12:07 INFO - Running setup.py install for mozhttpd 07:12:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:12:07 INFO - Running setup.py install for mozinfo 07:12:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:12:07 INFO - Running setup.py install for mozInstall 07:12:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:12:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:12:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:12:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:12:08 INFO - Running setup.py install for mozleak 07:12:08 INFO - Running setup.py install for mozlog 07:12:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:12:08 INFO - Running setup.py install for moznetwork 07:12:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:12:08 INFO - Running setup.py install for mozprocess 07:12:08 INFO - Running setup.py install for mozprofile 07:12:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:12:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:12:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:12:08 INFO - Running setup.py install for mozrunner 07:12:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:12:09 INFO - Running setup.py install for mozscreenshot 07:12:09 INFO - Running setup.py install for moztest 07:12:09 INFO - Running setup.py install for mozversion 07:12:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:12:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:12:09 INFO - Cleaning up... 07:12:09 INFO - Return code: 0 07:12:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:12:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dd2ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd364c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8c3487000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbd2d30>, '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 0x10d9f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc9b20>, '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.5v2lTH4nWf/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.r29JHfJEc2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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 07:12:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:12:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:12:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5v2lTH4nWf/Render', 07:12:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:12:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:12:09 INFO - 'HOME': '/Users/cltbld', 07:12:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:12:09 INFO - 'LOGNAME': 'cltbld', 07:12:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:09 INFO - 'MOZ_NO_REMOTE': '1', 07:12:09 INFO - 'NO_EM_RESTART': '1', 07:12:09 INFO - 'PAGER': '/bin/cat', 07:12:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:12:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:09 INFO - 'PWD': '/builds/slave/test', 07:12:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:12:09 INFO - 'SHELL': '/bin/bash', 07:12:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r29JHfJEc2/Listeners', 07:12:09 INFO - 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/', 07:12:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:12:09 INFO - 'USER': 'cltbld', 07:12:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:12:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:12:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:09 INFO - 'XPC_FLAGS': '0x0', 07:12:09 INFO - 'XPC_SERVICE_NAME': '0', 07:12:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:12:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:12:09 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-ym0TKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:12:09 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)) 07:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:12:09 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-iFbnhX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:12:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:12:10 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-lofzxI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:12:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:12:10 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-FaPF1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:12:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:12:10 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-ueeUx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:12:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:12:10 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-8O8bns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:12:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:12:10 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-RRsaRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:12:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:12:10 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-9N2KcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:12:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:12:10 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-VCWZWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:12:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:12:10 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-W9ejEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:12:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:12:10 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-WLmuia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:12:10 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)) 07:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:12:10 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-iHxBdd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:12:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:12:11 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-mu2p6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:12:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:12:11 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-9qPy3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:12:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:12:11 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-nDEggI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:12:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:12:11 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-NXwkfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:12:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:12:11 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-NfXwSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:12:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:12:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:12:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:12:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:12:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:12:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:12:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:12: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 07:12: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 07:12: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 07:12: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 07:12: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 07:12: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 07:12:13 INFO - Downloading blessings-1.6.tar.gz 07:12:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:12:14 INFO - Installing collected packages: blessings 07:12:14 INFO - Running setup.py install for blessings 07:12:14 INFO - Successfully installed blessings 07:12:14 INFO - Cleaning up... 07:12:14 INFO - Return code: 0 07:12:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:12:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:12:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:12:14 INFO - Reading from file tmpfile_stdout 07:12:14 INFO - Current package versions: 07:12:14 INFO - blessings == 1.6 07:12:14 INFO - blobuploader == 1.2.4 07:12:14 INFO - docopt == 0.6.1 07:12:14 INFO - manifestparser == 1.1 07:12:14 INFO - mozInstall == 1.12 07:12:14 INFO - mozcrash == 0.16 07:12:14 INFO - mozdebug == 0.1 07:12:14 INFO - mozdevice == 0.48 07:12:14 INFO - mozfile == 1.2 07:12:14 INFO - mozhttpd == 0.7 07:12:14 INFO - mozinfo == 0.9 07:12:14 INFO - mozleak == 0.1 07:12:14 INFO - mozlog == 3.1 07:12:14 INFO - moznetwork == 0.27 07:12:14 INFO - mozprocess == 0.22 07:12:14 INFO - mozprofile == 0.28 07:12:14 INFO - mozrunner == 6.11 07:12:14 INFO - mozscreenshot == 0.1 07:12:14 INFO - mozsystemmonitor == 0.0 07:12:14 INFO - moztest == 0.7 07:12:14 INFO - mozversion == 1.4 07:12:14 INFO - psutil == 3.1.1 07:12:14 INFO - requests == 1.2.3 07:12:14 INFO - wsgiref == 0.1.2 07:12:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:12: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')]} 07:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12: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')]} 07:12:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dd2ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd364c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8c3487000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbd2d30>, '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 0x10d9f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc9b20>, '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.5v2lTH4nWf/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.r29JHfJEc2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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 07:12:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:12:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:12:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5v2lTH4nWf/Render', 07:12:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:12:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:12:14 INFO - 'HOME': '/Users/cltbld', 07:12:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:12:14 INFO - 'LOGNAME': 'cltbld', 07:12:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:14 INFO - 'MOZ_NO_REMOTE': '1', 07:12:14 INFO - 'NO_EM_RESTART': '1', 07:12:14 INFO - 'PAGER': '/bin/cat', 07:12:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:12:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:14 INFO - 'PWD': '/builds/slave/test', 07:12:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:12:14 INFO - 'SHELL': '/bin/bash', 07:12:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r29JHfJEc2/Listeners', 07:12:14 INFO - 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/', 07:12:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:12:14 INFO - 'USER': 'cltbld', 07:12:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:12:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:12:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:14 INFO - 'XPC_FLAGS': '0x0', 07:12:14 INFO - 'XPC_SERVICE_NAME': '0', 07:12:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:12:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:12:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:12:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:12:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:12:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:12:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:12:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:12:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:12:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:12:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:12:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:12:14 INFO - Cleaning up... 07:12:14 INFO - Return code: 0 07:12:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:12: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')]} 07:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12: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')]} 07:12:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dd2ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd364c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8c3487000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbd2d30>, '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 0x10d9f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc9b20>, '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.5v2lTH4nWf/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.r29JHfJEc2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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 07:12:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:12:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:12:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5v2lTH4nWf/Render', 07:12:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:12:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:12:14 INFO - 'HOME': '/Users/cltbld', 07:12:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:12:14 INFO - 'LOGNAME': 'cltbld', 07:12:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:14 INFO - 'MOZ_NO_REMOTE': '1', 07:12:14 INFO - 'NO_EM_RESTART': '1', 07:12:14 INFO - 'PAGER': '/bin/cat', 07:12:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:12:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:14 INFO - 'PWD': '/builds/slave/test', 07:12:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:12:14 INFO - 'SHELL': '/bin/bash', 07:12:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r29JHfJEc2/Listeners', 07:12:14 INFO - 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/', 07:12:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:12:14 INFO - 'USER': 'cltbld', 07:12:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:12:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:12:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:14 INFO - 'XPC_FLAGS': '0x0', 07:12:14 INFO - 'XPC_SERVICE_NAME': '0', 07:12:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:12:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:15 INFO - Downloading/unpacking jsonschema 07:12:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:12:17 INFO - Downloading/unpacking functools32 (from jsonschema) 07:12: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 07:12: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 07:12: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 07:12: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 07:12: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 07:12: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 07:12:17 INFO - Downloading functools32-3.2.3-2.tar.gz 07:12:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:12:17 INFO - warning: no files found matching '*.txt' 07:12:17 INFO - no previously-included directories found matching 'build' 07:12:17 INFO - no previously-included directories found matching 'dist' 07:12:17 INFO - no previously-included directories found matching '.git*' 07:12:17 INFO - Installing collected packages: jsonschema, functools32 07:12:17 INFO - Running setup.py install for functools32 07:12:18 INFO - warning: no files found matching '*.txt' 07:12:18 INFO - no previously-included directories found matching 'build' 07:12:18 INFO - no previously-included directories found matching 'dist' 07:12:18 INFO - no previously-included directories found matching '.git*' 07:12:18 INFO - Successfully installed jsonschema functools32 07:12:18 INFO - Cleaning up... 07:12:18 INFO - Return code: 0 07:12:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:12:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dd2ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd364c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8c3487000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbd2d30>, '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 0x10d9f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc9b20>, '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.5v2lTH4nWf/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.r29JHfJEc2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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 07:12:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:12:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:12:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5v2lTH4nWf/Render', 07:12:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:12:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:12:18 INFO - 'HOME': '/Users/cltbld', 07:12:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:12:18 INFO - 'LOGNAME': 'cltbld', 07:12:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:18 INFO - 'MOZ_NO_REMOTE': '1', 07:12:18 INFO - 'NO_EM_RESTART': '1', 07:12:18 INFO - 'PAGER': '/bin/cat', 07:12:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:12:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:18 INFO - 'PWD': '/builds/slave/test', 07:12:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:12:18 INFO - 'SHELL': '/bin/bash', 07:12:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r29JHfJEc2/Listeners', 07:12:18 INFO - 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/', 07:12:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:12:18 INFO - 'USER': 'cltbld', 07:12:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:12:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:12:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:18 INFO - 'XPC_FLAGS': '0x0', 07:12:18 INFO - 'XPC_SERVICE_NAME': '0', 07:12:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:12:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:18 INFO - Downloading/unpacking flake8 07:12:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:12:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:12:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:12:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:12:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:12:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:12:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:12:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:12:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:12:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:12:22 INFO - no previously-included directories found matching 'docs/_build' 07:12:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:12:22 INFO - Running setup.py install for pep8 07:12:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:12:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:12:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:12:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:12:22 INFO - no previously-included directories found matching 'docs/_build' 07:12:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:12:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:12:22 INFO - Cleaning up... 07:12:22 INFO - Return code: 0 07:12:22 INFO - Running post-action listener: _resource_record_post_action 07:12:22 INFO - Running post-action listener: _start_resource_monitoring 07:12:22 INFO - Starting resource monitoring. 07:12:22 INFO - ##### 07:12:22 INFO - ##### Running install step. 07:12:22 INFO - ##### 07:12:22 INFO - Running pre-action listener: _resource_record_pre_action 07:12:22 INFO - Running main action method: install 07:12:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:12:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:12:23 INFO - Reading from file tmpfile_stdout 07:12:23 INFO - Detecting whether we're running mozinstall >=1.0... 07:12:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:12:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:12:23 INFO - Reading from file tmpfile_stdout 07:12:23 INFO - Output received: 07:12:23 INFO - Usage: mozinstall [options] installer 07:12:23 INFO - Options: 07:12:23 INFO - -h, --help show this help message and exit 07:12:23 INFO - -d DEST, --destination=DEST 07:12:23 INFO - Directory to install application into. [default: 07:12:23 INFO - "/builds/slave/test"] 07:12:23 INFO - --app=APP Application being installed. [default: firefox] 07:12:23 INFO - mkdir: /builds/slave/test/build/application 07:12:23 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'] 07:12:23 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 07:12:57 INFO - Reading from file tmpfile_stdout 07:12:57 INFO - Output received: 07:12:57 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:12:57 INFO - Running post-action listener: _resource_record_post_action 07:12:57 INFO - ##### 07:12:57 INFO - ##### Running run-tests step. 07:12:57 INFO - ##### 07:12:57 INFO - Running pre-action listener: _resource_record_pre_action 07:12:57 INFO - Running main action method: run_tests 07:12:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:12:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:12:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:12:57 INFO - 2016-02-17 07:12:57.434 screenresolution[1946:14540] starting screenresolution argv=screenresolution get 07:12:57 INFO - 2016-02-17 07:12:57.436 screenresolution[1946:14540] Display 0: 1600x1200x32@60 07:12:57 INFO - 2016-02-17 07:12:57.443 screenresolution[1947:14542] starting screenresolution argv=screenresolution list 07:12:57 INFO - Available Modes on Display 0 07:12:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:12:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:12:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:12:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:12:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:12:57 INFO - Intel Iris: 07:12:57 INFO - Chipset Model: Intel Iris 07:12:57 INFO - Type: GPU 07:12:57 INFO - Bus: Built-In 07:12:57 INFO - VRAM (Dynamic, Max): 1536 MB 07:12:57 INFO - Vendor: Intel (0x8086) 07:12:57 INFO - Device ID: 0x0a2e 07:12:57 INFO - Revision ID: 0x0009 07:12:57 INFO - Displays: 07:12:57 INFO - Display: 07:12:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:12:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:12:57 INFO - Display Serial Number: 1600x1200 60 07:12:57 INFO - Main Display: Yes 07:12:57 INFO - Mirror: Off 07:12:57 INFO - Online: Yes 07:12:57 INFO - Rotation: Supported 07:12:57 INFO - Return code: 0 07:12:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:12:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:12:57 INFO - Python 2.7.3 07:12:57 INFO - Return code: 0 07:12:57 INFO - grabbing minidump binary from tooltool 07:12:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:57 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbd2d30>, '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 0x10d9f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:12:57 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:12:57 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 07:12:57 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:12:57 INFO - Return code: 0 07:12:57 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:12:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:12:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:12:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:12:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:12:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:12:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:12:59 INFO - Return code: 0 07:12:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LRBfrVPTRFaOgG0JeMzvwg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0003', '--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 07:12:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LRBfrVPTRFaOgG0JeMzvwg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0003 --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 07:12:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5v2lTH4nWf/Render', 07:12:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:12:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:12:59 INFO - 'HOME': '/Users/cltbld', 07:12:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:12:59 INFO - 'LOGNAME': 'cltbld', 07:12:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:12:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:12:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:59 INFO - 'MOZ_NO_REMOTE': '1', 07:12:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:12:59 INFO - 'NO_EM_RESTART': '1', 07:12:59 INFO - 'PAGER': '/bin/cat', 07:12:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:12:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:59 INFO - 'PWD': '/builds/slave/test', 07:12:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:12:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:12:59 INFO - 'SHELL': '/bin/bash', 07:12:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r29JHfJEc2/Listeners', 07:12:59 INFO - 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/', 07:12:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:12:59 INFO - 'USER': 'cltbld', 07:12:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:12:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:12:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:59 INFO - 'XPC_FLAGS': '0x0', 07:12:59 INFO - 'XPC_SERVICE_NAME': '0', 07:12:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:12:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LRBfrVPTRFaOgG0JeMzvwg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0003', '--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 07:12:59 INFO - mozversion application_buildid: 20160217053150 07:12:59 INFO - mozversion application_changeset: 61c15768ee19b0158a194f725ef4454f0781662b 07:12:59 INFO - mozversion application_display_name: Nightly 07:12:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:12:59 INFO - mozversion application_name: Firefox 07:12:59 INFO - mozversion application_remotingname: firefox 07:12:59 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:12:59 INFO - mozversion application_vendor: Mozilla 07:12:59 INFO - mozversion application_version: 47.0a1 07:12:59 INFO - mozversion platform_buildid: 20160217053150 07:12:59 INFO - mozversion platform_changeset: 61c15768ee19b0158a194f725ef4454f0781662b 07:12:59 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:12:59 INFO - mozversion platform_version: 47.0a1 07:12:59 INFO - using testdate: 1455721979 07:12:59 INFO - actual date: 1455721979 07:12:59 INFO - starting webserver on 'localhost:49708' 07:12:59 INFO - SUITE-START | Running 2 tests 07:12:59 INFO - TEST-START | dromaeo_css 07:12:59 INFO - operating with platform_type : mac_ 07:12:59 INFO - Initialising browser for dromaeo_css test... 07:12:59 INFO - TEST-INFO | started process 1965 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/tmpo_IDmE/profile http://localhost:49708/getInfo.html) 07:13:02 INFO - PROCESS | 1965 | __metrics Screen width/height:1600/1200 07:13:02 INFO - PROCESS | 1965 | colorDepth:24 07:13:02 INFO - PROCESS | 1965 | Browser inner width/height: 1024/689 07:13:02 INFO - PROCESS | 1965 | __metrics 07:13:02 INFO - PROCESS | 1965 | 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" 07:13:02 INFO - PROCESS | 1965 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:13:02 INFO - TEST-INFO | 1965: exit 0 07:13:02 INFO - Browser initialized. 07:13:02 INFO - Running cycle 1/1 for dromaeo_css test... 07:13:02 INFO - TEST-INFO | started process 1968 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/tmpo_IDmE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:13:14 INFO - PROCESS | 1968 | RSS: Main: 244568064 07:13:14 INFO - PROCESS | 1968 | 07:14:05 INFO - PROCESS | 1968 | 1455722045589 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] 07:16:15 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49708/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49708/tests/dromaeo/cssquery-ext.html) 07:16:17 INFO - PROCESS | 1968 | RSS: Main: 368070656 07:16:17 INFO - PROCESS | 1968 | 07:19:20 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49708/tests/dromaeo/cssquery-ext.html (next: http://localhost:49708/tests/dromaeo/cssquery-jquery.html) 07:19:20 INFO - PROCESS | 1968 | RSS: Main: 382517248 07:19:20 INFO - PROCESS | 1968 | 07:22:23 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49708/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49708/tests/dromaeo/cssquery-mootools.html) 07:22:23 INFO - PROCESS | 1968 | RSS: Main: 379588608 07:22:23 INFO - PROCESS | 1968 | 07:25:25 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49708/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49708/tests/dromaeo/cssquery-prototype.html) 07:25:26 INFO - PROCESS | 1968 | RSS: Main: 335970304 07:25:26 INFO - PROCESS | 1968 | 07:28:29 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49708/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49708/tests/dromaeo/cssquery-yui.html) 07:28:30 INFO - PROCESS | 1968 | RSS: Main: 340959232 07:28:30 INFO - PROCESS | 1968 | 07:31:32 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49708/tests/dromaeo/cssquery-yui.html (next: http://localhost:49708/tests/dromaeo/cssquery-dojo.html) 07:31:33 INFO - PROCESS | 1968 | RSS: Main: 383172608 07:31:33 INFO - PROCESS | 1968 | 07:31:33 INFO - PROCESS | 1968 | __start_tp_report 07:31:33 INFO - PROCESS | 1968 | _x_x_mozilla_page_load 07:31:33 INFO - PROCESS | 1968 | _x_x_mozilla_page_load_details 07:31:33 INFO - PROCESS | 1968 | |i|pagename|runs| 07:31:33 INFO - PROCESS | 1968 | |0;dojo.html;2834.3055951291935;3501.807400592968;3511.771734837234;3517.665821746934;3573.4282514797637;5618.15727640854;5702.800401985931;5712.428757124296;5718.113692377683;5737.053386191284;5702.087665973445;5736.082226843695;5800.709964501779;5875.588708790376;5918;5123.462036486171;5167.509086636764;5195.922061169085;5199.402068762084;5284.180951952434;5316.787328506855;5323.9467605324035;5367.463253674621;5375.139977603584;5425.403205647375;5052.8484145475695;5119.769610367543;5163.328767260251;5213.061648903196;5223.320968274138;5219.686818790885;5250.18622113573;5250.81622143227;5254.816081437131;5275.947240527622;4264.87205383839;5114.948850511484;5197.194434862602;5205.323307969978;5210.166373380241;5571.66570005801;5663.49028587425;5672.00739870521;5734.4265573442735;5785.884282314372;6241.78153764616;6265.498760099181;6272.78045268418;6274.968625156891;6278.560500764948;6158.815235542941;6246.87506249877;6306.87386252277;6323.430891219812;6326.905096423558;5041.798328066836;5773.076307790733;5804.535637149018;5817.912731308991;5829.504492118175;6217.9689101555105;6255.906161407583;6256.874862502725;6262.467690246289;6275.3724627537795;6130.938690613037;6182.938170618326;6189.876202475925;6194.628322300677;6206.937930620727;6298.842528936813;6304.810855674337;6307.590006649553;6318.304986451487;6328.240611126695;6133.877322453526;6162.383761623892;6196.1635179251125;6244.687765611701;6254.249490061131;6231.376862313823;6245.687715614292;6270.717817698214;6284.12022316876;6294.716737746812;4879.926801097987;4927.359443272351;4930.728809915489;4942.629302802305;4963.45402005779;4341;4345.782710864444;4456.376107344974;4468.910621787546;4494.505604383515;5762.394948530427;5776.220210271644;5776.422357764274;5779.739911703983;5796.652200867961;6304.306526282106;6312.968435157794;6317.778877739257;6321.683915804191;6347.143135676624;5604.355499117653;5724.484796368347;5727.455891690282;5810.854728631733;5824.679642619697;5374.54316383104;5378.811741589026;5380.569554435636;5397.433269506724;5398.028354896078;6216.44052035319;6351.174347334817;6361.2048493938255;6377.107204991212;6388;6218.253809542703;6223.688815559294;6335.429811317003;6356.9046464304;6361.968190159019;6330.778422755181;6338.334474880071;6355.269144048493;6358.141650877073;6358.1734374531015;6125.173101631222;6188.845278868064;6219.036049412348;6267.341929097379;6284.968575157095;6218.191635087591;6264.655443950626;6316.368363163647;6321.11504389395;6326.746930122928;6162.7534898605345;6179.69101544912;6182.938170618237;6193.4425901669065;6199.876002480015;5346.893062138814;5445.074337362578;6116.8776624468155;6178.1350610913605;6203.596766210182;6031.396860313934;6042.123892035543;6080.7567697291615;6084.543659225665;6087.360827113266;6084.211471232145;6160.414760597736;6163.506919446523;6168.969155154375;6173.84565385869;6001;6059.242594675666;6069.393060693896;6082.087686847009;6093.969530152321 07:31:33 INFO - PROCESS | 1968 | |1;ext.html;434.17506737199335;451.82830524400725;488.8680056384777;538.5718353908647;553.1840535210565;23630.5273894522;37411;37950.8102459488;37960.62039379605;37990.530615509975;40399.990000249934;40738.98152546188;40903;41031.974200644996;41069.79465102678;8823.382363234545;8965.95517022414;9346.345755797098;9586.281028922824;9588.99315571862;9482.431054136774;9616.182624476927;9618.182454491376;9631.759206019835;9741.366811157252;9677.129058384779;9763.414195148314;9775.853362199572;9777.31558790885;9782.657606983757;9672.80654386912;9748.75628109296;9764.023597640251;9766.218702503782;9767.023297670246;9532.142107210315;9657.613695452173;9668.468234247113;9671.758206044835;9719.125278724878;39039.21921561553;39486.60513394858;39596;39712.60287397118;39783.40324895129;3242.4974129010043;3382.7124694401004;3426.794392336468;3678.6137455567045;3679.558452985632;27843;28079.29801754952;28276.01033963822;29410.705892941012;29755;2361.9409514762096;2779.332960089584;2818.309514169021;2863.527517959534;2937.2363185571903;423664;426626;426835;426980.86509567563;427408;55131.44868551343;56148.43851561514;61594;61806.38193618006;61948.69025654843;53395.73302133464;53509.39471815852;53553.464465355624;68948.65525672339;69769;16029.839701602834;16188;16207.270672819752;16211.675766484841;16254.918725406535;12255.203411778206;12508.49966001368;12528.498860045496;12530.624081277576;12535.498580056877;17890.91054544745;19863.60272794536;19898.50253743668;20152.093155808023;20281.492962675755;7771.883421748678;8608.870866937;9291.442513449214;9320.580573874056;9321.394109383004;956.516958935733;1019.8827134879584;1037.3412882819464;1041.385582506325;1092.82514797632;29127.27181820429;29128.12615621535;29402.117936461942;29813.850930745208;29843;858.5578427110044;1062.389126252408;1116.3580940958818;1117.3463523838645;1150.1259043127284;13791.931040344734;14441.265894828426;14507.911906607047;14589.562313130624;14606.269686515845;665190;674073;674451;674572.254277451;677087;49091.75454122706;55902.44097558972;56528.43471565314;56691;56970;1305.5822136916474;1379.2345248387041;1381.2265131526378;1419.1556024165604;1426.1656930695451;26565.33586660349;27812.887484500392;27875.024374146808;28210.576841346985;28425.857870710515;44610.55389446064;45142.32286515639;45395.319070213314;51058.48941510686;51949.7402512985;357991;361094;363849;365100;367709;30887.845560772053;31184.844075779474;31250.21874453157;31300.53049204218;31320;40066.79966600148;40575.39136913008;40647.796761016005;40874.1825163501;41783;34960.475592865616;35651.035727388975;36061.45907811437;36066.45900311445;36305.45541816928;33544;34824;35248;35451.113722157155;35581.64418355783;34662.30675386528;35354.11614709653;35574.466383004794;35576.64423355733;35732.82133589315;29144;31105.222369440038;31114.37771244517;31153.32700094913;31211.84394078106;24104.035838566964;24256.39359015968;24276.02895884145;24358.75641243565;24506.264812055666 07:31:33 INFO - PROCESS | 1968 | |2;jquery.html;323.85426558048874;362.5323332900558;367.6580779874717;371.1908040471772;375.26635427738773;15659.686806263868;15745.212739363044;19193.808061919375;20031.998400079992;21192.04635791391;9606.423614583113;10129.69610911672;11976.940115299432;19096.61806763864;19777.110030048647;5143.614228932826;5324;5325.653832500894;5327.600429967749;5339.305890234265;3943.6056394360476;4111.095558977036;5289.920651190235;5323.494268044529;5683;5853.678047707374;5887.61730487517;5887.705614719268;5895.64626122434;5897.351291357947;5452.291202143716;5679.290088738908;5689.345725241588;5693.202951586781;5696.658200507983;5195.974020129913;5411.18832175173;5427.48438898304;5427.891442171174;5433.130699088127;12873.67815804603;13053.477860885554;20427.182912683475;20640.5871882563;24187;2137.6900349449243;2145.420736401163;2149.118861266873;2377.583922813518;2623.265485664017;9659.937406885238;9789.657361992367;9911.702648920544;9988.800223995479;10030.699079027641;1719.217755921053;1728.3345911823913;1745.3250222617912;1802.2520653928605;1808.3670715249557;101091;101097.97804043951;101397;101907.49046254795;102486.99999999926;10858.239923205458;11096.33421994683;11142.108631309477;11163.83254251187;11252.549898004152;13130.737385252241;13273.601791946257;13288.601341959757;13311.73376532464;13333.066685332127;8452.957735211285;8466.619002144795;8473.703420380258;8578.91421085781;8610.87083693745;8656.39405241627;8661.30709543235;8666.263367613697;8753.47479151253;8772.078931712205;4349.652027837766;4423.646108311327;4425.358323043205;4466.1514312281215;4482.148391805546;1619.4089157457443;1674.246589034915;1810.5745149889765;1860.8232217939274;1875.2873907915177;858.9312854971587;925.412363149405;976.5605477535138;1009.3086235928413;1026.3636545341935;14686.55940321792;19927.103280352418;20022.49943751389;20432.693509597368;20664.380068597966;861.5907443964066;921.2629896083241;934.1219253901311;962.7593101724569;966.2077096780713;10896.135927651507;11635.650930472098;11698.824517632242;11710.590129345432;11711.1802173847;478584;484177;487165;592416;782415;120031;121276;124255.08938927387;124775;125076;1127.9774404511863;1147.766151387262;1164.6564263542275;1176.1472932124314;1178.3401295274673;15291.311890964711;17213.397531086353;18055.638887222445;18338.08309584542;18563.071846407354;38566;51488.940442381885;51507.501262291305;52071.47928520818;52406.47593524016;69440.61118777697;72678;72902;73613.8957915621;73615.52768944699;7603.20166382544;7782.299593036654;7786.961065194638;7790.571518566533;7799.06411230656;8346.540940248344;9373.906260937303;9855.852162217428;11957.103217258566;12233.143679942319;9289.76775580589;10375.273730839072;10676.46617669098;10701.036906678124;10844.620438284623;10290.588376465157;10421;10612.840807387742;10722.356658600509;10791.56833726642;10792.730181745204;10849;10909.618163364561;11086.002259796656;11324.773504530029;5369.4093649697725;7787.143414224544;7846.843063138819;7849.607519623882;7860.978072850493;10236.48817559134;11032.117430605373;11040.116790656568;11166.497507612014;11232.83150752723 07:31:33 INFO - PROCESS | 1968 | |3;mootools.html;1209;1541.7687346897965;1556.252998560691;1802.9639407211848;1946.4258043877064;6563.901541476882;7940.6426710798005;8554.572271386429;8741.169588889054;9100.681476148337;8419.70531031414;8704.782380440476;8720.389572729911;8730.912690873089;8737.344699147558;2199.2082850173924;2244.7979681828633;2455.9877200614014;2481.888315025828;2482.4042229864795;2456.459578892641;2504.4615407687434;2507.761762632547;2507.8996840126374;2510.598304271317;2237.7985981261763;2302.735185453669;2374.596318625829;2428.64784606232;2435.721246345665;1925.7207704882715;2180.6183917814396;2387.116766796279;2457.803375729937;2490.8131890108225;2435.90256389746;2443.3861597438977;2464.137551856854;2469.32093674241;2474.987625061863;8754.649814007433;8828.735137945872;8831.116888311182;8844.11558844117;8848.557572121368;5350.38470575881;5445.891082178374;5455.754491047913;5465.07093794056;5491.862703432406;3538.681518663307;3635.381985062546;3670.46778217157;3682.3003629310347;3685.207680348738;1043.3948309980194;1047.3506426015842;1059.6503153959175;1077.2674581284723;1098.5880294889416;11956;12004.279743215347;12011.339376334297;12027.338496382696;12040.096992725494;4845.53967373099;4850.466448690641;4924.384451943507;4929.433115191799;4930.876728081755;10220.335678181043;10238.283320167517;10238.948805255926;10249.9487502562;10250.333728307636;5441.755121019563;5448.863778405572;5450.345958485007;5451.345838499326;5456.836294911159;4889.193283108319;4903.632227582945;4921.311016457699;4945.703257804544;4951.579115775199;3911.5110611173604;3933;3937.822797974098;3958.1687845552756;3994.72036957416;1285.2802430638872;1285.68500717323;1286.633309506786;1307.2940612069376;1307.895368370528;1032.9845052324222;1113.9832902506469;1131.3438205840594;1132.7338075552238;1292.4571679894466;7070.92929070713;7322.560646361128;8178.1821817817745;8368.497890126611;8383.203595658402;625.2965413909352;634.7397566997508;635.4725577770439;640.6124294801671;642.495640921874;6142.662153581507;6176.969115154486;6188.040853667599;6189.288231853305;6225.346338634468;10357.689269321932;10638.734031649115;10755.139588832875;10780.622678206382;10864.619738309122;10574.788504229873;10687.519061642244;10733.51699173539;10790.838137427945;10817.567297308176;8274.089850116483;8284.792880177924;8289.917100829036;8381.65893457044;8384.413091083565;7704.768856934301;7906.881396778937;7918.445708800328;7919.604019799102;7922.049354077548;7230.6384680766805;9511.524423778645;9578.521073946136;9625.903740962502;9765.462899540593;9552.95223523878;9685.41887486753;9812.65655702047;9861.556229969525;9873.160781333667;7426.74006409773;7441.739539116105;7487.438442116754;7548.282913123245;7571;8087.47431416956;8135.471194372347;8141.877871831809;8154.673813047411;8154.877676834971;7733.994580704472;7840.255175758294;7904.446688731734;7977.960110199412;7986.161453047346;7640.968469256579;7667.233276672288;7707.499012564165;7858.489198202098;7880.211978802303;7035.788926332219;7194.424446044409;7795.532268063935;7852.37181025528;7865.646045927832;6859.176898772179;6941.132358455193;6958.895616565655;6980.232174460703;7001.229864714979;7055.082839230867;7081.46888983318;7126.216116227314;7128.786136415916;7133.714651413885 07:31:33 INFO - PROCESS | 1968 | |4;prototype.html;313.888569557807;323.3226390711459;326.8104499390354;331.11757167149534;335.3226482505341;5418.7019713915715;6688.86622267555;6702.128723265981;6724.2267139279;6746.763863264793;6362.936370636292;6422.165118534595;6502.707378167982;6601.66991650418;6671.199456065279;4845.709257444547;4891.290762839386;4899.657024008321;4901.215805471125;4914.680545764514;4717.221658426355;4896.706197628154;4899.755012249391;4899.975500122495;4911.091448082098;3835.5972622874615;4773.498782627827;4811.326414302001;4843.24929635907;4861.975690121544;4806.927896081562;4844.5882100021545;4850.611951043908;4852.320675105488;4856.97571512142;4151.771652559108;4168.187203495319;4168.312228482297;4175.227582897173;4187.078842654641;6219.129321894939;6355.269144048401;6438.259600145996;6470.320616335264;6474.74101035958;5850.882982340329;5869.970650146722;5872.412758724094;5883.146943693183;5907.852303692442;5762.279715035621;7145;7147.928520714779;7163.1762347330205;7172.246914074051;4740.881477963044;4752.691075080109;4759.262314341283;4764.690295130806;4769.070031343889;7327.487075904689;7601.923980760177;7621.80945476362;7632.236776322379;7639.312461878458;4637.60580350674;4672.836450724209;4677.789499472532;4680.438347398266;4687.812487500461;3999.9400008999887;4489.540899207771;4717.481077081518;4717.481077081518;4731.976340118277;4886.902261954812;5407.324084489439;5525.033119204123;5666.886662266732;5696.715164241771;7203.531770434905;7204.675789589481;7215.458840586977;7215.747448839265;7227.457940654472;1626.1462732065525;1651.3559711712442;1652.4629495413799;1653.421302544124;1655.809581898073;1034.7568321444455;1051.6634676903318;1054.5887104029434;1064.7657515346611;1071.6999240212754;5918.615290006136;6461.386168314003;6739.359760822714;6744.460443164535;6749.156355455568;7115.750948716874;7238.493305468567;7425.368843648243;7440.367568756608;7448.888266676005;6311.526635502356;6665.833354166185;6673.797646776552;6675.7997260082275;6748.122744043341;3954.130091379892;3985.1631157456677;3990.38149086892;3999.7000224983244;3999.9800000999808;6779.35596118368;6839.179298484114;7874.72438464651;7893.842123157505;7894.526328420313;7500.437467189982;7748.806279842936;7762.379009679212;7765.883511747328;7792.220777922163;7828.099768526692;7831.569263690438;7834.059912810613;7845.529268243924;7845.646945887449;7497.62511874415;7498.962505187439;7506.24937506245;7507.812304692427;7531.623418828927;7125.251848555827;7390.29792169743;7398.889016664647;7403.444741644506;7408.259174082764;7429.33136017761;7619.390448763975;7865.381924314879;7867.291943725092;7870.803229919298;4690.437147542317;4711.717296962193;4722.5513576210205;4724.976375118103;4725.149473094739;6300.9684951574945;7361.006264154271;7462;7462.179160292472;7475.588842613708;6107.236595425572;7012;7361.969324294496;7392.186859445349;7398.630068496661;6972.1981972071835;7186.568805871664;7196.676149573177;7207.279272072751;7217.566945983258;7015.649217539205;7018.017477553045;7022.6488675565;7022.929770702228;7082.822929426806;6908.93091069103;7025.367716905503;7040.331168538981;7183.784486465414;7186.10173728284;7072.83298255782;7077.893831592633;7116.573005619679;7117.537360071578;7131.322524360177 07:31:33 INFO - PROCESS | 1968 | |5;yui.html;670.8893032649612;723.9529430587012;734.823642325842;737.6274981134526;760.7641631094361;14646.267686615667;14852.33164507597;14855.331510082045;14861.331240094209;14889.181095039768;13088.73822523549;13782;13929.30353482327;13930.582082537514;13988;705.7706245470217;712.6650474277108;838.9706360277391;849.9970035358275;859.4370687199863;748.8427430239656;829.8423698939976;864.446754077391;866.2204016385241;867.5662168915542;911.9361644684875;912.885889263842;912.9729054813336;913.1735779119907;915.3318077803208;730.9853802923939;736.7716008037498;891.242443922667;906.2885634776669;907.5190149220923;667.7629441548229;669.2036476592839;670.7853486884198;672.4418732452102;675.9864802703968;14697.706045879022;14748.262586870613;14749.852501475063;14764.63088422798;14773.482928097465;10997.790243073256;11792.646220613395;12189.451474683661;12234.938825305906;12359.62921112359;10131.848022279672;10176.834703623785;10199.337043092175;10220;10221.488925553693;3511.6839484446523;3537.451694987281;3543.273628906094;3549.1304630365466;3549.4498352755363;82328.58835705843;83164.58417707933;84198.15801842026;85264.57367713183;86138;9518.571664275125;9522.381045232038;9556.95221523888;9587.904120958841;9927.652532161339;20978.89510552468;21122.683159752614;21134.577308454052;21370.358889233346;21388;7476.476646634684;7631.847363052819;7809.735176798778;7845.176256492986;7915.010623672041;4036.65688416482;4070.816813243411;4090.9772556860785;4106.260873042821;4122.0107174278555;3620.8913732588067;3654.634536546377;3666.2484190740834;3669.9633003670156;3671.9265614688093;683.8769021576064;693.9826504337432;712.398023669998;713.105053158283;718.741253148866;587.9660949500557;598.9131575921554;616.3682225718675;628.9276733175743;629.4177885455935;8218.876716849252;8657.653693852175;8658.177473140042;8730.476171429735;8894.199522043047;500.5045005444584;512.5156726893125;539.5063516882009;541.7697478571591;578.4071326889972;3826.6747326477002;3890.630390112935;3990.1221731219084;4022.879313620596;4101.118259574206;81956.18043819486;88633.55683221671;88906.11093888979;93255.53372233095;94612;70688.6465567669;71523.2847671527;71993.64003180055;73567;74829.6258518704;68846;69528.65235673891;69710.65144674346;70287;73243.63378183075;8968.68609598661;8969.37214394986;8988.775280618036;9041.502717350346;9081.59132839037;52538.94922101613;52883.4711652894;53104;53144.202836956705;53765;69478;74739;75471.62264188644;76718;77070;10745.091433356094;11027.338359698444;11055.668329950115;11335.829962550733;11943.641690749291;10110.19118470506;10407.751069871663;12390;12395.814062789246;12813.359332033548;11040.889591104307;11313.151513636345;11642.883571164519;11696.824547631622;12377.876221238033;10604.416757078434;10794;11478.368689721812;11620.186586938833;12263.877361226274;7432;10722.410267435365;11204.49579768896;11521.711957201138;11609.825852612386;9540.284478664267;9858.457784821616;9899.752506187402;9903.950480247553;10202.948985255027;9146.268298536233;9314.20829229523;9625.422474651543;9995.550200241152;10112.089911907964 07:31:33 INFO - PROCESS | 1968 | __end_tp_report 07:31:33 INFO - PROCESS | 1968 | __start_cc_report 07:31:33 INFO - PROCESS | 1968 | _x_x_mozilla_cycle_collect,1172 07:31:33 INFO - PROCESS | 1968 | __end_cc_report 07:31:33 INFO - PROCESS | 1968 | __startTimestamp1455723093233__endTimestamp 07:31:33 INFO - PROCESS | 1968 | 07:31:33 INFO - PROCESS | 1968 | ------- Summary: start ------- 07:31:33 INFO - PROCESS | 1968 | Number of tests: 6 07:31:33 INFO - PROCESS | 1968 | 07:31:33 INFO - PROCESS | 1968 | [#0] dojo.html Cycles:165 Average:5767.39 Median:6080.76 stddev:663.95 (10.9%) stddev-sans-first:624.85 07:31:33 INFO - PROCESS | 1968 | Values: 2834.3 3501.8 3511.8 3517.7 3573.4 5618.2 5702.8 5712.4 5718.1 5737.1 5702.1 5736.1 5800.7 5875.6 5918.0 5123.5 5167.5 5195.9 5199.4 5284.2 5316.8 5323.9 5367.5 5375.1 5425.4 5052.8 5119.8 5163.3 5213.1 5223.3 5219.7 5250.2 5250.8 5254.8 5275.9 4264.9 5114.9 5197.2 5205.3 5210.2 5571.7 5663.5 5672.0 5734.4 5785.9 6241.8 6265.5 6272.8 6275.0 6278.6 6158.8 6246.9 6306.9 6323.4 6326.9 5041.8 5773.1 5804.5 5817.9 5829.5 6218.0 6255.9 6256.9 6262.5 6275.4 6130.9 6182.9 6189.9 6194.6 6206.9 6298.8 6304.8 6307.6 6318.3 6328.2 6133.9 6162.4 6196.2 6244.7 6254.2 6231.4 6245.7 6270.7 6284.1 6294.7 4879.9 4927.4 4930.7 4942.6 4963.5 4341.0 4345.8 4456.4 4468.9 4494.5 5762.4 5776.2 5776.4 5779.7 5796.7 6304.3 6313.0 6317.8 6321.7 6347.1 5604.4 5724.5 5727.5 5810.9 5824.7 5374.5 5378.8 5380.6 5397.4 5398.0 6216.4 6351.2 6361.2 6377.1 6388.0 6218.3 6223.7 6335.4 6356.9 6362.0 6330.8 6338.3 6355.3 6358.1 6358.2 6125.2 6188.8 6219.0 6267.3 6285.0 6218.2 6264.7 6316.4 6321.1 6326.7 6162.8 6179.7 6182.9 6193.4 6199.9 5346.9 5445.1 6116.9 6178.1 6203.6 6031.4 6042.1 6080.8 6084.5 6087.4 6084.2 6160.4 6163.5 6169.0 6173.8 6001.0 6059.2 6069.4 6082.1 6094.0 07:31:33 INFO - PROCESS | 1968 | 07:31:33 INFO - PROCESS | 1968 | [#1] ext.html Cycles:180 Average:62458.32 Median:366404.50 stddev:135280.66 (36.9%) stddev-sans-first:135580.00 07:31:33 INFO - PROCESS | 1968 | Values: 434.2 451.8 488.9 538.6 553.2 23630.5 37411.0 37950.8 37960.6 37990.5 40400.0 40739.0 40903.0 41032.0 41069.8 8823.4 8966.0 9346.3 9586.3 9589.0 9482.4 9616.2 9618.2 9631.8 9741.4 9677.1 9763.4 9775.9 9777.3 9782.7 9672.8 9748.8 9764.0 9766.2 9767.0 9532.1 9657.6 9668.5 9671.8 9719.1 39039.2 39486.6 39596.0 39712.6 39783.4 3242.5 3382.7 3426.8 3678.6 3679.6 27843.0 28079.3 28276.0 29410.7 29755.0 2361.9 2779.3 2818.3 2863.5 2937.2 423664.0 426626.0 426835.0 426980.9 427408.0 55131.4 56148.4 61594.0 61806.4 61948.7 53395.7 53509.4 53553.5 68948.7 69769.0 16029.8 16188.0 16207.3 16211.7 16254.9 12255.2 12508.5 12528.5 12530.6 12535.5 17890.9 19863.6 19898.5 20152.1 20281.5 7771.9 8608.9 9291.4 9320.6 9321.4 956.5 1019.9 1037.3 1041.4 1092.8 29127.3 29128.1 29402.1 29813.9 29843.0 858.6 1062.4 1116.4 1117.3 1150.1 13791.9 14441.3 14507.9 14589.6 14606.3 665190.0 674073.0 674451.0 674572.3 677087.0 49091.8 55902.4 56528.4 56691.0 56970.0 1305.6 1379.2 1381.2 1419.2 1426.2 26565.3 27812.9 27875.0 28210.6 28425.9 44610.6 45142.3 45395.3 51058.5 51949.7 357991.0 361094.0 363849.0 365100.0 367709.0 30887.8 31184.8 31250.2 31300.5 31320.0 40066.8 40575.4 40647.8 40874.2 41783.0 34960.5 35651.0 36061.5 36066.5 36305.5 33544.0 34824.0 35248.0 35451.1 35581.6 34662.3 35354.1 35574.5 35576.6 35732.8 29144.0 31105.2 31114.4 31153.3 31211.8 24104.0 24256.4 24276.0 24358.8 24506.3 07:31:33 INFO - PROCESS | 1968 | 07:31:33 INFO - PROCESS | 1968 | [#2] jquery.html Cycles:180 Average:32519.13 Median:13282.29 stddev:96159.67 (724.0%) stddev-sans-first:96399.04 07:31:33 INFO - PROCESS | 1968 | Values: 323.9 362.5 367.7 371.2 375.3 15659.7 15745.2 19193.8 20032.0 21192.0 9606.4 10129.7 11976.9 19096.6 19777.1 5143.6 5324.0 5325.7 5327.6 5339.3 3943.6 4111.1 5289.9 5323.5 5683.0 5853.7 5887.6 5887.7 5895.6 5897.4 5452.3 5679.3 5689.3 5693.2 5696.7 5196.0 5411.2 5427.5 5427.9 5433.1 12873.7 13053.5 20427.2 20640.6 24187.0 2137.7 2145.4 2149.1 2377.6 2623.3 9659.9 9789.7 9911.7 9988.8 10030.7 1719.2 1728.3 1745.3 1802.3 1808.4 101091.0 101098.0 101397.0 101907.5 102487.0 10858.2 11096.3 11142.1 11163.8 11252.5 13130.7 13273.6 13288.6 13311.7 13333.1 8453.0 8466.6 8473.7 8578.9 8610.9 8656.4 8661.3 8666.3 8753.5 8772.1 4349.7 4423.6 4425.4 4466.2 4482.1 1619.4 1674.2 1810.6 1860.8 1875.3 858.9 925.4 976.6 1009.3 1026.4 14686.6 19927.1 20022.5 20432.7 20664.4 861.6 921.3 934.1 962.8 966.2 10896.1 11635.7 11698.8 11710.6 11711.2 478584.0 484177.0 487165.0 592416.0 782415.0 120031.0 121276.0 124255.1 124775.0 125076.0 1128.0 1147.8 1164.7 1176.1 1178.3 15291.3 17213.4 18055.6 18338.1 18563.1 38566.0 51488.9 51507.5 52071.5 52406.5 69440.6 72678.0 72902.0 73613.9 73615.5 7603.2 7782.3 7787.0 7790.6 7799.1 8346.5 9373.9 9855.9 11957.1 12233.1 9289.8 10375.3 10676.5 10701.0 10844.6 10290.6 10421.0 10612.8 10722.4 10791.6 10792.7 10849.0 10909.6 11086.0 11324.8 5369.4 7787.1 7846.8 7849.6 7861.0 10236.5 11032.1 11040.1 11166.5 11232.8 07:31:33 INFO - PROCESS | 1968 | 07:31:33 INFO - PROCESS | 1968 | [#3] mootools.html Cycles:180 Average:6037.45 Median:5453.55 stddev:3217.88 (59.0%) stddev-sans-first:3206.44 07:31:33 INFO - PROCESS | 1968 | Values: 1209.0 1541.8 1556.3 1803.0 1946.4 6563.9 7940.6 8554.6 8741.2 9100.7 8419.7 8704.8 8720.4 8730.9 8737.3 2199.2 2244.8 2456.0 2481.9 2482.4 2456.5 2504.5 2507.8 2507.9 2510.6 2237.8 2302.7 2374.6 2428.6 2435.7 1925.7 2180.6 2387.1 2457.8 2490.8 2435.9 2443.4 2464.1 2469.3 2475.0 8754.6 8828.7 8831.1 8844.1 8848.6 5350.4 5445.9 5455.8 5465.1 5491.9 3538.7 3635.4 3670.5 3682.3 3685.2 1043.4 1047.4 1059.7 1077.3 1098.6 11956.0 12004.3 12011.3 12027.3 12040.1 4845.5 4850.5 4924.4 4929.4 4930.9 10220.3 10238.3 10238.9 10249.9 10250.3 5441.8 5448.9 5450.3 5451.3 5456.8 4889.2 4903.6 4921.3 4945.7 4951.6 3911.5 3933.0 3937.8 3958.2 3994.7 1285.3 1285.7 1286.6 1307.3 1307.9 1033.0 1114.0 1131.3 1132.7 1292.5 7070.9 7322.6 8178.2 8368.5 8383.2 625.3 634.7 635.5 640.6 642.5 6142.7 6177.0 6188.0 6189.3 6225.3 10357.7 10638.7 10755.1 10780.6 10864.6 10574.8 10687.5 10733.5 10790.8 10817.6 8274.1 8284.8 8289.9 8381.7 8384.4 7704.8 7906.9 7918.4 7919.6 7922.0 7230.6 9511.5 9578.5 9625.9 9765.5 9553.0 9685.4 9812.7 9861.6 9873.2 7426.7 7441.7 7487.4 7548.3 7571.0 8087.5 8135.5 8141.9 8154.7 8154.9 7734.0 7840.3 7904.4 7978.0 7986.2 7641.0 7667.2 7707.5 7858.5 7880.2 7035.8 7194.4 7795.5 7852.4 7865.6 6859.2 6941.1 6958.9 6980.2 7001.2 7055.1 7081.5 7126.2 7128.8 7133.7 07:31:33 INFO - PROCESS | 1968 | 07:31:33 INFO - PROCESS | 1968 | [#4] prototype.html Cycles:180 Average:5836.18 Median:6633.75 stddev:1888.86 (28.5%) stddev-sans-first:1848.12 07:31:33 INFO - PROCESS | 1968 | Values: 313.9 323.3 326.8 331.1 335.3 5418.7 6688.9 6702.1 6724.2 6746.8 6362.9 6422.2 6502.7 6601.7 6671.2 4845.7 4891.3 4899.7 4901.2 4914.7 4717.2 4896.7 4899.8 4900.0 4911.1 3835.6 4773.5 4811.3 4843.2 4862.0 4806.9 4844.6 4850.6 4852.3 4857.0 4151.8 4168.2 4168.3 4175.2 4187.1 6219.1 6355.3 6438.3 6470.3 6474.7 5850.9 5870.0 5872.4 5883.1 5907.9 5762.3 7145.0 7147.9 7163.2 7172.2 4740.9 4752.7 4759.3 4764.7 4769.1 7327.5 7601.9 7621.8 7632.2 7639.3 4637.6 4672.8 4677.8 4680.4 4687.8 3999.9 4489.5 4717.5 4717.5 4732.0 4886.9 5407.3 5525.0 5666.9 5696.7 7203.5 7204.7 7215.5 7215.7 7227.5 1626.1 1651.4 1652.5 1653.4 1655.8 1034.8 1051.7 1054.6 1064.8 1071.7 5918.6 6461.4 6739.4 6744.5 6749.2 7115.8 7238.5 7425.4 7440.4 7448.9 6311.5 6665.8 6673.8 6675.8 6748.1 3954.1 3985.2 3990.4 3999.7 4000.0 6779.4 6839.2 7874.7 7893.8 7894.5 7500.4 7748.8 7762.4 7765.9 7792.2 7828.1 7831.6 7834.1 7845.5 7845.6 7497.6 7499.0 7506.2 7507.8 7531.6 7125.3 7390.3 7398.9 7403.4 7408.3 7429.3 7619.4 7865.4 7867.3 7870.8 4690.4 4711.7 4722.6 4725.0 4725.1 6301.0 7361.0 7462.0 7462.2 7475.6 6107.2 7012.0 7362.0 7392.2 7398.6 6972.2 7186.6 7196.7 7207.3 7217.6 7015.6 7018.0 7022.6 7022.9 7082.8 6908.9 7025.4 7040.3 7183.8 7186.1 7072.8 7077.9 7116.6 7117.5 7131.3 07:31:33 INFO - PROCESS | 1968 | 07:31:33 INFO - PROCESS | 1968 | [#5] yui.html Cycles:180 Average:18434.26 Median:648.59 stddev:25904.78 (3994.0%) stddev-sans-first:25943.11 07:31:33 INFO - PROCESS | 1968 | Values: 670.9 724.0 734.8 737.6 760.8 14646.3 14852.3 14855.3 14861.3 14889.2 13088.7 13782.0 13929.3 13930.6 13988.0 705.8 712.7 839.0 850.0 859.4 748.8 829.8 864.4 866.2 867.6 911.9 912.9 913.0 913.2 915.3 731.0 736.8 891.2 906.3 907.5 667.8 669.2 670.8 672.4 676.0 14697.7 14748.3 14749.9 14764.6 14773.5 10997.8 11792.6 12189.5 12234.9 12359.6 10131.8 10176.8 10199.3 10220.0 10221.5 3511.7 3537.5 3543.3 3549.1 3549.4 82328.6 83164.6 84198.2 85264.6 86138.0 9518.6 9522.4 9557.0 9587.9 9927.7 20978.9 21122.7 21134.6 21370.4 21388.0 7476.5 7631.8 7809.7 7845.2 7915.0 4036.7 4070.8 4091.0 4106.3 4122.0 3620.9 3654.6 3666.2 3670.0 3671.9 683.9 694.0 712.4 713.1 718.7 588.0 598.9 616.4 628.9 629.4 8218.9 8657.7 8658.2 8730.5 8894.2 500.5 512.5 539.5 541.8 578.4 3826.7 3890.6 3990.1 4022.9 4101.1 81956.2 88633.6 88906.1 93255.5 94612.0 70688.6 71523.3 71993.6 73567.0 74829.6 68846.0 69528.7 69710.7 70287.0 73243.6 8968.7 8969.4 8988.8 9041.5 9081.6 52538.9 52883.5 53104.0 53144.2 53765.0 69478.0 74739.0 75471.6 76718.0 77070.0 10745.1 11027.3 11055.7 11335.8 11943.6 10110.2 10407.8 12390.0 12395.8 12813.4 11040.9 11313.2 11642.9 11696.8 12377.9 10604.4 10794.0 11478.4 11620.2 12263.9 7432.0 10722.4 11204.5 11521.7 11609.8 9540.3 9858.5 9899.8 9904.0 10202.9 9146.3 9314.2 9625.4 9995.6 10112.1 07:31:33 INFO - PROCESS | 1968 | -------- Summary: end -------- 07:31:33 INFO - PROCESS | 1968 | 07:31:33 INFO - TEST-INFO | 1968: exit 0 07:31:33 INFO - TEST-OK | dromaeo_css | took 1114023ms 07:31:33 INFO - TEST-START | kraken 07:31:33 INFO - operating with platform_type : mac_ 07:31:33 INFO - Initialising browser for kraken test... 07:31:33 INFO - TEST-INFO | started process 1971 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/tmphykhB2/profile http://localhost:49708/getInfo.html) 07:31:35 INFO - PROCESS | 1971 | __metrics Screen width/height:1600/1200 07:31:35 INFO - PROCESS | 1971 | colorDepth:24 07:31:35 INFO - PROCESS | 1971 | Browser inner width/height: 1024/689 07:31:35 INFO - PROCESS | 1971 | __metrics 07:31:36 INFO - PROCESS | 1971 | 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" 07:31:36 INFO - PROCESS | 1971 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:31:36 INFO - TEST-INFO | 1971: exit 0 07:31:36 INFO - Browser initialized. 07:31:36 INFO - Running cycle 1/1 for kraken test... 07:31:36 INFO - TEST-INFO | started process 1973 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/tmphykhB2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:31:48 INFO - PROCESS | 1973 | RSS: Main: 244387840 07:31:48 INFO - PROCESS | 1973 | 07:31:51 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:49708/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49708/tests/kraken/driver.html?testName=audio-beat-detection) 07:31:51 INFO - PROCESS | 1973 | RSS: Main: 290476032 07:31:51 INFO - PROCESS | 1973 | 07:31:54 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:49708/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49708/tests/kraken/driver.html?testName=audio-dft) 07:31:55 INFO - PROCESS | 1973 | RSS: Main: 300998656 07:31:55 INFO - PROCESS | 1973 | 07:31:58 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:49708/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49708/tests/kraken/driver.html?testName=audio-fft) 07:31:59 INFO - PROCESS | 1973 | RSS: Main: 289214464 07:31:59 INFO - PROCESS | 1973 | 07:32:00 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:49708/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49708/tests/kraken/driver.html?testName=audio-oscillator) 07:32:01 INFO - PROCESS | 1973 | RSS: Main: 289476608 07:32:01 INFO - PROCESS | 1973 | 07:32:03 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:49708/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49708/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:32:04 INFO - PROCESS | 1973 | RSS: Main: 291966976 07:32:04 INFO - PROCESS | 1973 | 07:32:06 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:49708/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49708/tests/kraken/driver.html?testName=imaging-darkroom) 07:32:07 INFO - PROCESS | 1973 | RSS: Main: 290541568 07:32:07 INFO - PROCESS | 1973 | 07:32:10 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:49708/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49708/tests/kraken/driver.html?testName=imaging-desaturate) 07:32:11 INFO - PROCESS | 1973 | RSS: Main: 292831232 07:32:11 INFO - PROCESS | 1973 | 07:32:13 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:49708/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49708/tests/kraken/driver.html?testName=json-parse-financial) 07:32:14 INFO - PROCESS | 1973 | RSS: Main: 293605376 07:32:14 INFO - PROCESS | 1973 | 07:32:16 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:49708/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49708/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:32:16 INFO - PROCESS | 1973 | RSS: Main: 325492736 07:32:16 INFO - PROCESS | 1973 | 07:32:18 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:49708/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49708/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:32:19 INFO - PROCESS | 1973 | RSS: Main: 326496256 07:32:19 INFO - PROCESS | 1973 | 07:32:21 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:49708/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49708/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:32:21 INFO - PROCESS | 1973 | RSS: Main: 333058048 07:32:21 INFO - PROCESS | 1973 | 07:32:24 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:49708/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49708/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:32:24 INFO - PROCESS | 1973 | RSS: Main: 333819904 07:32:24 INFO - PROCESS | 1973 | 07:32:27 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:49708/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49708/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:32:27 INFO - PROCESS | 1973 | RSS: Main: 333565952 07:32:27 INFO - PROCESS | 1973 | 07:32:29 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:49708/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49708/tests/kraken/driver.html?testName=ai-astar) 07:32:29 INFO - PROCESS | 1973 | RSS: Main: 394067968 07:32:29 INFO - PROCESS | 1973 | 07:32:29 INFO - PROCESS | 1973 | __start_tp_report 07:32:29 INFO - PROCESS | 1973 | _x_x_mozilla_page_load 07:32:29 INFO - PROCESS | 1973 | _x_x_mozilla_page_load_details 07:32:29 INFO - PROCESS | 1973 | |i|pagename|runs| 07:32:29 INFO - PROCESS | 1973 | |0;ai-astar;109;108;110;109;117;161;168;111;110;109 07:32:29 INFO - PROCESS | 1973 | |1;audio-beat-detection;162;146;177;153;127;172;169;147;160;119 07:32:29 INFO - PROCESS | 1973 | |2;audio-dft;184;182;186;185;184;192;179;183;182;182 07:32:29 INFO - PROCESS | 1973 | |3;audio-fft;79;72;89;75;56;56;58;78;77;57 07:32:29 INFO - PROCESS | 1973 | |4;audio-oscillator;90;102;130;78;80;80;105;77;77;104 07:32:29 INFO - PROCESS | 1973 | |5;imaging-gaussian-blur;89;93;88;93;87;93;86;94;87;94 07:32:29 INFO - PROCESS | 1973 | |6;imaging-darkroom;128;151;142;96;95;94;94;95;97;96 07:32:29 INFO - PROCESS | 1973 | |7;imaging-desaturate;85;85;82;86;87;85;84;86;86;85 07:32:29 INFO - PROCESS | 1973 | |8;json-parse-financial;55;56;55;53;54;55;53;64;54;75 07:32:29 INFO - PROCESS | 1973 | |9;json-stringify-tinderbox;64;71;70;75;70;71;66;67;67;91 07:32:29 INFO - PROCESS | 1973 | |10;stanford-crypto-aes;83;83;81;82;83;79;84;82;81;83 07:32:29 INFO - PROCESS | 1973 | |11;stanford-crypto-ccm;122;127;127;126;123;130;128;122;119;126 07:32:29 INFO - PROCESS | 1973 | |12;stanford-crypto-pbkdf2;126;126;140;138;138;126;137;138;134;138 07:32:29 INFO - PROCESS | 1973 | |13;stanford-crypto-sha256-iterative;67;66;66;66;68;67;67;67;66;66 07:32:29 INFO - PROCESS | 1973 | __end_tp_report 07:32:29 INFO - PROCESS | 1973 | __start_cc_report 07:32:29 INFO - PROCESS | 1973 | _x_x_mozilla_cycle_collect,1151 07:32:29 INFO - PROCESS | 1973 | __end_cc_report 07:32:29 INFO - PROCESS | 1973 | __startTimestamp1455723149814__endTimestamp 07:32:29 INFO - PROCESS | 1973 | 07:32:29 INFO - PROCESS | 1973 | ------- Summary: start ------- 07:32:29 INFO - PROCESS | 1973 | Number of tests: 14 07:32:29 INFO - PROCESS | 1973 | 07:32:29 INFO - PROCESS | 1973 | [#0] ai-astar Cycles:10 Average:121.20 Median:110.50 stddev:23.02 (20.8%) stddev-sans-first:23.98 07:32:29 INFO - PROCESS | 1973 | Values: 109.0 108.0 110.0 109.0 117.0 161.0 168.0 111.0 110.0 109.0 07:32:29 INFO - PROCESS | 1973 | 07:32:29 INFO - PROCESS | 1973 | [#1] audio-beat-detection Cycles:10 Average:153.20 Median:161.00 stddev:18.97 (11.8%) stddev-sans-first:19.85 07:32:29 INFO - PROCESS | 1973 | Values: 162.0 146.0 177.0 153.0 127.0 172.0 169.0 147.0 160.0 119.0 07:32:29 INFO - PROCESS | 1973 | 07:32:29 INFO - PROCESS | 1973 | [#2] audio-dft Cycles:10 Average:183.90 Median:184.00 stddev:3.45 (1.9%) stddev-sans-first:3.66 07:32:29 INFO - PROCESS | 1973 | Values: 184.0 182.0 186.0 185.0 184.0 192.0 179.0 183.0 182.0 182.0 07:32:29 INFO - PROCESS | 1973 | 07:32:29 INFO - PROCESS | 1973 | [#3] audio-fft Cycles:10 Average:69.70 Median:76.00 stddev:11.96 (15.7%) stddev-sans-first:12.21 07:32:29 INFO - PROCESS | 1973 | Values: 79.0 72.0 89.0 75.0 56.0 56.0 58.0 78.0 77.0 57.0 07:32:29 INFO - PROCESS | 1973 | 07:32:29 INFO - PROCESS | 1973 | [#4] audio-oscillator Cycles:10 Average:92.30 Median:77.50 stddev:17.62 (22.7%) stddev-sans-first:18.67 07:32:29 INFO - PROCESS | 1973 | Values: 90.0 102.0 130.0 78.0 80.0 80.0 105.0 77.0 77.0 104.0 07:32:29 INFO - PROCESS | 1973 | 07:32:29 INFO - PROCESS | 1973 | [#5] imaging-gaussian-blur Cycles:10 Average:90.40 Median:93.00 stddev:3.27 (3.5%) stddev-sans-first:3.43 07:32:29 INFO - PROCESS | 1973 | Values: 89.0 93.0 88.0 93.0 87.0 93.0 86.0 94.0 87.0 94.0 07:32:29 INFO - PROCESS | 1973 | 07:32:29 INFO - PROCESS | 1973 | [#6] imaging-darkroom Cycles:10 Average:108.80 Median:95.00 stddev:22.45 (23.6%) stddev-sans-first:22.72 07:32:29 INFO - PROCESS | 1973 | Values: 128.0 151.0 142.0 96.0 95.0 94.0 94.0 95.0 97.0 96.0 07:32:29 INFO - PROCESS | 1973 | 07:32:29 INFO - PROCESS | 1973 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.50 stddev:1.37 (1.6%) stddev-sans-first:1.45 07:32:29 INFO - PROCESS | 1973 | Values: 85.0 85.0 82.0 86.0 87.0 85.0 84.0 86.0 86.0 85.0 07:32:29 INFO - PROCESS | 1973 | 07:32:29 INFO - PROCESS | 1973 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:55.00 stddev:6.95 (12.6%) stddev-sans-first:7.31 07:32:29 INFO - PROCESS | 1973 | Values: 55.0 56.0 55.0 53.0 54.0 55.0 53.0 64.0 54.0 75.0 07:32:29 INFO - PROCESS | 1973 | 07:32:29 INFO - PROCESS | 1973 | [#9] json-stringify-tinderbox Cycles:10 Average:71.20 Median:70.50 stddev:7.63 (10.8%) stddev-sans-first:7.63 07:32:29 INFO - PROCESS | 1973 | Values: 64.0 71.0 70.0 75.0 70.0 71.0 66.0 67.0 67.0 91.0 07:32:29 INFO - PROCESS | 1973 | 07:32:29 INFO - PROCESS | 1973 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:83.00 stddev:1.45 (1.7%) stddev-sans-first:1.50 07:32:29 INFO - PROCESS | 1973 | Values: 83.0 83.0 81.0 82.0 83.0 79.0 84.0 82.0 81.0 83.0 07:32:29 INFO - PROCESS | 1973 | 07:32:29 INFO - PROCESS | 1973 | [#11] stanford-crypto-ccm Cycles:10 Average:125.00 Median:126.50 stddev:3.37 (2.7%) stddev-sans-first:3.39 07:32:29 INFO - PROCESS | 1973 | Values: 122.0 127.0 127.0 126.0 123.0 130.0 128.0 122.0 119.0 126.0 07:32:29 INFO - PROCESS | 1973 | 07:32:29 INFO - PROCESS | 1973 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:134.10 Median:138.00 stddev:5.78 (4.2%) stddev-sans-first:5.34 07:32:29 INFO - PROCESS | 1973 | Values: 126.0 126.0 140.0 138.0 138.0 126.0 137.0 138.0 134.0 138.0 07:32:29 INFO - PROCESS | 1973 | 07:32:29 INFO - PROCESS | 1973 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 07:32:29 INFO - PROCESS | 1973 | Values: 67.0 66.0 66.0 66.0 68.0 67.0 67.0 67.0 66.0 66.0 07:32:29 INFO - PROCESS | 1973 | -------- Summary: end -------- 07:32:29 INFO - PROCESS | 1973 | 07:32:30 INFO - TEST-INFO | 1973: exit 0 07:32:30 INFO - TEST-OK | kraken | took 56902ms 07:32:30 INFO - SUITE-END | took 1170s 07:32:30 INFO - Completed test suite (00:19:31) 07:32:30 INFO - Working with test: dromaeo_css 07:32:30 INFO - Generating results file: dromaeo_css 07:32:30 INFO - Working with test: kraken 07:32:30 INFO - Generating results file: kraken 07:32:30 INFO - javascript benchmark 07:32:30 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:32:31 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 07:32:31 INFO - process_Request line: dromaeo_css 7450.21 graph.html#tests=[[72,64,59]] 07:32:31 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:32:31 INFO - process_Request line: kraken 1441.00 graph.html#tests=[[232,64,59]] 07:32:31 INFO - RETURN: dromaeo_css: 7450.21 07:32:31 INFO - RETURN: kraken: 1441.00 07:32:31 INFO - javascript benchmark 07:32:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2834.3055951291935, 3501.807400592968, 3511.771734837234, 3517.665821746934, 3573.4282514797637, 5618.15727640854, 5702.800401985931, 5712.428757124296, 5718.113692377683, 5737.053386191284, 5702.087665973445, 5736.082226843695, 5800.709964501779, 5875.588708790376, 5918.0, 5123.462036486171, 5167.509086636764, 5195.922061169085, 5199.402068762084, 5284.180951952434, 5316.787328506855, 5323.9467605324035, 5367.463253674621, 5375.139977603584, 5425.403205647375, 5052.8484145475695, 5119.769610367543, 5163.328767260251, 5213.061648903196, 5223.320968274138, 5219.686818790885, 5250.18622113573, 5250.81622143227, 5254.816081437131, 5275.947240527622, 4264.87205383839, 5114.948850511484, 5197.194434862602, 5205.323307969978, 5210.166373380241, 5571.66570005801, 5663.49028587425, 5672.00739870521, 5734.4265573442735, 5785.884282314372, 6241.78153764616, 6265.498760099181, 6272.78045268418, 6274.968625156891, 6278.560500764948, 6158.815235542941, 6246.87506249877, 6306.87386252277, 6323.430891219812, 6326.905096423558, 5041.798328066836, 5773.076307790733, 5804.535637149018, 5817.912731308991, 5829.504492118175, 6217.9689101555105, 6255.906161407583, 6256.874862502725, 6262.467690246289, 6275.3724627537795, 6130.938690613037, 6182.938170618326, 6189.876202475925, 6194.628322300677, 6206.937930620727, 6298.842528936813, 6304.810855674337, 6307.590006649553, 6318.304986451487, 6328.240611126695, 6133.877322453526, 6162.383761623892, 6196.1635179251125, 6244.687765611701, 6254.249490061131, 6231.376862313823, 6245.687715614292, 6270.717817698214, 6284.12022316876, 6294.716737746812, 4879.926801097987, 4927.359443272351, 4930.728809915489, 4942.629302802305, 4963.45402005779, 4341.0, 4345.782710864444, 4456.376107344974, 4468.910621787546, 4494.505604383515, 5762.394948530427, 5776.220210271644, 5776.422357764274, 5779.739911703983, 5796.652200867961, 6304.306526282106, 6312.968435157794, 6317.778877739257, 6321.683915804191, 6347.143135676624, 5604.355499117653, 5724.484796368347, 5727.455891690282, 5810.854728631733, 5824.679642619697, 5374.54316383104, 5378.811741589026, 5380.569554435636, 5397.433269506724, 5398.028354896078, 6216.44052035319, 6351.174347334817, 6361.2048493938255, 6377.107204991212, 6388.0, 6218.253809542703, 6223.688815559294, 6335.429811317003, 6356.9046464304, 6361.968190159019, 6330.778422755181, 6338.334474880071, 6355.269144048493, 6358.141650877073, 6358.1734374531015, 6125.173101631222, 6188.845278868064, 6219.036049412348, 6267.341929097379, 6284.968575157095, 6218.191635087591, 6264.655443950626, 6316.368363163647, 6321.11504389395, 6326.746930122928, 6162.7534898605345, 6179.69101544912, 6182.938170618237, 6193.4425901669065, 6199.876002480015, 5346.893062138814, 5445.074337362578, 6116.8776624468155, 6178.1350610913605, 6203.596766210182, 6031.396860313934, 6042.123892035543, 6080.7567697291615, 6084.543659225665, 6087.360827113266, 6084.211471232145, 6160.414760597736, 6163.506919446523, 6168.969155154375, 6173.84565385869, 6001.0, 6059.242594675666, 6069.393060693896, 6082.087686847009, 6093.969530152321], "unit": "score", "name": "dojo.html", "value": 5723.97993194463}, {"lowerIsBetter": false, "replicates": [434.17506737199335, 451.82830524400725, 488.8680056384777, 538.5718353908647, 553.1840535210565, 23630.5273894522, 37411.0, 37950.8102459488, 37960.62039379605, 37990.530615509975, 40399.990000249934, 40738.98152546188, 40903.0, 41031.974200644996, 41069.79465102678, 8823.382363234545, 8965.95517022414, 9346.345755797098, 9586.281028922824, 9588.99315571862, 9482.431054136774, 9616.182624476927, 9618.182454491376, 9631.759206019835, 9741.366811157252, 9677.129058384779, 9763.414195148314, 9775.853362199572, 9777.31558790885, 9782.657606983757, 9672.80654386912, 9748.75628109296, 9764.023597640251, 9766.218702503782, 9767.023297670246, 9532.142107210315, 9657.613695452173, 9668.468234247113, 9671.758206044835, 9719.125278724878, 39039.21921561553, 39486.60513394858, 39596.0, 39712.60287397118, 39783.40324895129, 3242.4974129010043, 3382.7124694401004, 3426.794392336468, 3678.6137455567045, 3679.558452985632, 27843.0, 28079.29801754952, 28276.01033963822, 29410.705892941012, 29755.0, 2361.9409514762096, 2779.332960089584, 2818.309514169021, 2863.527517959534, 2937.2363185571903, 423664.0, 426626.0, 426835.0, 426980.86509567563, 427408.0, 55131.44868551343, 56148.43851561514, 61594.0, 61806.38193618006, 61948.69025654843, 53395.73302133464, 53509.39471815852, 53553.464465355624, 68948.65525672339, 69769.0, 16029.839701602834, 16188.0, 16207.270672819752, 16211.675766484841, 16254.918725406535, 12255.203411778206, 12508.49966001368, 12528.498860045496, 12530.624081277576, 12535.498580056877, 17890.91054544745, 19863.60272794536, 19898.50253743668, 20152.093155808023, 20281.492962675755, 7771.883421748678, 8608.870866937, 9291.442513449214, 9320.580573874056, 9321.394109383004, 956.516958935733, 1019.8827134879584, 1037.3412882819464, 1041.385582506325, 1092.82514797632, 29127.27181820429, 29128.12615621535, 29402.117936461942, 29813.850930745208, 29843.0, 858.5578427110044, 1062.389126252408, 1116.3580940958818, 1117.3463523838645, 1150.1259043127284, 13791.931040344734, 14441.265894828426, 14507.911906607047, 14589.562313130624, 14606.269686515845, 665190.0, 674073.0, 674451.0, 674572.254277451, 677087.0, 49091.75454122706, 55902.44097558972, 56528.43471565314, 56691.0, 56970.0, 1305.5822136916474, 1379.2345248387041, 1381.2265131526378, 1419.1556024165604, 1426.1656930695451, 26565.33586660349, 27812.887484500392, 27875.024374146808, 28210.576841346985, 28425.857870710515, 44610.55389446064, 45142.32286515639, 45395.319070213314, 51058.48941510686, 51949.7402512985, 357991.0, 361094.0, 363849.0, 365100.0, 367709.0, 30887.845560772053, 31184.844075779474, 31250.21874453157, 31300.53049204218, 31320.0, 40066.79966600148, 40575.39136913008, 40647.796761016005, 40874.1825163501, 41783.0, 34960.475592865616, 35651.035727388975, 36061.45907811437, 36066.45900311445, 36305.45541816928, 33544.0, 34824.0, 35248.0, 35451.113722157155, 35581.64418355783, 34662.30675386528, 35354.11614709653, 35574.466383004794, 35576.64423355733, 35732.82133589315, 29144.0, 31105.222369440038, 31114.37771244517, 31153.32700094913, 31211.84394078106, 24104.035838566964, 24256.39359015968, 24276.02895884145, 24358.75641243565, 24506.264812055666], "unit": "score", "name": "ext.html", "value": 19205.96520785873}, {"lowerIsBetter": false, "replicates": [323.85426558048874, 362.5323332900558, 367.6580779874717, 371.1908040471772, 375.26635427738773, 15659.686806263868, 15745.212739363044, 19193.808061919375, 20031.998400079992, 21192.04635791391, 9606.423614583113, 10129.69610911672, 11976.940115299432, 19096.61806763864, 19777.110030048647, 5143.614228932826, 5324.0, 5325.653832500894, 5327.600429967749, 5339.305890234265, 3943.6056394360476, 4111.095558977036, 5289.920651190235, 5323.494268044529, 5683.0, 5853.678047707374, 5887.61730487517, 5887.705614719268, 5895.64626122434, 5897.351291357947, 5452.291202143716, 5679.290088738908, 5689.345725241588, 5693.202951586781, 5696.658200507983, 5195.974020129913, 5411.18832175173, 5427.48438898304, 5427.891442171174, 5433.130699088127, 12873.67815804603, 13053.477860885554, 20427.182912683475, 20640.5871882563, 24187.0, 2137.6900349449243, 2145.420736401163, 2149.118861266873, 2377.583922813518, 2623.265485664017, 9659.937406885238, 9789.657361992367, 9911.702648920544, 9988.800223995479, 10030.699079027641, 1719.217755921053, 1728.3345911823913, 1745.3250222617912, 1802.2520653928605, 1808.3670715249557, 101091.0, 101097.97804043951, 101397.0, 101907.49046254795, 102486.99999999926, 10858.239923205458, 11096.33421994683, 11142.108631309477, 11163.83254251187, 11252.549898004152, 13130.737385252241, 13273.601791946257, 13288.601341959757, 13311.73376532464, 13333.066685332127, 8452.957735211285, 8466.619002144795, 8473.703420380258, 8578.91421085781, 8610.87083693745, 8656.39405241627, 8661.30709543235, 8666.263367613697, 8753.47479151253, 8772.078931712205, 4349.652027837766, 4423.646108311327, 4425.358323043205, 4466.1514312281215, 4482.148391805546, 1619.4089157457443, 1674.246589034915, 1810.5745149889765, 1860.8232217939274, 1875.2873907915177, 858.9312854971587, 925.412363149405, 976.5605477535138, 1009.3086235928413, 1026.3636545341935, 14686.55940321792, 19927.103280352418, 20022.49943751389, 20432.693509597368, 20664.380068597966, 861.5907443964066, 921.2629896083241, 934.1219253901311, 962.7593101724569, 966.2077096780713, 10896.135927651507, 11635.650930472098, 11698.824517632242, 11710.590129345432, 11711.1802173847, 478584.0, 484177.0, 487165.0, 592416.0, 782415.0, 120031.0, 121276.0, 124255.08938927387, 124775.0, 125076.0, 1127.9774404511863, 1147.766151387262, 1164.6564263542275, 1176.1472932124314, 1178.3401295274673, 15291.311890964711, 17213.397531086353, 18055.638887222445, 18338.08309584542, 18563.071846407354, 38566.0, 51488.940442381885, 51507.501262291305, 52071.47928520818, 52406.47593524016, 69440.61118777697, 72678.0, 72902.0, 73613.8957915621, 73615.52768944699, 7603.20166382544, 7782.299593036654, 7786.961065194638, 7790.571518566533, 7799.06411230656, 8346.540940248344, 9373.906260937303, 9855.852162217428, 11957.103217258566, 12233.143679942319, 9289.76775580589, 10375.273730839072, 10676.46617669098, 10701.036906678124, 10844.620438284623, 10290.588376465157, 10421.0, 10612.840807387742, 10722.356658600509, 10791.56833726642, 10792.730181745204, 10849.0, 10909.618163364561, 11086.002259796656, 11324.773504530029, 5369.4093649697725, 7787.143414224544, 7846.843063138819, 7849.607519623882, 7860.978072850493, 10236.48817559134, 11032.117430605373, 11040.116790656568, 11166.497507612014, 11232.83150752723], "unit": "score", "name": "jquery.html", "value": 8981.699110956893}, {"lowerIsBetter": false, "replicates": [1209.0, 1541.7687346897965, 1556.252998560691, 1802.9639407211848, 1946.4258043877064, 6563.901541476882, 7940.6426710798005, 8554.572271386429, 8741.169588889054, 9100.681476148337, 8419.70531031414, 8704.782380440476, 8720.389572729911, 8730.912690873089, 8737.344699147558, 2199.2082850173924, 2244.7979681828633, 2455.9877200614014, 2481.888315025828, 2482.4042229864795, 2456.459578892641, 2504.4615407687434, 2507.761762632547, 2507.8996840126374, 2510.598304271317, 2237.7985981261763, 2302.735185453669, 2374.596318625829, 2428.64784606232, 2435.721246345665, 1925.7207704882715, 2180.6183917814396, 2387.116766796279, 2457.803375729937, 2490.8131890108225, 2435.90256389746, 2443.3861597438977, 2464.137551856854, 2469.32093674241, 2474.987625061863, 8754.649814007433, 8828.735137945872, 8831.116888311182, 8844.11558844117, 8848.557572121368, 5350.38470575881, 5445.891082178374, 5455.754491047913, 5465.07093794056, 5491.862703432406, 3538.681518663307, 3635.381985062546, 3670.46778217157, 3682.3003629310347, 3685.207680348738, 1043.3948309980194, 1047.3506426015842, 1059.6503153959175, 1077.2674581284723, 1098.5880294889416, 11956.0, 12004.279743215347, 12011.339376334297, 12027.338496382696, 12040.096992725494, 4845.53967373099, 4850.466448690641, 4924.384451943507, 4929.433115191799, 4930.876728081755, 10220.335678181043, 10238.283320167517, 10238.948805255926, 10249.9487502562, 10250.333728307636, 5441.755121019563, 5448.863778405572, 5450.345958485007, 5451.345838499326, 5456.836294911159, 4889.193283108319, 4903.632227582945, 4921.311016457699, 4945.703257804544, 4951.579115775199, 3911.5110611173604, 3933.0, 3937.822797974098, 3958.1687845552756, 3994.72036957416, 1285.2802430638872, 1285.68500717323, 1286.633309506786, 1307.2940612069376, 1307.895368370528, 1032.9845052324222, 1113.9832902506469, 1131.3438205840594, 1132.7338075552238, 1292.4571679894466, 7070.92929070713, 7322.560646361128, 8178.1821817817745, 8368.497890126611, 8383.203595658402, 625.2965413909352, 634.7397566997508, 635.4725577770439, 640.6124294801671, 642.495640921874, 6142.662153581507, 6176.969115154486, 6188.040853667599, 6189.288231853305, 6225.346338634468, 10357.689269321932, 10638.734031649115, 10755.139588832875, 10780.622678206382, 10864.619738309122, 10574.788504229873, 10687.519061642244, 10733.51699173539, 10790.838137427945, 10817.567297308176, 8274.089850116483, 8284.792880177924, 8289.917100829036, 8381.65893457044, 8384.413091083565, 7704.768856934301, 7906.881396778937, 7918.445708800328, 7919.604019799102, 7922.049354077548, 7230.6384680766805, 9511.524423778645, 9578.521073946136, 9625.903740962502, 9765.462899540593, 9552.95223523878, 9685.41887486753, 9812.65655702047, 9861.556229969525, 9873.160781333667, 7426.74006409773, 7441.739539116105, 7487.438442116754, 7548.282913123245, 7571.0, 8087.47431416956, 8135.471194372347, 8141.877871831809, 8154.673813047411, 8154.877676834971, 7733.994580704472, 7840.255175758294, 7904.446688731734, 7977.960110199412, 7986.161453047346, 7640.968469256579, 7667.233276672288, 7707.499012564165, 7858.489198202098, 7880.211978802303, 7035.788926332219, 7194.424446044409, 7795.532268063935, 7852.37181025528, 7865.646045927832, 6859.176898772179, 6941.132358455193, 6958.895616565655, 6980.232174460703, 7001.229864714979, 7055.082839230867, 7081.46888983318, 7126.216116227314, 7128.786136415916, 7133.714651413885], "unit": "score", "name": "mootools.html", "value": 4840.61696890665}, {"lowerIsBetter": false, "replicates": [313.888569557807, 323.3226390711459, 326.8104499390354, 331.11757167149534, 335.3226482505341, 5418.7019713915715, 6688.86622267555, 6702.128723265981, 6724.2267139279, 6746.763863264793, 6362.936370636292, 6422.165118534595, 6502.707378167982, 6601.66991650418, 6671.199456065279, 4845.709257444547, 4891.290762839386, 4899.657024008321, 4901.215805471125, 4914.680545764514, 4717.221658426355, 4896.706197628154, 4899.755012249391, 4899.975500122495, 4911.091448082098, 3835.5972622874615, 4773.498782627827, 4811.326414302001, 4843.24929635907, 4861.975690121544, 4806.927896081562, 4844.5882100021545, 4850.611951043908, 4852.320675105488, 4856.97571512142, 4151.771652559108, 4168.187203495319, 4168.312228482297, 4175.227582897173, 4187.078842654641, 6219.129321894939, 6355.269144048401, 6438.259600145996, 6470.320616335264, 6474.74101035958, 5850.882982340329, 5869.970650146722, 5872.412758724094, 5883.146943693183, 5907.852303692442, 5762.279715035621, 7145.0, 7147.928520714779, 7163.1762347330205, 7172.246914074051, 4740.881477963044, 4752.691075080109, 4759.262314341283, 4764.690295130806, 4769.070031343889, 7327.487075904689, 7601.923980760177, 7621.80945476362, 7632.236776322379, 7639.312461878458, 4637.60580350674, 4672.836450724209, 4677.789499472532, 4680.438347398266, 4687.812487500461, 3999.9400008999887, 4489.540899207771, 4717.481077081518, 4717.481077081518, 4731.976340118277, 4886.902261954812, 5407.324084489439, 5525.033119204123, 5666.886662266732, 5696.715164241771, 7203.531770434905, 7204.675789589481, 7215.458840586977, 7215.747448839265, 7227.457940654472, 1626.1462732065525, 1651.3559711712442, 1652.4629495413799, 1653.421302544124, 1655.809581898073, 1034.7568321444455, 1051.6634676903318, 1054.5887104029434, 1064.7657515346611, 1071.6999240212754, 5918.615290006136, 6461.386168314003, 6739.359760822714, 6744.460443164535, 6749.156355455568, 7115.750948716874, 7238.493305468567, 7425.368843648243, 7440.367568756608, 7448.888266676005, 6311.526635502356, 6665.833354166185, 6673.797646776552, 6675.7997260082275, 6748.122744043341, 3954.130091379892, 3985.1631157456677, 3990.38149086892, 3999.7000224983244, 3999.9800000999808, 6779.35596118368, 6839.179298484114, 7874.72438464651, 7893.842123157505, 7894.526328420313, 7500.437467189982, 7748.806279842936, 7762.379009679212, 7765.883511747328, 7792.220777922163, 7828.099768526692, 7831.569263690438, 7834.059912810613, 7845.529268243924, 7845.646945887449, 7497.62511874415, 7498.962505187439, 7506.24937506245, 7507.812304692427, 7531.623418828927, 7125.251848555827, 7390.29792169743, 7398.889016664647, 7403.444741644506, 7408.259174082764, 7429.33136017761, 7619.390448763975, 7865.381924314879, 7867.291943725092, 7870.803229919298, 4690.437147542317, 4711.717296962193, 4722.5513576210205, 4724.976375118103, 4725.149473094739, 6300.9684951574945, 7361.006264154271, 7462.0, 7462.179160292472, 7475.588842613708, 6107.236595425572, 7012.0, 7361.969324294496, 7392.186859445349, 7398.630068496661, 6972.1981972071835, 7186.568805871664, 7196.676149573177, 7207.279272072751, 7217.566945983258, 7015.649217539205, 7018.017477553045, 7022.6488675565, 7022.929770702228, 7082.822929426806, 6908.93091069103, 7025.367716905503, 7040.331168538981, 7183.784486465414, 7186.10173728284, 7072.83298255782, 7077.893831592633, 7116.573005619679, 7117.537360071578, 7131.322524360177], "unit": "score", "name": "prototype.html", "value": 5201.3401773740325}, {"lowerIsBetter": false, "replicates": [670.8893032649612, 723.9529430587012, 734.823642325842, 737.6274981134526, 760.7641631094361, 14646.267686615667, 14852.33164507597, 14855.331510082045, 14861.331240094209, 14889.181095039768, 13088.73822523549, 13782.0, 13929.30353482327, 13930.582082537514, 13988.0, 705.7706245470217, 712.6650474277108, 838.9706360277391, 849.9970035358275, 859.4370687199863, 748.8427430239656, 829.8423698939976, 864.446754077391, 866.2204016385241, 867.5662168915542, 911.9361644684875, 912.885889263842, 912.9729054813336, 913.1735779119907, 915.3318077803208, 730.9853802923939, 736.7716008037498, 891.242443922667, 906.2885634776669, 907.5190149220923, 667.7629441548229, 669.2036476592839, 670.7853486884198, 672.4418732452102, 675.9864802703968, 14697.706045879022, 14748.262586870613, 14749.852501475063, 14764.63088422798, 14773.482928097465, 10997.790243073256, 11792.646220613395, 12189.451474683661, 12234.938825305906, 12359.62921112359, 10131.848022279672, 10176.834703623785, 10199.337043092175, 10220.0, 10221.488925553693, 3511.6839484446523, 3537.451694987281, 3543.273628906094, 3549.1304630365466, 3549.4498352755363, 82328.58835705843, 83164.58417707933, 84198.15801842026, 85264.57367713183, 86138.0, 9518.571664275125, 9522.381045232038, 9556.95221523888, 9587.904120958841, 9927.652532161339, 20978.89510552468, 21122.683159752614, 21134.577308454052, 21370.358889233346, 21388.0, 7476.476646634684, 7631.847363052819, 7809.735176798778, 7845.176256492986, 7915.010623672041, 4036.65688416482, 4070.816813243411, 4090.9772556860785, 4106.260873042821, 4122.0107174278555, 3620.8913732588067, 3654.634536546377, 3666.2484190740834, 3669.9633003670156, 3671.9265614688093, 683.8769021576064, 693.9826504337432, 712.398023669998, 713.105053158283, 718.741253148866, 587.9660949500557, 598.9131575921554, 616.3682225718675, 628.9276733175743, 629.4177885455935, 8218.876716849252, 8657.653693852175, 8658.177473140042, 8730.476171429735, 8894.199522043047, 500.5045005444584, 512.5156726893125, 539.5063516882009, 541.7697478571591, 578.4071326889972, 3826.6747326477002, 3890.630390112935, 3990.1221731219084, 4022.879313620596, 4101.118259574206, 81956.18043819486, 88633.55683221671, 88906.11093888979, 93255.53372233095, 94612.0, 70688.6465567669, 71523.2847671527, 71993.64003180055, 73567.0, 74829.6258518704, 68846.0, 69528.65235673891, 69710.65144674346, 70287.0, 73243.63378183075, 8968.68609598661, 8969.37214394986, 8988.775280618036, 9041.502717350346, 9081.59132839037, 52538.94922101613, 52883.4711652894, 53104.0, 53144.202836956705, 53765.0, 69478.0, 74739.0, 75471.62264188644, 76718.0, 77070.0, 10745.091433356094, 11027.338359698444, 11055.668329950115, 11335.829962550733, 11943.641690749291, 10110.19118470506, 10407.751069871663, 12390.0, 12395.814062789246, 12813.359332033548, 11040.889591104307, 11313.151513636345, 11642.883571164519, 11696.824547631622, 12377.876221238033, 10604.416757078434, 10794.0, 11478.368689721812, 11620.186586938833, 12263.877361226274, 7432.0, 10722.410267435365, 11204.49579768896, 11521.711957201138, 11609.825852612386, 9540.284478664267, 9858.457784821616, 9899.752506187402, 9903.950480247553, 10202.948985255027, 9146.268298536233, 9314.20829229523, 9625.422474651543, 9995.550200241152, 10112.089911907964], "unit": "score", "name": "yui.html", "value": 6878.07628728624}], "name": "dromaeo_css", "value": 7450.204428073203}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 108.0, 110.0, 109.0, 117.0, 161.0, 168.0, 111.0, 110.0, 109.0], "unit": "score", "name": "ai-astar", "value": 121.2}, {"lowerIsBetter": true, "replicates": [162.0, 146.0, 177.0, 153.0, 127.0, 172.0, 169.0, 147.0, 160.0, 119.0], "unit": "score", "name": "audio-beat-detection", "value": 153.2}, {"lowerIsBetter": true, "replicates": [184.0, 182.0, 186.0, 185.0, 184.0, 192.0, 179.0, 183.0, 182.0, 182.0], "unit": "score", "name": "audio-dft", "value": 183.9}, {"lowerIsBetter": true, "replicates": [79.0, 72.0, 89.0, 75.0, 56.0, 56.0, 58.0, 78.0, 77.0, 57.0], "unit": "score", "name": "audio-fft", "value": 69.7}, {"lowerIsBetter": true, "replicates": [90.0, 102.0, 130.0, 78.0, 80.0, 80.0, 105.0, 77.0, 77.0, 104.0], "unit": "score", "name": "audio-oscillator", "value": 92.3}, {"lowerIsBetter": true, "replicates": [89.0, 93.0, 88.0, 93.0, 87.0, 93.0, 86.0, 94.0, 87.0, 94.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 90.4}, {"lowerIsBetter": true, "replicates": [128.0, 151.0, 142.0, 96.0, 95.0, 94.0, 94.0, 95.0, 97.0, 96.0], "unit": "score", "name": "imaging-darkroom", "value": 108.8}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 82.0, 86.0, 87.0, 85.0, 84.0, 86.0, 86.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 85.1}, {"lowerIsBetter": true, "replicates": [55.0, 56.0, 55.0, 53.0, 54.0, 55.0, 53.0, 64.0, 54.0, 75.0], "unit": "score", "name": "json-parse-financial", "value": 57.4}, {"lowerIsBetter": true, "replicates": [64.0, 71.0, 70.0, 75.0, 70.0, 71.0, 66.0, 67.0, 67.0, 91.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 71.2}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 81.0, 82.0, 83.0, 79.0, 84.0, 82.0, 81.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.1}, {"lowerIsBetter": true, "replicates": [122.0, 127.0, 127.0, 126.0, 123.0, 130.0, 128.0, 122.0, 119.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.0}, {"lowerIsBetter": true, "replicates": [126.0, 126.0, 140.0, 138.0, 138.0, 126.0, 137.0, 138.0, 134.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 134.1}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 66.0, 66.0, 68.0, 67.0, 67.0, 67.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.6}], "name": "kraken", "value": 1440.9999999999995}]} 07:32:31 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1441.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7450.21"}}} 07:32:31 INFO - Return code: 0 07:32:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:32:31 INFO - # TBPL SUCCESS # 07:32:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:32:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:32:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:32:31 INFO - 2016-02-17 07:32:31.584 screenresolution[1977:16409] starting screenresolution argv=screenresolution get 07:32:31 INFO - 2016-02-17 07:32:31.587 screenresolution[1977:16409] Display 0: 1600x1200x32@60 07:32:31 INFO - 2016-02-17 07:32:31.593 screenresolution[1978:16412] starting screenresolution argv=screenresolution list 07:32:31 INFO - Available Modes on Display 0 07:32:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:32:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:32:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:32:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:32:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:32:31 INFO - Intel Iris: 07:32:31 INFO - Chipset Model: Intel Iris 07:32:31 INFO - Type: GPU 07:32:31 INFO - Bus: Built-In 07:32:31 INFO - VRAM (Dynamic, Max): 1536 MB 07:32:31 INFO - Vendor: Intel (0x8086) 07:32:31 INFO - Device ID: 0x0a2e 07:32:31 INFO - Revision ID: 0x0009 07:32:31 INFO - Displays: 07:32:31 INFO - Display: 07:32:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:32:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:32:31 INFO - Display Serial Number: 1600x1200 60 07:32:31 INFO - Main Display: Yes 07:32:31 INFO - Mirror: Off 07:32:31 INFO - Online: Yes 07:32:31 INFO - Rotation: Supported 07:32:31 INFO - Return code: 0 07:32:31 INFO - Running post-action listener: _resource_record_post_action 07:32:31 INFO - Running post-run listener: _resource_record_post_run 07:32:32 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 2347008; Write bytes: 708387840; Read time: 34; Write time: 2128 07:32:32 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 390937088; Write bytes: 386390016; Read time: 29491; Write time: 859 07:32:32 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 2347008; Write bytes: 298546176; Read time: 34; Write time: 1216 07:32:32 INFO - Running post-run listener: _upload_blobber_files 07:32:32 INFO - Blob upload gear active. 07:32:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:32:32 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 07:32:32 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'] 07:32:32 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 07:32:33 INFO - (blobuploader) - INFO - Open directory for files ... 07:32:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:32:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:32:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:32:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:32:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:32:34 INFO - (blobuploader) - INFO - Done attempting. 07:32:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:32:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:32:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:32:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:32:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:32:35 INFO - (blobuploader) - INFO - Done attempting. 07:32:35 INFO - (blobuploader) - INFO - Iteration through files over. 07:32:35 INFO - Return code: 0 07:32:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:32:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:32:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/92608bdf0170f7c0e64e868c12d4a040f5af9f564cd99df48af6c0bb957ccabf167bc3795f7eeeed4ee820acb310cd01743059373f069be5d2ce83263c0063ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/75d81d27fd544892264ded10653e2fa863973c1a6f97549d9b9b49d7b881f2d20aaad8c25717417a38b81ea1a5860afa7e4c5becbbeced69add2a642ff88f8ee"} 07:32:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:32:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:32:35 INFO - Contents: 07:32:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/92608bdf0170f7c0e64e868c12d4a040f5af9f564cd99df48af6c0bb957ccabf167bc3795f7eeeed4ee820acb310cd01743059373f069be5d2ce83263c0063ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/75d81d27fd544892264ded10653e2fa863973c1a6f97549d9b9b49d7b881f2d20aaad8c25717417a38b81ea1a5860afa7e4c5becbbeced69add2a642ff88f8ee"} 07:32:35 INFO - Running post-run listener: copy_logs_to_upload_dir 07:32:35 INFO - Copying logs to upload dir... 07:32:35 INFO - mkdir: /builds/slave/test/build/upload/logs 07:32:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1280.126397 ========= master_lag: 0.74 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-02-17 07:32:36.330015) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 2 mins, 20 secs) (at 2016-02-17 07:32:36.334276) ========= 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.5v2lTH4nWf/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.r29JHfJEc2/Listeners TMPDIR=/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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/92608bdf0170f7c0e64e868c12d4a040f5af9f564cd99df48af6c0bb957ccabf167bc3795f7eeeed4ee820acb310cd01743059373f069be5d2ce83263c0063ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/75d81d27fd544892264ded10653e2fa863973c1a6f97549d9b9b49d7b881f2d20aaad8c25717417a38b81ea1a5860afa7e4c5becbbeced69add2a642ff88f8ee"} build_url:https://queue.taskcluster.net/v1/task/LRBfrVPTRFaOgG0JeMzvwg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011260 build_url: 'https://queue.taskcluster.net/v1/task/LRBfrVPTRFaOgG0JeMzvwg/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/92608bdf0170f7c0e64e868c12d4a040f5af9f564cd99df48af6c0bb957ccabf167bc3795f7eeeed4ee820acb310cd01743059373f069be5d2ce83263c0063ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/75d81d27fd544892264ded10653e2fa863973c1a6f97549d9b9b49d7b881f2d20aaad8c25717417a38b81ea1a5860afa7e4c5becbbeced69add2a642ff88f8ee"}' ========= master_lag: 140.21 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 2 mins, 20 secs) (at 2016-02-17 07:34:56.557164) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-02-17 07:34:56.557475) ========= 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.5v2lTH4nWf/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.r29JHfJEc2/Listeners TMPDIR=/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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.005359 ========= master_lag: 4.21 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-02-17 07:35:00.768692) ========= ========= Started reboot skipped (results: 3, elapsed: 11 secs) (at 2016-02-17 07:35:00.772000) ========= ========= Finished reboot skipped (results: 3, elapsed: 11 secs) (at 2016-02-17 07:35:12.739784) ========= ========= Total master_lag: 145.33 =========