builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0130 starttime: 1455589626.63 results: success (0) buildid: 20160215172550 builduid: 0a335d23fe524cd4843a1636a9ea0bd2 revision: 1ba422314bc61c2cbf657f8c76ffff7e10a9082e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-15 18:27:06.626336) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-15 18:27:06.626791) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-15 18:27:06.630454) ========= 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.bXurAHNlMO/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.pF1wYHt0qf/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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.005718 basedir: '/builds/slave/test' ========= master_lag: 0.09 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-15 18:27:06.724103) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-15 18:27:06.724453) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-15 18:27:06.766762) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 18:27:06.767099) ========= 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.bXurAHNlMO/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.pF1wYHt0qf/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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.005318 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 18:27:06.827757) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-15 18:27:06.828059) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-15 18:27:06.828442) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 18:27:06.828763) ========= 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.bXurAHNlMO/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.pF1wYHt0qf/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-02-15 18:27:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 29.6M=0s 2016-02-15 18:27:07 (29.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.529279 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 18:27:07.377157) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 18:27:07.377527) ========= 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.bXurAHNlMO/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.pF1wYHt0qf/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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.019586 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 18:27:07.427058) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 18:27:07.427429) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1ba422314bc61c2cbf657f8c76ffff7e10a9082e --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 1ba422314bc61c2cbf657f8c76ffff7e10a9082e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bXurAHNlMO/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.pF1wYHt0qf/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-02-15 18:27:07,501 truncating revision to first 12 chars 2016-02-15 18:27:07,501 Setting DEBUG logging. 2016-02-15 18:27:07,501 attempt 1/10 2016-02-15 18:27:07,501 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1ba422314bc6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-15 18:27:08,128 unpacking tar archive at: fx-team-1ba422314bc6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.874416 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 18:27:08.317965) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-15 18:27:08.318330) ========= echo 1ba422314bc61c2cbf657f8c76ffff7e10a9082e in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'1ba422314bc61c2cbf657f8c76ffff7e10a9082e'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bXurAHNlMO/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.pF1wYHt0qf/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 1ba422314bc61c2cbf657f8c76ffff7e10a9082e program finished with exit code 0 elapsedTime=0.005446 script_repo_revision: '1ba422314bc61c2cbf657f8c76ffff7e10a9082e' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-15 18:27:08.368071) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-15 18:27:08.368413) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-15 18:27:08.382917) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-02-15 18:27:08.383627) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bXurAHNlMO/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.pF1wYHt0qf/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 18:27:08 INFO - MultiFileLogger online at 20160215 18:27:08 in /builds/slave/test 18:27:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 18:27:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:27:08 INFO - {'append_to_log': False, 18:27:08 INFO - 'base_work_dir': '/builds/slave/test', 18:27:08 INFO - 'blob_upload_branch': 'Fx-Team', 18:27:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:27:08 INFO - 'branch': 'Fx-Team', 18:27:08 INFO - 'buildbot_json_path': 'buildprops.json', 18:27:08 INFO - 'config_files': ('talos/mac_config.py',), 18:27:08 INFO - 'default_actions': ('clobber', 18:27:08 INFO - 'read-buildbot-config', 18:27:08 INFO - 'download-and-extract', 18:27:08 INFO - 'populate-webroot', 18:27:08 INFO - 'create-virtualenv', 18:27:08 INFO - 'install', 18:27:08 INFO - 'run-tests'), 18:27:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:27:08 INFO - 'download_minidump_stackwalk': True, 18:27:08 INFO - 'download_symbols': 'ondemand', 18:27:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:27:08 INFO - 'tooltool.py': '/tools/tooltool.py', 18:27:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:27:08 INFO - '/tools/misc-python/virtualenv.py')}, 18:27:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:27:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:27:08 INFO - 'installer_path': 'installer.exe', 18:27:08 INFO - 'log_level': 'info', 18:27:08 INFO - 'log_name': 'talos', 18:27:08 INFO - 'log_to_console': True, 18:27:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:27:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:27:08 INFO - 'opt_config_files': (), 18:27:08 INFO - 'pip_index': False, 18:27:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:27:08 INFO - 'cmd': ('bash', 18:27:08 INFO - '-c', 18:27:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:27:08 INFO - 'enabled': True, 18:27:08 INFO - 'halt_on_failure': False, 18:27:08 INFO - 'name': 'check_screen_resolution'},), 18:27:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:27:08 INFO - 'cmd': ('bash', 18:27:08 INFO - '-c', 18:27:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:27:08 INFO - 'enabled': True, 18:27:08 INFO - 'halt_on_failure': False, 18:27:08 INFO - 'name': 'check_screen_resolution'},), 18:27:08 INFO - 'run_cmd_checks_enabled': True, 18:27:08 INFO - 'sps_profile': False, 18:27:08 INFO - 'sps_profile_interval': 0, 18:27:08 INFO - 'suite': 'dromaeojs-e10s', 18:27:08 INFO - 'system_bits': '32', 18:27:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:27:08 INFO - 'title': 't-yosemite-r7-0130', 18:27:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:27:08 INFO - 'use_talos_json': True, 18:27:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:27:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:27:08 INFO - 'work_dir': 'build'} 18:27:08 INFO - ##### 18:27:08 INFO - ##### Running clobber step. 18:27:08 INFO - ##### 18:27:08 INFO - Running pre-action listener: _resource_record_pre_action 18:27:08 INFO - Running main action method: clobber 18:27:08 INFO - rmtree: /builds/slave/test/build 18:27:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:27:10 INFO - Running post-action listener: _resource_record_post_action 18:27:10 INFO - ##### 18:27:10 INFO - ##### Running read-buildbot-config step. 18:27:10 INFO - ##### 18:27:10 INFO - Running pre-action listener: _resource_record_pre_action 18:27:10 INFO - Running main action method: read_buildbot_config 18:27:10 INFO - Using buildbot properties: 18:27:10 INFO - { 18:27:10 INFO - "project": "", 18:27:10 INFO - "product": "firefox", 18:27:10 INFO - "script_repo_revision": "production", 18:27:10 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 18:27:10 INFO - "repository": "", 18:27:10 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 18:27:10 INFO - "buildid": "20160215172550", 18:27:10 INFO - "pgo_build": "False", 18:27:10 INFO - "basedir": "/builds/slave/test", 18:27:10 INFO - "buildnumber": 435, 18:27:10 INFO - "slavename": "t-yosemite-r7-0130", 18:27:10 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 18:27:10 INFO - "platform": "yosemite_r7", 18:27:10 INFO - "scheduler": "tests-fx-team-macosx64-talos", 18:27:10 INFO - "branch": "fx-team", 18:27:10 INFO - "repo_path": "integration/fx-team", 18:27:10 INFO - "revision": "1ba422314bc61c2cbf657f8c76ffff7e10a9082e", 18:27:10 INFO - "stage_platform": "macosx64", 18:27:10 INFO - "builduid": "0a335d23fe524cd4843a1636a9ea0bd2", 18:27:10 INFO - "slavebuilddir": "test" 18:27:10 INFO - } 18:27:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/CbdsflAUQIGGeBU2kDt50w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 18:27:10 INFO - Running post-action listener: _resource_record_post_action 18:27:10 INFO - ##### 18:27:10 INFO - ##### Running download-and-extract step. 18:27:10 INFO - ##### 18:27:10 INFO - Running pre-action listener: _resource_record_pre_action 18:27:10 INFO - Running main action method: download_and_extract 18:27:10 INFO - mkdir: /builds/slave/test/build/tests 18:27:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:27:10 INFO - https://queue.taskcluster.net/v1/task/CbdsflAUQIGGeBU2kDt50w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:27:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbdsflAUQIGGeBU2kDt50w/artifacts/public/build/test_packages.json 18:27:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbdsflAUQIGGeBU2kDt50w/artifacts/public/build/test_packages.json 18:27:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbdsflAUQIGGeBU2kDt50w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 18:27:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbdsflAUQIGGeBU2kDt50w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 18:27:11 INFO - Downloaded 1277 bytes. 18:27:11 INFO - Reading from file /builds/slave/test/build/test_packages.json 18:27:11 INFO - Using the following test package requirements: 18:27:11 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 18:27:11 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:27:11 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 18:27:11 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:27:11 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 18:27:11 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:27:11 INFO - u'jsshell-mac.zip'], 18:27:11 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:27:11 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 18:27:11 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 18:27:11 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:27:11 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 18:27:11 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:27:11 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 18:27:11 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:27:11 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 18:27:11 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 18:27:11 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:27:11 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 18:27:11 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:27:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:27:11 INFO - https://queue.taskcluster.net/v1/task/CbdsflAUQIGGeBU2kDt50w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:27:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbdsflAUQIGGeBU2kDt50w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 18:27:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbdsflAUQIGGeBU2kDt50w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 18:27:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbdsflAUQIGGeBU2kDt50w/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 18:27:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbdsflAUQIGGeBU2kDt50w/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 18:27:12 INFO - Downloaded 17802729 bytes. 18:27:12 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'] 18:27:12 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 18:27:15 INFO - Return code: 0 18:27:15 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 18:27:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:27:15 INFO - https://queue.taskcluster.net/v1/task/CbdsflAUQIGGeBU2kDt50w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:27:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbdsflAUQIGGeBU2kDt50w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 18:27:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbdsflAUQIGGeBU2kDt50w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 18:27:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbdsflAUQIGGeBU2kDt50w/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 18:27:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbdsflAUQIGGeBU2kDt50w/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 18:27:19 INFO - Downloaded 17802729 bytes. 18:27:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:27:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 18:27:22 INFO - Return code: 0 18:27:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:27:22 INFO - https://queue.taskcluster.net/v1/task/CbdsflAUQIGGeBU2kDt50w/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 18:27:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbdsflAUQIGGeBU2kDt50w/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 18:27:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbdsflAUQIGGeBU2kDt50w/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 18:27:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbdsflAUQIGGeBU2kDt50w/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 18:27:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbdsflAUQIGGeBU2kDt50w/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 18:27:23 INFO - Downloaded 10707070 bytes. 18:27:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:27:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 18:27:24 INFO - Return code: 0 18:27:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:27:24 INFO - https://queue.taskcluster.net/v1/task/CbdsflAUQIGGeBU2kDt50w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 18:27:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbdsflAUQIGGeBU2kDt50w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 18:27:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbdsflAUQIGGeBU2kDt50w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 18:27:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbdsflAUQIGGeBU2kDt50w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 18:27:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbdsflAUQIGGeBU2kDt50w/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 18:27:29 INFO - Downloaded 111145775 bytes. 18:27:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CbdsflAUQIGGeBU2kDt50w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 18:27:29 INFO - mkdir: /builds/slave/test/properties 18:27:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:27:29 INFO - Writing to file /builds/slave/test/properties/build_url 18:27:29 INFO - Contents: 18:27:29 INFO - build_url:https://queue.taskcluster.net/v1/task/CbdsflAUQIGGeBU2kDt50w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 18:27:30 INFO - Running post-action listener: _resource_record_post_action 18:27:30 INFO - Running post-action listener: set_extra_try_arguments 18:27:30 INFO - ##### 18:27:30 INFO - ##### Running populate-webroot step. 18:27:30 INFO - ##### 18:27:30 INFO - Running pre-action listener: _resource_record_pre_action 18:27:30 INFO - Running main action method: populate_webroot 18:27:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:27:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:27:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:27:30 INFO - '--tppagecycles', 18:27:30 INFO - '7'], 18:27:30 INFO - 'tests': ['tsvgm']}}, 18:27:30 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:27:30 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:27:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:27:30 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 18:27:30 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:27:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:27:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:27:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:27:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:27:30 INFO - 'talos_options': ['--e10s'], 18:27:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:27:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:27:30 INFO - 'tests': ['damp', 'tps']}, 18:27:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:27:30 INFO - 'talos_options': ['--e10s'], 18:27:30 INFO - 'tests': ['damp', 'tps']}, 18:27:30 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:27:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:27:30 INFO - 'other': {'tests': ['a11yr', 18:27:30 INFO - 'ts_paint', 18:27:30 INFO - 'tpaint', 18:27:30 INFO - 'sessionrestore', 18:27:30 INFO - 'sessionrestore_no_auto_restore']}, 18:27:30 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:27:30 INFO - 'tests': ['a11yr', 18:27:30 INFO - 'ts_paint', 18:27:30 INFO - 'tpaint', 18:27:30 INFO - 'sessionrestore', 18:27:30 INFO - 'sessionrestore_no_auto_restore']}, 18:27:30 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:27:30 INFO - 'tests': ['a11yr', 18:27:30 INFO - 'ts_paint', 18:27:30 INFO - 'tpaint', 18:27:30 INFO - 'sessionrestore', 18:27:30 INFO - 'sessionrestore_no_auto_restore']}, 18:27:30 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:27:30 INFO - 'tests': ['a11yr', 18:27:30 INFO - 'ts_paint', 18:27:30 INFO - 'tpaint', 18:27:30 INFO - 'sessionrestore', 18:27:30 INFO - 'sessionrestore_no_auto_restore']}, 18:27:30 INFO - 'other_l64': {'tests': ['a11yr', 18:27:30 INFO - 'ts_paint', 18:27:30 INFO - 'tpaint', 18:27:30 INFO - 'sessionrestore', 18:27:30 INFO - 'sessionrestore_no_auto_restore']}, 18:27:30 INFO - 'other_nol64': {'tests': ['a11yr', 18:27:30 INFO - 'ts_paint', 18:27:30 INFO - 'tpaint', 18:27:30 INFO - 'sessionrestore', 18:27:30 INFO - 'sessionrestore_no_auto_restore']}, 18:27:30 INFO - 'svgr': {'tests': ['tsvgx', 18:27:30 INFO - 'tsvgr_opacity', 18:27:30 INFO - 'tart', 18:27:30 INFO - 'tscrollx', 18:27:30 INFO - 'cart']}, 18:27:30 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:27:30 INFO - 'tests': ['tsvgx', 18:27:30 INFO - 'tsvgr_opacity', 18:27:30 INFO - 'tart', 18:27:30 INFO - 'tscrollx', 18:27:30 INFO - 'cart']}, 18:27:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:27:30 INFO - 'tests': ['tp5o']}, 18:27:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:27:30 INFO - 'talos_options': ['--e10s'], 18:27:30 INFO - 'tests': ['tp5o']}, 18:27:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:27:30 INFO - 'talos_options': ['--xperf_path', 18:27:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:27:30 INFO - 'tests': ['tp5n']}, 18:27:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:27:30 INFO - 'talos_options': ['--e10s', 18:27:30 INFO - '--xperf_path', 18:27:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:27:30 INFO - 'tests': ['tp5n']}}, 18:27:30 INFO - 'talos.zip': {'path': '', 18:27:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:27:30 INFO - Running post-action listener: _resource_record_post_action 18:27:30 INFO - ##### 18:27:30 INFO - ##### Running create-virtualenv step. 18:27:30 INFO - ##### 18:27:30 INFO - Running pre-action listener: _resource_record_pre_action 18:27:30 INFO - Running main action method: create_virtualenv 18:27:30 INFO - Creating virtualenv /builds/slave/test/build/venv 18:27:30 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 18:27:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:27:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:27:30 INFO - Using real prefix '/tools/python27' 18:27:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:27:31 INFO - Installing distribute.............................................................................................................................................................................................done. 18:27:34 INFO - Installing pip.................done. 18:27:34 INFO - Return code: 0 18:27:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:27:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:27:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:27:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:34 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 0x103008a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10300f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2cbc98340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102eacd30>, '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 0x102cd0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ea3b20>, '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.bXurAHNlMO/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.pF1wYHt0qf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:27:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:27:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:27:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bXurAHNlMO/Render', 18:27:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:27:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:27:34 INFO - 'HOME': '/Users/cltbld', 18:27:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:27:34 INFO - 'LOGNAME': 'cltbld', 18:27:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:34 INFO - 'MOZ_NO_REMOTE': '1', 18:27:34 INFO - 'NO_EM_RESTART': '1', 18:27:34 INFO - 'PAGER': '/bin/cat', 18:27:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:27:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:34 INFO - 'PWD': '/builds/slave/test', 18:27:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:27:34 INFO - 'SHELL': '/bin/bash', 18:27:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pF1wYHt0qf/Listeners', 18:27:34 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 18:27:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:27:34 INFO - 'USER': 'cltbld', 18:27:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:27:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:27:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:34 INFO - 'XPC_FLAGS': '0x0', 18:27:34 INFO - 'XPC_SERVICE_NAME': '0', 18:27:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:27:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:27:34 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:27:34 INFO - Cleaning up... 18:27:34 INFO - Return code: 0 18:27:34 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:27:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:27:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:27:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:34 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 0x103008a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10300f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2cbc98340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102eacd30>, '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 0x102cd0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ea3b20>, '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.bXurAHNlMO/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.pF1wYHt0qf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:27:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 18:27:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 18:27:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bXurAHNlMO/Render', 18:27:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:27:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:27:34 INFO - 'HOME': '/Users/cltbld', 18:27:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:27:34 INFO - 'LOGNAME': 'cltbld', 18:27:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:34 INFO - 'MOZ_NO_REMOTE': '1', 18:27:34 INFO - 'NO_EM_RESTART': '1', 18:27:34 INFO - 'PAGER': '/bin/cat', 18:27:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:27:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:34 INFO - 'PWD': '/builds/slave/test', 18:27:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:27:34 INFO - 'SHELL': '/bin/bash', 18:27:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pF1wYHt0qf/Listeners', 18:27:34 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 18:27:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:27:34 INFO - 'USER': 'cltbld', 18:27:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:27:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:27:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:34 INFO - 'XPC_FLAGS': '0x0', 18:27:34 INFO - 'XPC_SERVICE_NAME': '0', 18:27:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:27:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:27:34 INFO - Downloading/unpacking psutil>=0.7.1 18:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:27:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:27:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:27:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:27:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:27:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:27:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:27:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:27:38 INFO - Installing collected packages: psutil 18:27:38 INFO - Running setup.py install for psutil 18:27:38 INFO - building 'psutil._psutil_osx' extension 18:27:38 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 18:27:38 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 18:27:38 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 18:27:38 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 18:27:38 INFO - building 'psutil._psutil_posix' extension 18:27:38 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 18:27:38 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:27:38 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:27:38 INFO - ^ 18:27:38 INFO - 1 warning generated. 18:27:38 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 18:27:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:27:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:27:38 INFO - Successfully installed psutil 18:27:38 INFO - Cleaning up... 18:27:38 INFO - Return code: 0 18:27:38 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:27: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')]} 18:27:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:27:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27: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')]} 18:27:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:27:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:38 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 0x103008a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10300f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2cbc98340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102eacd30>, '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 0x102cd0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ea3b20>, '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.bXurAHNlMO/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.pF1wYHt0qf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:27:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 18:27:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 18:27:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bXurAHNlMO/Render', 18:27:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:27:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:27:38 INFO - 'HOME': '/Users/cltbld', 18:27:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:27:38 INFO - 'LOGNAME': 'cltbld', 18:27:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:38 INFO - 'MOZ_NO_REMOTE': '1', 18:27:38 INFO - 'NO_EM_RESTART': '1', 18:27:38 INFO - 'PAGER': '/bin/cat', 18:27:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:27:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:38 INFO - 'PWD': '/builds/slave/test', 18:27:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:27:38 INFO - 'SHELL': '/bin/bash', 18:27:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pF1wYHt0qf/Listeners', 18:27:38 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 18:27:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:27:38 INFO - 'USER': 'cltbld', 18:27:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:27:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:27:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:38 INFO - 'XPC_FLAGS': '0x0', 18:27:38 INFO - 'XPC_SERVICE_NAME': '0', 18:27:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:27:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:27:39 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:27:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:27:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:27:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:27:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:27:41 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:27:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:27:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:27:41 INFO - Installing collected packages: mozsystemmonitor 18:27:41 INFO - Running setup.py install for mozsystemmonitor 18:27:41 INFO - Successfully installed mozsystemmonitor 18:27:41 INFO - Cleaning up... 18:27:41 INFO - Return code: 0 18:27:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:27:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:27:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:27:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:27:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103008a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10300f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2cbc98340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102eacd30>, '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 0x102cd0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ea3b20>, '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.bXurAHNlMO/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.pF1wYHt0qf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:27:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:27:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:27:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bXurAHNlMO/Render', 18:27:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:27:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:27:41 INFO - 'HOME': '/Users/cltbld', 18:27:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:27:41 INFO - 'LOGNAME': 'cltbld', 18:27:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:41 INFO - 'MOZ_NO_REMOTE': '1', 18:27:41 INFO - 'NO_EM_RESTART': '1', 18:27:41 INFO - 'PAGER': '/bin/cat', 18:27:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:27:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:41 INFO - 'PWD': '/builds/slave/test', 18:27:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:27:41 INFO - 'SHELL': '/bin/bash', 18:27:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pF1wYHt0qf/Listeners', 18:27:41 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 18:27:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:27:41 INFO - 'USER': 'cltbld', 18:27:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:27:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:27:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:41 INFO - 'XPC_FLAGS': '0x0', 18:27:41 INFO - 'XPC_SERVICE_NAME': '0', 18:27:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:27:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:27:42 INFO - Downloading/unpacking blobuploader==1.2.4 18:27:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:27:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:27:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:27:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:27:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:27:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:27:44 INFO - Downloading blobuploader-1.2.4.tar.gz 18:27:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:27:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:27:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:27:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:27:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:27:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:27:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:27:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:27:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:27:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:27:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:27:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:27:45 INFO - Downloading docopt-0.6.1.tar.gz 18:27:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:27:45 INFO - Installing collected packages: blobuploader, requests, docopt 18:27:45 INFO - Running setup.py install for blobuploader 18:27:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:27:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:27:45 INFO - Running setup.py install for requests 18:27:46 INFO - Running setup.py install for docopt 18:27:46 INFO - Successfully installed blobuploader requests docopt 18:27:46 INFO - Cleaning up... 18:27:46 INFO - Return code: 0 18:27:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:27:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:27:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:27:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:27:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:46 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 0x103008a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10300f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2cbc98340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102eacd30>, '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 0x102cd0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ea3b20>, '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.bXurAHNlMO/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.pF1wYHt0qf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:27:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:27:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:27:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bXurAHNlMO/Render', 18:27:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:27:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:27:46 INFO - 'HOME': '/Users/cltbld', 18:27:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:27:46 INFO - 'LOGNAME': 'cltbld', 18:27:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:46 INFO - 'MOZ_NO_REMOTE': '1', 18:27:46 INFO - 'NO_EM_RESTART': '1', 18:27:46 INFO - 'PAGER': '/bin/cat', 18:27:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:27:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:46 INFO - 'PWD': '/builds/slave/test', 18:27:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:27:46 INFO - 'SHELL': '/bin/bash', 18:27:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pF1wYHt0qf/Listeners', 18:27:46 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 18:27:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:27:46 INFO - 'USER': 'cltbld', 18:27:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:27:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:27:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:46 INFO - 'XPC_FLAGS': '0x0', 18:27:46 INFO - 'XPC_SERVICE_NAME': '0', 18:27:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:27:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:27:46 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-IbUwWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:27:46 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-aqBN5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:27:46 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-2B1fDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:27:46 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-XOi60s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:27:47 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-RpnbhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:27:47 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-8ehToA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:27:47 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-AaFVso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:27:47 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-B2cUjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:27:47 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-a3aWWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:27:47 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-SG8c6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:27:47 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-fsG4t8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:27:47 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-cYsLR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:27:47 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-dWariA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:27:48 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-bAyFHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:27:48 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-F1E7M3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:27:48 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-W1Azag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:27:48 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-FQa9lx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:27:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:27:48 INFO - Running setup.py install for manifestparser 18:27:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:27:48 INFO - Running setup.py install for mozcrash 18:27:48 INFO - Running setup.py install for mozdebug 18:27:48 INFO - Running setup.py install for mozdevice 18:27:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:27:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:27:49 INFO - Running setup.py install for mozfile 18:27:49 INFO - Running setup.py install for mozhttpd 18:27:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:27:49 INFO - Running setup.py install for mozinfo 18:27:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:27:49 INFO - Running setup.py install for mozInstall 18:27:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:27:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:27:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:27:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:27:49 INFO - Running setup.py install for mozleak 18:27:49 INFO - Running setup.py install for mozlog 18:27:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:27:49 INFO - Running setup.py install for moznetwork 18:27:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:27:50 INFO - Running setup.py install for mozprocess 18:27:50 INFO - Running setup.py install for mozprofile 18:27:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:27:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:27:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:27:50 INFO - Running setup.py install for mozrunner 18:27:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:27:50 INFO - Running setup.py install for mozscreenshot 18:27:50 INFO - Running setup.py install for moztest 18:27:50 INFO - Running setup.py install for mozversion 18:27:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:27:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:27:50 INFO - Cleaning up... 18:27:50 INFO - Return code: 0 18:27:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:27:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:27:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:27:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:27:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:27:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:50 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 0x103008a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10300f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2cbc98340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102eacd30>, '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 0x102cd0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ea3b20>, '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.bXurAHNlMO/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.pF1wYHt0qf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:27:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:27:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:27:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bXurAHNlMO/Render', 18:27:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:27:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:27:50 INFO - 'HOME': '/Users/cltbld', 18:27:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:27:50 INFO - 'LOGNAME': 'cltbld', 18:27:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:50 INFO - 'MOZ_NO_REMOTE': '1', 18:27:50 INFO - 'NO_EM_RESTART': '1', 18:27:50 INFO - 'PAGER': '/bin/cat', 18:27:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:27:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:50 INFO - 'PWD': '/builds/slave/test', 18:27:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:27:50 INFO - 'SHELL': '/bin/bash', 18:27:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pF1wYHt0qf/Listeners', 18:27:50 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 18:27:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:27:50 INFO - 'USER': 'cltbld', 18:27:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:27:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:27:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:50 INFO - 'XPC_FLAGS': '0x0', 18:27:50 INFO - 'XPC_SERVICE_NAME': '0', 18:27:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:27:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:27:51 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-60BhtI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:27:51 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-etnHat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:27:51 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-EDwChj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:27:51 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-r9R6u1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:27:51 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-NLfAx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:27:51 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-HXDNxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:27:51 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-4sc4PA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:27:51 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-5wtpYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:27:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:27:52 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-OLJnnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:27:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:27:52 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-RrTJcB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:27:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:27:52 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-tu43uD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:27:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:27:52 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-DpgzMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:27:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:27:52 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-FOGFbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:27:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:27:52 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-LZ_CPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:27:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:27:52 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-vCs_u5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:27:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:27:52 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-g2sKgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:27:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:27:52 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-vkiZu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:27:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:27:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:27:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:27:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:27:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:27:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:27:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:27:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:27:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:27:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:27:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:27:55 INFO - Downloading blessings-1.6.tar.gz 18:27:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:27:55 INFO - Installing collected packages: blessings 18:27:55 INFO - Running setup.py install for blessings 18:27:55 INFO - Successfully installed blessings 18:27:55 INFO - Cleaning up... 18:27:55 INFO - Return code: 0 18:27:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:27:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:27:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:27:55 INFO - Reading from file tmpfile_stdout 18:27:55 INFO - Current package versions: 18:27:55 INFO - blessings == 1.6 18:27:55 INFO - blobuploader == 1.2.4 18:27:55 INFO - docopt == 0.6.1 18:27:55 INFO - manifestparser == 1.1 18:27:55 INFO - mozInstall == 1.12 18:27:55 INFO - mozcrash == 0.16 18:27:55 INFO - mozdebug == 0.1 18:27:55 INFO - mozdevice == 0.48 18:27:55 INFO - mozfile == 1.2 18:27:55 INFO - mozhttpd == 0.7 18:27:55 INFO - mozinfo == 0.9 18:27:55 INFO - mozleak == 0.1 18:27:55 INFO - mozlog == 3.1 18:27:55 INFO - moznetwork == 0.27 18:27:55 INFO - mozprocess == 0.22 18:27:55 INFO - mozprofile == 0.28 18:27:55 INFO - mozrunner == 6.11 18:27:55 INFO - mozscreenshot == 0.1 18:27:55 INFO - mozsystemmonitor == 0.0 18:27:55 INFO - moztest == 0.7 18:27:55 INFO - mozversion == 1.4 18:27:55 INFO - psutil == 3.1.1 18:27:55 INFO - requests == 1.2.3 18:27:55 INFO - wsgiref == 0.1.2 18:27:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:27:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:27:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:27:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:27:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:27:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27:55 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 0x103008a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10300f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2cbc98340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102eacd30>, '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 0x102cd0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ea3b20>, '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.bXurAHNlMO/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.pF1wYHt0qf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:27:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:27:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:27:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bXurAHNlMO/Render', 18:27:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:27:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:27:55 INFO - 'HOME': '/Users/cltbld', 18:27:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:27:55 INFO - 'LOGNAME': 'cltbld', 18:27:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:55 INFO - 'MOZ_NO_REMOTE': '1', 18:27:55 INFO - 'NO_EM_RESTART': '1', 18:27:55 INFO - 'PAGER': '/bin/cat', 18:27:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:27:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:55 INFO - 'PWD': '/builds/slave/test', 18:27:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:27:55 INFO - 'SHELL': '/bin/bash', 18:27:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pF1wYHt0qf/Listeners', 18:27:55 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 18:27:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:27:55 INFO - 'USER': 'cltbld', 18:27:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:27:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:27:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:55 INFO - 'XPC_FLAGS': '0x0', 18:27:55 INFO - 'XPC_SERVICE_NAME': '0', 18:27:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:27:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:27:56 INFO - Cleaning up... 18:27:56 INFO - Return code: 0 18:27:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:27: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')]} 18:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:27:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27: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')]} 18:27:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:27:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103008a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10300f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2cbc98340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102eacd30>, '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 0x102cd0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ea3b20>, '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.bXurAHNlMO/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.pF1wYHt0qf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:27: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', 'jsonschema'] in /builds/slave/test/build 18:27: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 jsonschema 18:27:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bXurAHNlMO/Render', 18:27:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:27:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:27:56 INFO - 'HOME': '/Users/cltbld', 18:27:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:27:56 INFO - 'LOGNAME': 'cltbld', 18:27:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:56 INFO - 'MOZ_NO_REMOTE': '1', 18:27:56 INFO - 'NO_EM_RESTART': '1', 18:27:56 INFO - 'PAGER': '/bin/cat', 18:27:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:27:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:56 INFO - 'PWD': '/builds/slave/test', 18:27:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:27:56 INFO - 'SHELL': '/bin/bash', 18:27:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pF1wYHt0qf/Listeners', 18:27:56 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 18:27:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:27:56 INFO - 'USER': 'cltbld', 18:27:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:27:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:27:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:56 INFO - 'XPC_FLAGS': '0x0', 18:27:56 INFO - 'XPC_SERVICE_NAME': '0', 18:27:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:27:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:27:56 INFO - Downloading/unpacking jsonschema 18:27: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 18:27: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 18:27: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 18:27: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 18:27: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 18:27: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 18:27:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:27:58 INFO - Downloading/unpacking functools32 (from jsonschema) 18:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:27:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:27:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:27:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:27:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:27:59 INFO - Downloading functools32-3.2.3-2.tar.gz 18:27:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:27:59 INFO - warning: no files found matching '*.txt' 18:27:59 INFO - no previously-included directories found matching 'build' 18:27:59 INFO - no previously-included directories found matching 'dist' 18:27:59 INFO - no previously-included directories found matching '.git*' 18:27:59 INFO - Installing collected packages: jsonschema, functools32 18:27:59 INFO - Running setup.py install for functools32 18:27:59 INFO - warning: no files found matching '*.txt' 18:27:59 INFO - no previously-included directories found matching 'build' 18:27:59 INFO - no previously-included directories found matching 'dist' 18:27:59 INFO - no previously-included directories found matching '.git*' 18:27:59 INFO - Successfully installed jsonschema functools32 18:27:59 INFO - Cleaning up... 18:27:59 INFO - Return code: 0 18:27:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:27: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')]} 18:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:27:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27: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')]} 18:27:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:27:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:27: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103008a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10300f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2cbc98340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102eacd30>, '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 0x102cd0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ea3b20>, '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.bXurAHNlMO/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.pF1wYHt0qf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:27: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', 'flake8'] in /builds/slave/test/build 18:27: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 flake8 18:27:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bXurAHNlMO/Render', 18:27:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:27:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:27:59 INFO - 'HOME': '/Users/cltbld', 18:27:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:27:59 INFO - 'LOGNAME': 'cltbld', 18:27:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:27:59 INFO - 'MOZ_NO_REMOTE': '1', 18:27:59 INFO - 'NO_EM_RESTART': '1', 18:27:59 INFO - 'PAGER': '/bin/cat', 18:27:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:27:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:27:59 INFO - 'PWD': '/builds/slave/test', 18:27:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:27:59 INFO - 'SHELL': '/bin/bash', 18:27:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pF1wYHt0qf/Listeners', 18:27:59 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 18:27:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:27:59 INFO - 'USER': 'cltbld', 18:27:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:27:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:27:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:27:59 INFO - 'XPC_FLAGS': '0x0', 18:27:59 INFO - 'XPC_SERVICE_NAME': '0', 18:27:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:27:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:27:59 INFO - Downloading/unpacking flake8 18:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:27:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:27:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:27:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:27:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:28:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:28:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:28: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 18:28: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 18:28: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 18:28: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 18:28: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 18:28: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 18:28:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:28:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:28: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 18:28: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 18:28: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 18:28: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 18:28: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 18:28: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 18:28:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:28: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 18:28: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 18:28: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 18:28: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 18:28: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 18:28: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 18:28:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:28:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:28:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:28:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:28:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:28:03 INFO - no previously-included directories found matching 'docs/_build' 18:28:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:28:03 INFO - Running setup.py install for pep8 18:28:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:28:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:28:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:28:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:28:03 INFO - no previously-included directories found matching 'docs/_build' 18:28:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:28:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:28:03 INFO - Cleaning up... 18:28:03 INFO - Return code: 0 18:28:03 INFO - Running post-action listener: _resource_record_post_action 18:28:03 INFO - Running post-action listener: _start_resource_monitoring 18:28:03 INFO - Starting resource monitoring. 18:28:03 INFO - ##### 18:28:03 INFO - ##### Running install step. 18:28:03 INFO - ##### 18:28:03 INFO - Running pre-action listener: _resource_record_pre_action 18:28:03 INFO - Running main action method: install 18:28:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:28:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:28:04 INFO - Reading from file tmpfile_stdout 18:28:04 INFO - Detecting whether we're running mozinstall >=1.0... 18:28:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:28:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:28:04 INFO - Reading from file tmpfile_stdout 18:28:04 INFO - Output received: 18:28:04 INFO - Usage: mozinstall [options] installer 18:28:04 INFO - Options: 18:28:04 INFO - -h, --help show this help message and exit 18:28:04 INFO - -d DEST, --destination=DEST 18:28:04 INFO - Directory to install application into. [default: 18:28:04 INFO - "/builds/slave/test"] 18:28:04 INFO - --app=APP Application being installed. [default: firefox] 18:28:04 INFO - mkdir: /builds/slave/test/build/application 18:28:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:28:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 18:28:38 INFO - Reading from file tmpfile_stdout 18:28:38 INFO - Output received: 18:28:38 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:28:38 INFO - Running post-action listener: _resource_record_post_action 18:28:38 INFO - ##### 18:28:38 INFO - ##### Running run-tests step. 18:28:38 INFO - ##### 18:28:38 INFO - Running pre-action listener: _resource_record_pre_action 18:28:38 INFO - Running main action method: run_tests 18:28:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:28:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:28:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:28:38 INFO - 2016-02-15 18:28:38.195 screenresolution[1952:12269] starting screenresolution argv=screenresolution get 18:28:38 INFO - 2016-02-15 18:28:38.198 screenresolution[1952:12269] Display 0: 1600x1200x32@60 18:28:38 INFO - 2016-02-15 18:28:38.204 screenresolution[1953:12271] starting screenresolution argv=screenresolution list 18:28:38 INFO - Available Modes on Display 0 18:28:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:28:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:28:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:28:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:28:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:28:38 INFO - Intel Iris: 18:28:38 INFO - Chipset Model: Intel Iris 18:28:38 INFO - Type: GPU 18:28:38 INFO - Bus: Built-In 18:28:38 INFO - VRAM (Dynamic, Max): 1536 MB 18:28:38 INFO - Vendor: Intel (0x8086) 18:28:38 INFO - Device ID: 0x0a2e 18:28:38 INFO - Revision ID: 0x0009 18:28:38 INFO - Displays: 18:28:38 INFO - Display: 18:28:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:28:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:28:38 INFO - Display Serial Number: 1600x1200 60 18:28:38 INFO - Main Display: Yes 18:28:38 INFO - Mirror: Off 18:28:38 INFO - Online: Yes 18:28:38 INFO - Rotation: Supported 18:28:38 INFO - Return code: 0 18:28:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:28:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:28:38 INFO - Python 2.7.3 18:28:38 INFO - Return code: 0 18:28:38 INFO - grabbing minidump binary from tooltool 18:28: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')]} 18:28:38 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 0x102eacd30>, '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 0x102cd0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ea3b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:28:38 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:28:38 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 18:28:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:28:38 INFO - Return code: 0 18:28:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:28:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:28:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:28:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:28:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:28:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:28:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:28:39 INFO - Return code: 0 18:28:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CbdsflAUQIGGeBU2kDt50w/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0130', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:28:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CbdsflAUQIGGeBU2kDt50w/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0130 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:28:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bXurAHNlMO/Render', 18:28:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:28:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:28:39 INFO - 'HOME': '/Users/cltbld', 18:28:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:28:39 INFO - 'LOGNAME': 'cltbld', 18:28:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:28:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:28:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:28:39 INFO - 'MOZ_NO_REMOTE': '1', 18:28:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:28:39 INFO - 'NO_EM_RESTART': '1', 18:28:39 INFO - 'PAGER': '/bin/cat', 18:28:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:28:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:28:39 INFO - 'PWD': '/builds/slave/test', 18:28:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:28:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:28:39 INFO - 'SHELL': '/bin/bash', 18:28:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pF1wYHt0qf/Listeners', 18:28:39 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 18:28:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:28:39 INFO - 'USER': 'cltbld', 18:28:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:28:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:28:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:28:39 INFO - 'XPC_FLAGS': '0x0', 18:28:39 INFO - 'XPC_SERVICE_NAME': '0', 18:28:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:28:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CbdsflAUQIGGeBU2kDt50w/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0130', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:28:39 INFO - mozversion application_buildid: 20160215172550 18:28:39 INFO - mozversion application_changeset: 1ba422314bc61c2cbf657f8c76ffff7e10a9082e 18:28:39 INFO - mozversion application_display_name: Nightly 18:28:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:28:39 INFO - mozversion application_name: Firefox 18:28:39 INFO - mozversion application_remotingname: firefox 18:28:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:28:39 INFO - mozversion application_vendor: Mozilla 18:28:39 INFO - mozversion application_version: 47.0a1 18:28:39 INFO - mozversion platform_buildid: 20160215172550 18:28:39 INFO - mozversion platform_changeset: 1ba422314bc61c2cbf657f8c76ffff7e10a9082e 18:28:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:28:39 INFO - mozversion platform_version: 47.0a1 18:28:39 INFO - using testdate: 1455589719 18:28:39 INFO - actual date: 1455589719 18:28:39 INFO - starting webserver on 'localhost:49703' 18:28:39 INFO - SUITE-START | Running 2 tests 18:28:39 INFO - TEST-START | dromaeo_css 18:28:39 INFO - operating with platform_type : mac_ 18:28:39 INFO - Initialising browser for dromaeo_css test... 18:28:40 INFO - TEST-INFO | started process 1971 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/tmpQHpwdp/profile http://localhost:49703/getInfo.html) 18:28:42 INFO - PROCESS | 1971 | __metrics Screen width/height:1600/1200 18:28:42 INFO - PROCESS | 1971 | colorDepth:24 18:28:42 INFO - PROCESS | 1971 | Browser inner width/height: 1024/689 18:28:42 INFO - PROCESS | 1971 | __metrics 18:28:43 INFO - TEST-INFO | 1971: exit 0 18:28:43 INFO - Browser initialized. 18:28:43 INFO - Running cycle 1/1 for dromaeo_css test... 18:28:43 INFO - TEST-INFO | started process 1975 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/tmpQHpwdp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:28:55 INFO - PROCESS | 1975 | RSS: Main: 256454656 18:28:55 INFO - PROCESS | 1975 | 18:29:45 INFO - PROCESS | 1975 | 1455589785570 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 18:31:56 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49703/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49703/tests/dromaeo/cssquery-ext.html) 18:31:57 INFO - PROCESS | 1975 | RSS: Main: 270114816 18:31:57 INFO - PROCESS | 1975 | 18:34:59 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49703/tests/dromaeo/cssquery-ext.html (next: http://localhost:49703/tests/dromaeo/cssquery-jquery.html) 18:35:00 INFO - PROCESS | 1975 | RSS: Main: 281026560 18:35:00 INFO - PROCESS | 1975 | 18:38:01 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49703/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49703/tests/dromaeo/cssquery-mootools.html) 18:38:02 INFO - PROCESS | 1975 | RSS: Main: 283815936 18:38:02 INFO - PROCESS | 1975 | 18:41:04 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49703/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49703/tests/dromaeo/cssquery-prototype.html) 18:41:04 INFO - PROCESS | 1975 | RSS: Main: 283815936 18:41:04 INFO - PROCESS | 1975 | 18:44:07 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49703/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49703/tests/dromaeo/cssquery-yui.html) 18:44:07 INFO - PROCESS | 1975 | RSS: Main: 286347264 18:44:07 INFO - PROCESS | 1975 | 18:47:10 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49703/tests/dromaeo/cssquery-yui.html (next: http://localhost:49703/tests/dromaeo/cssquery-dojo.html) 18:47:10 INFO - PROCESS | 1975 | RSS: Main: 288833536 18:47:10 INFO - PROCESS | 1975 | 18:47:10 INFO - PROCESS | 1975 | __start_tp_report 18:47:10 INFO - PROCESS | 1975 | _x_x_mozilla_page_load 18:47:10 INFO - PROCESS | 1975 | _x_x_mozilla_page_load_details 18:47:10 INFO - PROCESS | 1975 | |i|pagename|runs| 18:47:10 INFO - PROCESS | 1975 | |0;dojo.html;3448.0345503259095;3448.9137771555706;3492.6681965213297;3509.5086687863704;3510.684038436541;4901.558859702631;5629.802956896509;5666.121751128577;5683.8579035524135;5693.487586117249;4460.375547423363;5638.971805140979;5712.057510510771;5737.938481380937;5815.5638327125525;5131.666441681288;5184.144616138333;5205.609579281569;5227.869303267411;5322.414534401213;4266.850660226893;5065.569426598725;5102.489751024905;5194.246834209038;5261.631685781997;5172.353455818023;5184.326037615124;5193.221016847466;5195.740212989335;5197.48025197481;5223.2165175223645;5227.032998895179;5237.79048838046;5247.580193584504;5263.3947096083675;5067.0879241736475;5104;5170.793168273264;5176.715280659562;5192.8961420771375;4583.610393116589;5419.810306639288;5650.434956504358;5654.830355089354;5671.291088613923;6085.208922840046;6144.201253837017;6208.00671892495;6217.626942383471;6222.284437289724;6144.494598823272;6220.47125994291;6259.2488901332135;6260.624362538262;6295;5823.621464604787;5835.241418615596;5851.912221316684;5871.089981052944;5921.911171332434;6136.917362303815;6173.938260617426;6248.875022499616;6262.2172228471445;6277.435030847246;6096.939030609726;6124.693765311717;6134.7852825151795;6142.477889379364;6156.8768624627255;6183.288921773964;6252.374762523802;6252.624842509464;6255.74977000924;6260;6060.090986352083;6148;6204.100405441186;6220.813375598649;6235.376462353819;6171.47542458896;6216.906746398808;6217.875642487125;6223.595466294676;6243.313235544087;4770.379850619397;4840.975795121002;4858.7570621468785;4894.241392584155;4911.852644420673;4332.935005974913;4362.716423432466;4387.736735795863;4407.140607581555;4428.4685837699035;4811.759412029384;5672.744726487318;5691.174779656926;5712.428757124338;5737.655740655574;6144.279601711528;6171.197744293213;6267.843303917439;6273.341299163613;6275.215598050244;4773.260144677511;5659.830205093854;5714.142878568165;5749.108888122348;5753.626014309057;4642.814287428532;4909.7790599423115;5143.588512918957;5252.369715634072;5382.085045542267;6198.504119670415;6230.719617617127;6285.622862628257;6285.811425657238;6297.118403423525;6223.222097237845;6260.154879091265;6269.028300613412;6274.811755647338;6277.121203031488;6152.569320147726;6226.813195604139;6254.530910181664;6269.153664255267;6288.968555157195;6132.600268413531;6180.6291622502795;6185.659788711484;6195.19462469876;6211;5649.954758369715;6251.624902505864;6263.530235232284;6266.530010249158;6283.183186185766;5698.8290351289525;5873.060310350324;6103.359147289649;6156.199694039925;6168.599041062496;6109.533711909021;6115.780809617568;6141.9385806143155;6150.616111374905;6160.568760186744;4626.560476754703;5942;6011;6012.7294271757;6062.151298818081;6063.454289114001;6116.388361164026;6117.828170999409;6169.352218017044;6175.2589689237575;6031.125486804301;6035;6043.969780151071;6046.788362407295;6064.757409703562 18:47:10 INFO - PROCESS | 1975 | |1;ext.html;399.60838378389195;438.95090733147765;463.38601353206997;526.6313580493654;592.8912932815635;33987.32025359492;37882.4317635235;37948.43077353842;38039.619603803956;38155.85532434028;39497;39738;39830.8008459958;39877.401838972364;39946;9336.953315233415;9512.66705665302;9534.904650953471;9564.282678799083;9588.232941364675;9256.6297348106;9530.475823829687;9549.09283618055;9558.713238602853;9570.425774453555;9529;9554.952225238863;9573.99473055326;9620.278479114095;9625.278104142182;9463.668771592995;9577;9580.760480987996;9605.951970240174;9617.374870633386;9472.336936414455;9565.473898935556;9603.855942160873;9607.951960240154;9659.855102173473;37687.05782355436;38039.42940855889;38072.80963595164;38448.61551384506;38462.038449039;2787.693353731088;3179.777415580887;3231.2729635831984;3348.2131699050706;3364.2934983653463;26303;26325.473490530083;27182.912683492636;27355;27733.861330693217;2774.4589804988036;2792.3996340786625;2808.171589381117;2870.799044066916;2948.6609039960463;279753;341311;342699;343907;344080;56129.43870561324;57149.71425142848;64731;66725.6663716688;67025;52368;58483;63710;63952;64161;13449.32753362328;15900.52298431049;16244.431444899608;16264.18679066042;16271.918640406959;12213.755724885452;12243.265404075606;12307.630771076882;12307.69230769238;12592.307423091817;20036.998150092437;20843.791562084185;20859.478513037295;20893.791062089487;20988.685169722467;7160.534565253241;7278.890816637755;8431.409801313972;8603.784905377415;8675.826483470295;931.4923366765129;972.844344904826;1002.9598816047277;1051.3691784929135;1145.4158379226653;29642.703572964427;29804.850975744983;29999.400011999638;30588.38823223523;31390.901318454202;1031.118025119792;1084.0839490630406;1179.7050737315672;1201.7356181640025;1207.1308657766394;15263.771043434357;15269;15370.231488425534;15519.844801552066;15593.844061559466;530980;539553;541606;544141;551309;56308;57446.425535744944;57727.711361442925;57893;58164.70917645469;1215.8784121587948;1286.9832832062752;1484.087286318906;1488.1740633948045;1497.2214448486725;30052.549211762278;30204.09387718372;30283.242918927204;30487.847560762053;30591.847040765544;48046.5195348042;48409.27386089282;48459.5154048455;48829.51170488392;49018.264726029855;388576;388579;399331;401495.9027663193;490443;33990;44414.555854441045;44741.55258447504;45737;45818;43794.34308485439;43873.78063109664;44274.55725442704;44783;44871.51284871487;35968.820155899055;36888.922148219994;37178.6282137186;37252;37653.87038388853;36543.81728091343;36934;37574.81212593919;38112.618873810905;38601.6139838598;35214.64785352216;35510.5294691443;35784.105397365274;35875.64124358723;36152.63847361493;27619.447611047264;31200;31524.52713209258;32461.837690811393;33459.83270083634;20927.581448371253;25036.37409064715;25977.610335844598;26025.869870650524;26207.21378358652 18:47:10 INFO - PROCESS | 1975 | |2;jquery.html;356.9286142771446;369.81878879349125;371.69335298378843;373.18086799475157;374.25336453774713;15342.539723808275;17309.82690173098;19436.51408714783;19709.31017414391;20167.092480838342;11474.196806223568;11638.767224655501;11720.238184518;11749.941250293736;11775.7644847103;3915.960840391588;5137.306463627409;5191.091558977164;5437.265969094161;5794.797182098628;5902.468777809996;5910.61580997236;5913.14259432382;5979.192808970777;5987.251593550806;5350.652207606513;6018.518518518508;6491.772787952423;6526.934730652704;6534.954407294834;5267.078261304257;5837.066069428871;5944.583879128462;6436.80689579311;6536.509761767863;5629.71851407432;5645.576581756384;5648.237487939116;5671.659700417947;5700.857478563028;23484.178053768035;23730.40673983147;23955.40111497209;24052;24123.879380602986;2102.4638717127186;2156.7304086989125;2213.767554406796;2239.3729755668437;2626.290901456596;9599.08808663183;9671.758206044835;9685.951570242174;9890.752731181707;10082.99170082993;1721.672882152387;1786.9910650446795;1816.6911625023777;1822.7265910113456;1838.7241913712917;75414;96734;99548.00451995533;101829.49085254526;102204.48897755537;8929.508877011827;9512.09635084666;10408.895911040943;10463.94768026155;11199.888001120047;12908.419121139572;13331.533396331082;13340.866591333963;13367.866321336856;13409.66475838112;6573.605583664996;8153.959230203811;8312.5428101455;8346.958265208636;8364.414490985573;8239.752807415787;8287.254147126787;8291.253787159185;8372.581370931552;8398.412111152284;3914.1584559319313;4156.189543039079;4262.70161088727;4301.16127355169;4306.138772245564;1850.3153833081847;1863.9161237744333;1865.0861078071648;1894.4127320530679;1902.4387805597382;916.1205242966694;926.9942112807679;936.7330310861372;955.0160656908241;1032.9586816527406;19097.140628671743;19634.803651963583;19799.60400791976;20043.498912527302;20108.296209632594;974.7855471796194;977.4379731654327;978.2125389061731;1009.5059312217959;1035.8290882004385;10703.46482675863;11004.174686898514;11108.222424430374;11117.666470005914;11135;620600;628982;634935;725652;728644;111964.44017779859;112309;118281;119264.40367798106;119424;1207.4687137659225;1208.1301462946665;1210.285931300537;1213.9817902731465;1216.5255550335376;13178.934105329412;14757.778633320295;18072.638547229246;18338.81661183371;18402.171902264163;40451.797741011105;51680.74159629178;52081.47918520766;53159.46840531545;53489.10231809332;74505.62747186446;75115.49769004699;75942;76502.6174869122;77019.22980770345;7426.403115002151;7435.92564074374;7509.061367329084;7769.572673503011;7886.842263154819;8800.735977920673;9146.862797057916;11481.851814818452;12104.576339828063;12236.877631223573;9741.756456088655;10056.446895420822;10592.417417041828;10606.204534659777;10649.361038337725;10312.381257124596;10464.790704186025;10583.153347732317;10611.31026483276;10684.626038088629;10605.310654807412;10689.412082335546;10763.138948884227;10866.022058014816;11136.33182009082;7522.398208143226;7622.885656715264;7639.427042971911;7775.883361749691;7831;9808.16630586408;9960.601575937171;10366.896331036894;10841.512131953923;10863.837042444527 18:47:10 INFO - PROCESS | 1975 | |3;mootools.html;1532.4253404973135;1550.2248875562223;1781.6169523552433;1817.7185084515418;1888.5845114074907;7938.841223175533;7967.123616402191;8647.783805404868;8947.239484643813;8970.641174353026;8693.261072808804;8736.344774141933;8736.694215702451;8851.822963540726;8871.290296776258;2179.204590324536;2357.26924653358;2491.0658503061354;2499.2252401755422;2503.3115893129443;2466.9753302467016;2493.887775050118;2496.450780828215;2496.8876400562017;2503.336615796806;2200.515886504966;2414.4808866093786;2455.1161581830524;2470.29596564979;2477.7770000699934;2433.4038160650666;2452.1049816816912;2467.1734968785477;2470.6047032474717;2479.6280557916366;2449.926502204919;2464.125235541375;2474.022761009391;2475.282168171246;2476.4799392127675;8841.071687472851;8848.115188481164;8864.645414183426;8866.157715017063;8875.245604123656;5381.5425688816495;5506.476884695948;5521.033819081645;5545.77816887328;5562.554995600342;3611.9097022574383;3691.298653255873;3736.869209577652;3739.1773809761808;3753.9812300938593;1048.397171626318;1053.3048188195753;1062.2086545523634;1087.4508373271526;1099.2634934593761;12211.877881221162;12244;12289.877101228964;12309.56916507918;12344.876551234462;4210.200061988274;4854.514548545118;4884.780184891689;4922.704637721677;4987.526185012418;7550.848983020419;10357.326773759682;10391.428471434143;10408.791824163625;10432.64375631163;5465.836024919259;5562.249096371938;5595.272614560081;5599.244102046172;5620.353659329229;5018.2974383586325;5056.924146137811;5067.771950262247;5092.898142037213;5114.488551144856;4013.4381186633896;4018.1160144768105;4037.4549435826375;4057.14799892026;4090.8568200112854;1130.7166366174288;1237.270010693677;1330.973380532384;1335.0921373465942;1355.4239448234462;1066.594694016269;1096.4517741129434;1098.1983152298867;1260.7289432771815;1351.9932400337934;7985.640646170937;8067.717629883044;8126.83746325082;8267.586620668942;8532.70135545253;1170.9121815863843;1188.2217147768226;1202.807550791869;1206.252123683322;1217.8964787992943;6243.157173781572;6281.560290779602;6288.5598008139905;6346.968265158737;6367.267764207083;10498.370097794157;10717.196210284259;10803.945980270048;10808.621698240524;10826.89173108259;10569.365838049742;10815.026647601753;10819.513121909533;10854.837177442345;11096.722581935355;8443.746687599381;8515.276201522816;8525.914740852511;8564.357673174536;8567.614457349435;7888.645010974635;7983.401244906771;8008.879866801886;8021.197880211932;8067.87898181516;7858.489198202098;9764.755881103029;9766.706998790047;9850.128475589616;9943.850842237516;9983.750406239611;10071.295009349275;10168.186545076229;10187.388756674327;10250.948745256524;7517.1731109579;7532.359749421361;7602.885956710765;7629.427792915442;7641.465097443125;8199.467034642728;8213.876791848008;8231.971003624547;8255;8259.917400825914;7074.903389974562;7235.746748863765;7614.16244213125;7644.541327520366;7944.483608565425;7461.365783908429;7482.70069197226;7580.241975802375;7616.581088040211;7684.116326622287;6267.937320626917;7131.8573628528175;7611.961940190264;7657.617119143909;7669.463137580316;5920.644761314335;6860.931390686029;6889.207741109636;6945.756898508528;6979.581225126509;7064.752733654297;7158.856822863409;7162.104736907887;7162.64186790648;7189.424846012411 18:47:10 INFO - PROCESS | 1975 | |4;prototype.html;323.4307618591279;330.283285270962;332.199399447332;334.3763880363122;340.9532734505069;4757.1437141314545;5366.9463305366935;6348.857205702978;6421.454176395012;6736.9663151684235;6806.591604503733;6833.248342682314;6850.725970961155;6877;6889.896651550218;4695.600873925703;5049.293098966157;5090.643654944155;5096.745162741867;5109.20807274873;4956.2565615157655;5044.19292913134;5104.821331253407;5105.132127538327;5118.334616499868;4160.814167962131;4980.228064649985;4994.150994330954;5011.348524691785;5040.243963405482;4953.257011448276;5007.674501157449;5010.0731364697285;5031.295618613415;5053.393592768891;4256.808443620044;4275.91448171038;4285.678574106923;4296.033392486696;4296.677749168824;6274.372562743734;6587.868242635121;6601.768938087192;6631.071649969008;6668.899966500507;5784.392638772911;5785.508231800302;5786.247787787603;5792.65244085352;5862.325832529271;7202.819929501752;7231.2768723127265;7252.891206631904;7276.490645654806;7277.454190935701;3775.6413140751583;4615.976920115378;4621.8151273949;4629.328747331618;4640.23436133041;7222.422206223489;7616.619169041581;7617.200193979607;7626.084869815602;7654.617269136521;4654.999175177353;4661.906761864744;4669.719816811003;4672.205725026685;4684.672072954861;4760.7619619018915;4761.166795810719;4763.166445871959;4781.880452988703;4791.6406269529925;5534.695591742493;5714.828555143353;5730.596003979052;5734.885302293931;5738.799142030009;7233.89149162763;7238.457115716237;7265.5277406969435;7358.22738612438;7375.648367463223;1294.7410517896458;1569.5291412576182;1605.6387312854515;1648.645541208646;1648.9587760306088;1002.9749256268651;1031.7626945802358;1041.4532370505544;1053.9156867450586;1059.5073290919606;6600.174978127734;6661.3338666132995;6676.86646267072;6680.498962577826;6692.765753198614;5333.599980001515;7342.853142937111;7424.888626670604;7443.292887175709;7450.36671882896;6461.8061458156335;6646.368594983469;6663.967085101817;6670.166229221348;6677.799666010027;3937;3964.6431821136234;3969.4641223435046;3975.801209939549;3980.86066987654;7715;7715.151333353327;7716.189800071024;7721.227877212234;7723.65243564041;6060.122399509194;6249.468795152463;7601.429892758065;7672.079350477979;7915.564643944638;6317.368263173646;7724.034495688039;7733.188015258429;7758.961205194051;7775.883361749578;6255;7262.745803896838;7426.962865185639;7435.293647103516;7498.100227972678;6168.889599872066;7246.275372462712;7558.470907036454;7560.243975602396;7574.621268936421;7954.403419743659;7966.681332746857;7977.122516523062;7990.960045199737;7996.520208787491;4703.20045592257;4766.6901651392545;4769.451513076041;4769.499202583679;4778.092162489255;7246.927530724625;7374.594397308199;7390.593517356597;7610.200928902385;7650.273224043707;7249.855002900018;7269.818254543467;7323.084614423197;7331.670074846751;7391.113066432063;7306.634668266459;7328.706851725871;7331.523450975669;7332.5967071811565;7385.8153546161775;6949.131358580177;7153.570785752663;7153.892691609526;7172.605506697182;7176.820579485346;7359.521631093961;7366.263373662805;7367.631618419165;7375.151857536452;7383.224761399975;6947.895781563179;7186.173590037212;7191.8561628768175;7213.891791623235;7220.422366210795 18:47:10 INFO - PROCESS | 1975 | |5;yui.html;720.607269038374;727.3998950865537;728.1553398058247;733.9467863615711;744.9664765085571;14506.854931450682;14768.409263629455;14819.851801481982;14884.181370024644;14966.551003469885;13114.803277950838;13124.278164700938;13131.934340328286;13146.211227326366;13182.93408532956;704.0776582676697;823.6375994562403;852.9786755331104;876.4609764994547;878.0692465986075;870.0472982084607;870.7779516223354;881.568031664483;882.2765332427412;883.011027649034;813.8657121574932;918.7106061590611;922.6632279218071;925.5048549026272;925.5973651461602;912.6167009855876;913.7076135636532;914.401067300919;915.3501014279869;920.148862302371;661.6195687479718;684.6953105867891;685.7085738561142;688.7899190746821;689.3416786968434;14394.280285985764;14394.78407823873;14427.783583246155;14627.122372657675;14802.481913132988;12784.169029013177;12861.228326300452;12874.87125128746;12909.741805163843;13084.037910644827;10119.443430611313;10188.49057547127;10369.066783989478;10371.325863818904;10441.530131144042;3549.804760738158;3584.6594573515476;3584.946225806615;3586;3587.641235876418;76349;77800.61099694522;78674.42651147002;79285.60357198234;88017.55991220067;9448.244140468745;9506.144446999802;9618.230541556659;9707.029297070236;10156.542955567018;20203.39389818308;20254.89872550628;20272.18911243534;20275.986200689906;20442.38672839817;7407.6666550005375;7434.851302973911;7467.887981680279;7580.0145981022115;7702.8844567331535;3197.280611862359;4036.616521430459;4079.326911059642;4215.988162840896;4222.0500387412585;3579.552555930509;3591.5510561179854;3621.8189090545893;3624.9093772655897;3625.4743062256352;530.3794560364306;660.4947215380238;666.3236814633151;686.1217641418991;693.4764252989062;514.7349115205672;565.9660420374709;605.7365046204915;630.6878095342835;643.0707627478342;8428;8630.697925572575;8722.30221582272;8736.08271131522;8805.025160784136;604.4529700620946;609.2354095610069;615.6952308607179;619.170311782214;619.8171539395889;3723.9069023274633;3940.2513522430645;3966.464527288837;4242.17277630859;4451.198784218872;92740.53629731807;93746;94573.05426945642;97487.53768693475;97627.51186244024;84465;84672.53274672606;85405.57297213475;86340;87685.98512119016;69528.95706564406;69592;70870.64564677143;70913.58172836514;71773.64113179401;7883.251091146332;9037.457752534869;9051.683191088281;9162.037986011639;9187.494687792236;34759.13102172466;40226.79886600548;42662.36006459968;43247.13505729931;49836.25245621391;58831;65388.67305663632;68172.3182768166;69498.3050169512;70088.24779380557;10809.837852432378;11028.5037173329;11091.72270693239;11362.715932101764;11805.976527174738;12110.515579376726;12202.206856554296;12507.4371653274;12762.17045892014;12786.936065319614;11265.831012534982;11797.76404471923;11800.586979455678;11827.645170644895;12398.5660501882;11654.067674586182;11700.239484433825;11722.472488738198;11732.237404568676;12333.260004399406;11263.831042534532;11664.008559272557;11670.94164529172;11672.124590655565;11673.824892626448;9173.633054677739;9190.264778817813;9325.80843501763;9651.613935442503;10257.794844102928;8777.868331974898;9280.303977201602;9356.625734970525;9391.530423478935;9865.704028879145 18:47:10 INFO - PROCESS | 1975 | __end_tp_report 18:47:10 INFO - PROCESS | 1975 | __start_cc_report 18:47:10 INFO - PROCESS | 1975 | _x_x_mozilla_cycle_collect,363 18:47:10 INFO - PROCESS | 1975 | __end_cc_report 18:47:10 INFO - PROCESS | 1975 | __startTimestamp1455590830571__endTimestamp 18:47:10 INFO - PROCESS | 1975 | 18:47:10 INFO - PROCESS | 1975 | ------- Summary: start ------- 18:47:10 INFO - PROCESS | 1975 | Number of tests: 6 18:47:10 INFO - PROCESS | 1975 | 18:47:10 INFO - PROCESS | 1975 | [#0] dojo.html Cycles:165 Average:5684.56 Median:6031.13 stddev:675.31 (11.2%) stddev-sans-first:654.20 18:47:10 INFO - PROCESS | 1975 | Values: 3448.0 3448.9 3492.7 3509.5 3510.7 4901.6 5629.8 5666.1 5683.9 5693.5 4460.4 5639.0 5712.1 5737.9 5815.6 5131.7 5184.1 5205.6 5227.9 5322.4 4266.9 5065.6 5102.5 5194.2 5261.6 5172.4 5184.3 5193.2 5195.7 5197.5 5223.2 5227.0 5237.8 5247.6 5263.4 5067.1 5104.0 5170.8 5176.7 5192.9 4583.6 5419.8 5650.4 5654.8 5671.3 6085.2 6144.2 6208.0 6217.6 6222.3 6144.5 6220.5 6259.2 6260.6 6295.0 5823.6 5835.2 5851.9 5871.1 5921.9 6136.9 6173.9 6248.9 6262.2 6277.4 6096.9 6124.7 6134.8 6142.5 6156.9 6183.3 6252.4 6252.6 6255.7 6260.0 6060.1 6148.0 6204.1 6220.8 6235.4 6171.5 6216.9 6217.9 6223.6 6243.3 4770.4 4841.0 4858.8 4894.2 4911.9 4332.9 4362.7 4387.7 4407.1 4428.5 4811.8 5672.7 5691.2 5712.4 5737.7 6144.3 6171.2 6267.8 6273.3 6275.2 4773.3 5659.8 5714.1 5749.1 5753.6 4642.8 4909.8 5143.6 5252.4 5382.1 6198.5 6230.7 6285.6 6285.8 6297.1 6223.2 6260.2 6269.0 6274.8 6277.1 6152.6 6226.8 6254.5 6269.2 6289.0 6132.6 6180.6 6185.7 6195.2 6211.0 5650.0 6251.6 6263.5 6266.5 6283.2 5698.8 5873.1 6103.4 6156.2 6168.6 6109.5 6115.8 6141.9 6150.6 6160.6 4626.6 5942.0 6011.0 6012.7 6062.2 6063.5 6116.4 6117.8 6169.4 6175.3 6031.1 6035.0 6044.0 6046.8 6064.8 18:47:10 INFO - PROCESS | 1975 | 18:47:10 INFO - PROCESS | 1975 | [#1] ext.html Cycles:180 Average:58353.32 Median:37993.93 stddev:116327.94 (306.2%) stddev-sans-first:116572.89 18:47:10 INFO - PROCESS | 1975 | Values: 399.6 439.0 463.4 526.6 592.9 33987.3 37882.4 37948.4 38039.6 38155.9 39497.0 39738.0 39830.8 39877.4 39946.0 9337.0 9512.7 9534.9 9564.3 9588.2 9256.6 9530.5 9549.1 9558.7 9570.4 9529.0 9555.0 9574.0 9620.3 9625.3 9463.7 9577.0 9580.8 9606.0 9617.4 9472.3 9565.5 9603.9 9608.0 9659.9 37687.1 38039.4 38072.8 38448.6 38462.0 2787.7 3179.8 3231.3 3348.2 3364.3 26303.0 26325.5 27182.9 27355.0 27733.9 2774.5 2792.4 2808.2 2870.8 2948.7 279753.0 341311.0 342699.0 343907.0 344080.0 56129.4 57149.7 64731.0 66725.7 67025.0 52368.0 58483.0 63710.0 63952.0 64161.0 13449.3 15900.5 16244.4 16264.2 16271.9 12213.8 12243.3 12307.6 12307.7 12592.3 20037.0 20843.8 20859.5 20893.8 20988.7 7160.5 7278.9 8431.4 8603.8 8675.8 931.5 972.8 1003.0 1051.4 1145.4 29642.7 29804.9 29999.4 30588.4 31390.9 1031.1 1084.1 1179.7 1201.7 1207.1 15263.8 15269.0 15370.2 15519.8 15593.8 530980.0 539553.0 541606.0 544141.0 551309.0 56308.0 57446.4 57727.7 57893.0 58164.7 1215.9 1287.0 1484.1 1488.2 1497.2 30052.5 30204.1 30283.2 30487.8 30591.8 48046.5 48409.3 48459.5 48829.5 49018.3 388576.0 388579.0 399331.0 401495.9 490443.0 33990.0 44414.6 44741.6 45737.0 45818.0 43794.3 43873.8 44274.6 44783.0 44871.5 35968.8 36888.9 37178.6 37252.0 37653.9 36543.8 36934.0 37574.8 38112.6 38601.6 35214.6 35510.5 35784.1 35875.6 36152.6 27619.4 31200.0 31524.5 32461.8 33459.8 20927.6 25036.4 25977.6 26025.9 26207.2 18:47:10 INFO - PROCESS | 1975 | 18:47:10 INFO - PROCESS | 1975 | [#2] jquery.html Cycles:180 Average:35178.56 Median:370.76 stddev:110600.34 (29831.0%) stddev-sans-first:110879.69 18:47:10 INFO - PROCESS | 1975 | Values: 356.9 369.8 371.7 373.2 374.3 15342.5 17309.8 19436.5 19709.3 20167.1 11474.2 11638.8 11720.2 11749.9 11775.8 3916.0 5137.3 5191.1 5437.3 5794.8 5902.5 5910.6 5913.1 5979.2 5987.3 5350.7 6018.5 6491.8 6526.9 6535.0 5267.1 5837.1 5944.6 6436.8 6536.5 5629.7 5645.6 5648.2 5671.7 5700.9 23484.2 23730.4 23955.4 24052.0 24123.9 2102.5 2156.7 2213.8 2239.4 2626.3 9599.1 9671.8 9686.0 9890.8 10083.0 1721.7 1787.0 1816.7 1822.7 1838.7 75414.0 96734.0 99548.0 101829.5 102204.5 8929.5 9512.1 10408.9 10463.9 11199.9 12908.4 13331.5 13340.9 13367.9 13409.7 6573.6 8154.0 8312.5 8347.0 8364.4 8239.8 8287.3 8291.3 8372.6 8398.4 3914.2 4156.2 4262.7 4301.2 4306.1 1850.3 1863.9 1865.1 1894.4 1902.4 916.1 927.0 936.7 955.0 1033.0 19097.1 19634.8 19799.6 20043.5 20108.3 974.8 977.4 978.2 1009.5 1035.8 10703.5 11004.2 11108.2 11117.7 11135.0 620600.0 628982.0 634935.0 725652.0 728644.0 111964.4 112309.0 118281.0 119264.4 119424.0 1207.5 1208.1 1210.3 1214.0 1216.5 13178.9 14757.8 18072.6 18338.8 18402.2 40451.8 51680.7 52081.5 53159.5 53489.1 74505.6 75115.5 75942.0 76502.6 77019.2 7426.4 7435.9 7509.1 7769.6 7886.8 8800.7 9146.9 11481.9 12104.6 12236.9 9741.8 10056.4 10592.4 10606.2 10649.4 10312.4 10464.8 10583.2 10611.3 10684.6 10605.3 10689.4 10763.1 10866.0 11136.3 7522.4 7622.9 7639.4 7775.9 7831.0 9808.2 9960.6 10366.9 10841.5 10863.8 18:47:10 INFO - PROCESS | 1975 | 18:47:10 INFO - PROCESS | 1975 | [#3] mootools.html Cycles:180 Average:6103.80 Median:5080.34 stddev:3217.72 (63.3%) stddev-sans-first:3208.40 18:47:10 INFO - PROCESS | 1975 | Values: 1532.4 1550.2 1781.6 1817.7 1888.6 7938.8 7967.1 8647.8 8947.2 8970.6 8693.3 8736.3 8736.7 8851.8 8871.3 2179.2 2357.3 2491.1 2499.2 2503.3 2467.0 2493.9 2496.5 2496.9 2503.3 2200.5 2414.5 2455.1 2470.3 2477.8 2433.4 2452.1 2467.2 2470.6 2479.6 2449.9 2464.1 2474.0 2475.3 2476.5 8841.1 8848.1 8864.6 8866.2 8875.2 5381.5 5506.5 5521.0 5545.8 5562.6 3611.9 3691.3 3736.9 3739.2 3754.0 1048.4 1053.3 1062.2 1087.5 1099.3 12211.9 12244.0 12289.9 12309.6 12344.9 4210.2 4854.5 4884.8 4922.7 4987.5 7550.8 10357.3 10391.4 10408.8 10432.6 5465.8 5562.2 5595.3 5599.2 5620.4 5018.3 5056.9 5067.8 5092.9 5114.5 4013.4 4018.1 4037.5 4057.1 4090.9 1130.7 1237.3 1331.0 1335.1 1355.4 1066.6 1096.5 1098.2 1260.7 1352.0 7985.6 8067.7 8126.8 8267.6 8532.7 1170.9 1188.2 1202.8 1206.3 1217.9 6243.2 6281.6 6288.6 6347.0 6367.3 10498.4 10717.2 10803.9 10808.6 10826.9 10569.4 10815.0 10819.5 10854.8 11096.7 8443.7 8515.3 8525.9 8564.4 8567.6 7888.6 7983.4 8008.9 8021.2 8067.9 7858.5 9764.8 9766.7 9850.1 9943.9 9983.8 10071.3 10168.2 10187.4 10250.9 7517.2 7532.4 7602.9 7629.4 7641.5 8199.5 8213.9 8232.0 8255.0 8259.9 7074.9 7235.7 7614.2 7644.5 7944.5 7461.4 7482.7 7580.2 7616.6 7684.1 6267.9 7131.9 7612.0 7657.6 7669.5 5920.6 6860.9 6889.2 6945.8 6979.6 7064.8 7158.9 7162.1 7162.6 7189.4 18:47:10 INFO - PROCESS | 1975 | 18:47:10 INFO - PROCESS | 1975 | [#4] prototype.html Cycles:180 Average:5870.83 Median:6638.72 stddev:1900.33 (28.6%) stddev-sans-first:1859.48 18:47:10 INFO - PROCESS | 1975 | Values: 323.4 330.3 332.2 334.4 341.0 4757.1 5366.9 6348.9 6421.5 6737.0 6806.6 6833.2 6850.7 6877.0 6889.9 4695.6 5049.3 5090.6 5096.7 5109.2 4956.3 5044.2 5104.8 5105.1 5118.3 4160.8 4980.2 4994.2 5011.3 5040.2 4953.3 5007.7 5010.1 5031.3 5053.4 4256.8 4275.9 4285.7 4296.0 4296.7 6274.4 6587.9 6601.8 6631.1 6668.9 5784.4 5785.5 5786.2 5792.7 5862.3 7202.8 7231.3 7252.9 7276.5 7277.5 3775.6 4616.0 4621.8 4629.3 4640.2 7222.4 7616.6 7617.2 7626.1 7654.6 4655.0 4661.9 4669.7 4672.2 4684.7 4760.8 4761.2 4763.2 4781.9 4791.6 5534.7 5714.8 5730.6 5734.9 5738.8 7233.9 7238.5 7265.5 7358.2 7375.6 1294.7 1569.5 1605.6 1648.6 1649.0 1003.0 1031.8 1041.5 1053.9 1059.5 6600.2 6661.3 6676.9 6680.5 6692.8 5333.6 7342.9 7424.9 7443.3 7450.4 6461.8 6646.4 6664.0 6670.2 6677.8 3937.0 3964.6 3969.5 3975.8 3980.9 7715.0 7715.2 7716.2 7721.2 7723.7 6060.1 6249.5 7601.4 7672.1 7915.6 6317.4 7724.0 7733.2 7759.0 7775.9 6255.0 7262.7 7427.0 7435.3 7498.1 6168.9 7246.3 7558.5 7560.2 7574.6 7954.4 7966.7 7977.1 7991.0 7996.5 4703.2 4766.7 4769.5 4769.5 4778.1 7246.9 7374.6 7390.6 7610.2 7650.3 7249.9 7269.8 7323.1 7331.7 7391.1 7306.6 7328.7 7331.5 7332.6 7385.8 6949.1 7153.6 7153.9 7172.6 7176.8 7359.5 7366.3 7367.6 7375.2 7383.2 6947.9 7186.2 7191.9 7213.9 7220.4 18:47:10 INFO - PROCESS | 1975 | 18:47:10 INFO - PROCESS | 1975 | [#5] yui.html Cycles:180 Average:18347.46 Median:619.49 stddev:26135.69 (4218.9%) stddev-sans-first:26175.50 18:47:10 INFO - PROCESS | 1975 | Values: 720.6 727.4 728.2 733.9 745.0 14506.9 14768.4 14819.9 14884.2 14966.6 13114.8 13124.3 13131.9 13146.2 13182.9 704.1 823.6 853.0 876.5 878.1 870.0 870.8 881.6 882.3 883.0 813.9 918.7 922.7 925.5 925.6 912.6 913.7 914.4 915.4 920.1 661.6 684.7 685.7 688.8 689.3 14394.3 14394.8 14427.8 14627.1 14802.5 12784.2 12861.2 12874.9 12909.7 13084.0 10119.4 10188.5 10369.1 10371.3 10441.5 3549.8 3584.7 3584.9 3586.0 3587.6 76349.0 77800.6 78674.4 79285.6 88017.6 9448.2 9506.1 9618.2 9707.0 10156.5 20203.4 20254.9 20272.2 20276.0 20442.4 7407.7 7434.9 7467.9 7580.0 7702.9 3197.3 4036.6 4079.3 4216.0 4222.1 3579.6 3591.6 3621.8 3624.9 3625.5 530.4 660.5 666.3 686.1 693.5 514.7 566.0 605.7 630.7 643.1 8428.0 8630.7 8722.3 8736.1 8805.0 604.5 609.2 615.7 619.2 619.8 3723.9 3940.3 3966.5 4242.2 4451.2 92740.5 93746.0 94573.1 97487.5 97627.5 84465.0 84672.5 85405.6 86340.0 87686.0 69529.0 69592.0 70870.6 70913.6 71773.6 7883.3 9037.5 9051.7 9162.0 9187.5 34759.1 40226.8 42662.4 43247.1 49836.3 58831.0 65388.7 68172.3 69498.3 70088.2 10809.8 11028.5 11091.7 11362.7 11806.0 12110.5 12202.2 12507.4 12762.2 12786.9 11265.8 11797.8 11800.6 11827.6 12398.6 11654.1 11700.2 11722.5 11732.2 12333.3 11263.8 11664.0 11670.9 11672.1 11673.8 9173.6 9190.3 9325.8 9651.6 10257.8 8777.9 9280.3 9356.6 9391.5 9865.7 18:47:10 INFO - PROCESS | 1975 | -------- Summary: end -------- 18:47:10 INFO - PROCESS | 1975 | 18:47:11 INFO - TEST-INFO | 1975: exit 0 18:47:11 INFO - TEST-OK | dromaeo_css | took 1111085ms 18:47:11 INFO - TEST-START | kraken 18:47:11 INFO - operating with platform_type : mac_ 18:47:11 INFO - Initialising browser for kraken test... 18:47:11 INFO - TEST-INFO | started process 1981 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/tmpa83TBx/profile http://localhost:49703/getInfo.html) 18:47:13 INFO - PROCESS | 1981 | __metrics Screen width/height:1600/1200 18:47:13 INFO - PROCESS | 1981 | colorDepth:24 18:47:13 INFO - PROCESS | 1981 | Browser inner width/height: 1024/689 18:47:13 INFO - PROCESS | 1981 | __metrics 18:47:14 INFO - TEST-INFO | 1981: exit 0 18:47:14 INFO - Browser initialized. 18:47:14 INFO - Running cycle 1/1 for kraken test... 18:47:14 INFO - TEST-INFO | started process 1984 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/tmpa83TBx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:47:26 INFO - PROCESS | 1984 | RSS: Main: 255811584 18:47:26 INFO - PROCESS | 1984 | 18:47:29 INFO - PROCESS | 1984 | Cycle 1(1): loaded http://localhost:49703/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49703/tests/kraken/driver.html?testName=audio-beat-detection) 18:47:29 INFO - PROCESS | 1984 | RSS: Main: 268701696 18:47:29 INFO - PROCESS | 1984 | 18:47:32 INFO - PROCESS | 1984 | Cycle 1(1): loaded http://localhost:49703/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49703/tests/kraken/driver.html?testName=audio-dft) 18:47:33 INFO - PROCESS | 1984 | RSS: Main: 277037056 18:47:33 INFO - PROCESS | 1984 | 18:47:36 INFO - PROCESS | 1984 | Cycle 1(1): loaded http://localhost:49703/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49703/tests/kraken/driver.html?testName=audio-fft) 18:47:37 INFO - PROCESS | 1984 | RSS: Main: 282480640 18:47:37 INFO - PROCESS | 1984 | 18:47:38 INFO - PROCESS | 1984 | Cycle 1(1): loaded http://localhost:49703/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49703/tests/kraken/driver.html?testName=audio-oscillator) 18:47:39 INFO - PROCESS | 1984 | RSS: Main: 284069888 18:47:39 INFO - PROCESS | 1984 | 18:47:41 INFO - PROCESS | 1984 | Cycle 1(1): loaded http://localhost:49703/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49703/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:47:42 INFO - PROCESS | 1984 | RSS: Main: 284356608 18:47:42 INFO - PROCESS | 1984 | 18:47:44 INFO - PROCESS | 1984 | Cycle 1(1): loaded http://localhost:49703/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49703/tests/kraken/driver.html?testName=imaging-darkroom) 18:47:45 INFO - PROCESS | 1984 | RSS: Main: 284815360 18:47:45 INFO - PROCESS | 1984 | 18:47:48 INFO - PROCESS | 1984 | Cycle 1(1): loaded http://localhost:49703/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49703/tests/kraken/driver.html?testName=imaging-desaturate) 18:47:49 INFO - PROCESS | 1984 | RSS: Main: 284246016 18:47:49 INFO - PROCESS | 1984 | 18:47:52 INFO - PROCESS | 1984 | Cycle 1(1): loaded http://localhost:49703/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49703/tests/kraken/driver.html?testName=json-parse-financial) 18:47:52 INFO - PROCESS | 1984 | RSS: Main: 285196288 18:47:52 INFO - PROCESS | 1984 | 18:47:54 INFO - PROCESS | 1984 | Cycle 1(1): loaded http://localhost:49703/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49703/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:47:55 INFO - PROCESS | 1984 | RSS: Main: 284745728 18:47:55 INFO - PROCESS | 1984 | 18:47:57 INFO - PROCESS | 1984 | Cycle 1(1): loaded http://localhost:49703/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49703/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:47:57 INFO - PROCESS | 1984 | RSS: Main: 284090368 18:47:57 INFO - PROCESS | 1984 | 18:47:59 INFO - PROCESS | 1984 | Cycle 1(1): loaded http://localhost:49703/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49703/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:48:00 INFO - PROCESS | 1984 | RSS: Main: 283873280 18:48:00 INFO - PROCESS | 1984 | 18:48:02 INFO - PROCESS | 1984 | Cycle 1(1): loaded http://localhost:49703/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49703/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:48:03 INFO - PROCESS | 1984 | RSS: Main: 283172864 18:48:03 INFO - PROCESS | 1984 | 18:48:06 INFO - PROCESS | 1984 | Cycle 1(1): loaded http://localhost:49703/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49703/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:48:06 INFO - PROCESS | 1984 | RSS: Main: 284393472 18:48:06 INFO - PROCESS | 1984 | 18:48:08 INFO - PROCESS | 1984 | Cycle 1(1): loaded http://localhost:49703/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49703/tests/kraken/driver.html?testName=ai-astar) 18:48:08 INFO - PROCESS | 1984 | RSS: Main: 285929472 18:48:08 INFO - PROCESS | 1984 | 18:48:08 INFO - PROCESS | 1984 | __start_tp_report 18:48:08 INFO - PROCESS | 1984 | _x_x_mozilla_page_load 18:48:08 INFO - PROCESS | 1984 | _x_x_mozilla_page_load_details 18:48:08 INFO - PROCESS | 1984 | |i|pagename|runs| 18:48:08 INFO - PROCESS | 1984 | |0;ai-astar;113;111;110;115;114;127;114;112;118;114 18:48:08 INFO - PROCESS | 1984 | |1;audio-beat-detection;195;161;149;151;108;158;152;142;154;106 18:48:08 INFO - PROCESS | 1984 | |2;audio-dft;198;262;200;259;234;199;199;195;204;197 18:48:08 INFO - PROCESS | 1984 | |3;audio-fft;70;72;73;124;56;57;59;58;86;56 18:48:08 INFO - PROCESS | 1984 | |4;audio-oscillator;82;84;125;80;82;82;118;82;82;115 18:48:08 INFO - PROCESS | 1984 | |5;imaging-gaussian-blur;86;92;84;91;85;90;75;139;129;94 18:48:08 INFO - PROCESS | 1984 | |6;imaging-darkroom;95;146;100;95;99;96;92;91;151;153 18:48:08 INFO - PROCESS | 1984 | |7;imaging-desaturate;93;107;83;83;140;133;127;134;135;127 18:48:08 INFO - PROCESS | 1984 | |8;json-parse-financial;54;54;56;52;62;67;78;92;86;87 18:48:08 INFO - PROCESS | 1984 | |9;json-stringify-tinderbox;54;83;102;63;98;108;59;57;62;59 18:48:08 INFO - PROCESS | 1984 | |10;stanford-crypto-aes;84;86;84;89;84;86;84;85;83;87 18:48:08 INFO - PROCESS | 1984 | |11;stanford-crypto-ccm;124;124;129;134;131;144;140;149;127;126 18:48:08 INFO - PROCESS | 1984 | |12;stanford-crypto-pbkdf2;127;138;149;176;186;140;142;142;140;127 18:48:08 INFO - PROCESS | 1984 | |13;stanford-crypto-sha256-iterative;73;69;69;68;59;62;88;98;70;66 18:48:08 INFO - PROCESS | 1984 | __end_tp_report 18:48:08 INFO - PROCESS | 1984 | __start_cc_report 18:48:08 INFO - PROCESS | 1984 | _x_x_mozilla_cycle_collect,897 18:48:08 INFO - PROCESS | 1984 | __end_cc_report 18:48:08 INFO - PROCESS | 1984 | __startTimestamp1455590888717__endTimestamp 18:48:08 INFO - PROCESS | 1984 | 18:48:08 INFO - PROCESS | 1984 | ------- Summary: start ------- 18:48:08 INFO - PROCESS | 1984 | Number of tests: 14 18:48:08 INFO - PROCESS | 1984 | 18:48:08 INFO - PROCESS | 1984 | [#0] ai-astar Cycles:10 Average:114.80 Median:114.00 stddev:4.83 (4.2%) stddev-sans-first:5.07 18:48:08 INFO - PROCESS | 1984 | Values: 113.0 111.0 110.0 115.0 114.0 127.0 114.0 112.0 118.0 114.0 18:48:08 INFO - PROCESS | 1984 | 18:48:08 INFO - PROCESS | 1984 | [#1] audio-beat-detection Cycles:10 Average:147.60 Median:153.00 stddev:25.69 (16.8%) stddev-sans-first:20.74 18:48:08 INFO - PROCESS | 1984 | Values: 195.0 161.0 149.0 151.0 108.0 158.0 152.0 142.0 154.0 106.0 18:48:08 INFO - PROCESS | 1984 | 18:48:08 INFO - PROCESS | 1984 | [#2] audio-dft Cycles:10 Average:214.70 Median:202.00 stddev:26.62 (13.2%) stddev-sans-first:27.54 18:48:08 INFO - PROCESS | 1984 | Values: 198.0 262.0 200.0 259.0 234.0 199.0 199.0 195.0 204.0 197.0 18:48:08 INFO - PROCESS | 1984 | 18:48:08 INFO - PROCESS | 1984 | [#3] audio-fft Cycles:10 Average:71.10 Median:64.50 stddev:21.08 (32.7%) stddev-sans-first:22.35 18:48:08 INFO - PROCESS | 1984 | Values: 70.0 72.0 73.0 124.0 56.0 57.0 59.0 58.0 86.0 56.0 18:48:08 INFO - PROCESS | 1984 | 18:48:08 INFO - PROCESS | 1984 | [#4] audio-oscillator Cycles:10 Average:93.20 Median:82.00 stddev:18.22 (22.2%) stddev-sans-first:18.87 18:48:08 INFO - PROCESS | 1984 | Values: 82.0 84.0 125.0 80.0 82.0 82.0 118.0 82.0 82.0 115.0 18:48:08 INFO - PROCESS | 1984 | 18:48:08 INFO - PROCESS | 1984 | [#5] imaging-gaussian-blur Cycles:10 Average:96.50 Median:88.00 stddev:20.61 (23.4%) stddev-sans-first:21.51 18:48:08 INFO - PROCESS | 1984 | Values: 86.0 92.0 84.0 91.0 85.0 90.0 75.0 139.0 129.0 94.0 18:48:08 INFO - PROCESS | 1984 | 18:48:08 INFO - PROCESS | 1984 | [#6] imaging-darkroom Cycles:10 Average:111.80 Median:93.50 stddev:26.55 (28.4%) stddev-sans-first:27.46 18:48:08 INFO - PROCESS | 1984 | Values: 95.0 146.0 100.0 95.0 99.0 96.0 92.0 91.0 151.0 153.0 18:48:08 INFO - PROCESS | 1984 | 18:48:08 INFO - PROCESS | 1984 | [#7] imaging-desaturate Cycles:10 Average:116.20 Median:137.50 stddev:22.56 (16.4%) stddev-sans-first:22.31 18:48:08 INFO - PROCESS | 1984 | Values: 93.0 107.0 83.0 83.0 140.0 133.0 127.0 134.0 135.0 127.0 18:48:08 INFO - PROCESS | 1984 | 18:48:08 INFO - PROCESS | 1984 | [#8] json-parse-financial Cycles:10 Average:68.80 Median:72.50 stddev:15.58 (21.5%) stddev-sans-first:15.57 18:48:08 INFO - PROCESS | 1984 | Values: 54.0 54.0 56.0 52.0 62.0 67.0 78.0 92.0 86.0 87.0 18:48:08 INFO - PROCESS | 1984 | 18:48:08 INFO - PROCESS | 1984 | [#9] json-stringify-tinderbox Cycles:10 Average:74.50 Median:60.50 stddev:21.08 (34.8%) stddev-sans-first:21.01 18:48:08 INFO - PROCESS | 1984 | Values: 54.0 83.0 102.0 63.0 98.0 108.0 59.0 57.0 62.0 59.0 18:48:08 INFO - PROCESS | 1984 | 18:48:08 INFO - PROCESS | 1984 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:85.50 stddev:1.81 (2.1%) stddev-sans-first:1.87 18:48:08 INFO - PROCESS | 1984 | Values: 84.0 86.0 84.0 89.0 84.0 86.0 84.0 85.0 83.0 87.0 18:48:08 INFO - PROCESS | 1984 | 18:48:08 INFO - PROCESS | 1984 | [#11] stanford-crypto-ccm Cycles:10 Average:132.80 Median:132.50 stddev:8.78 (6.6%) stddev-sans-first:8.71 18:48:08 INFO - PROCESS | 1984 | Values: 124.0 124.0 129.0 134.0 131.0 144.0 140.0 149.0 127.0 126.0 18:48:08 INFO - PROCESS | 1984 | 18:48:08 INFO - PROCESS | 1984 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.70 Median:142.00 stddev:19.42 (13.7%) stddev-sans-first:19.24 18:48:08 INFO - PROCESS | 1984 | Values: 127.0 138.0 149.0 176.0 186.0 140.0 142.0 142.0 140.0 127.0 18:48:08 INFO - PROCESS | 1984 | 18:48:08 INFO - PROCESS | 1984 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.20 Median:69.50 stddev:11.91 (17.1%) stddev-sans-first:12.62 18:48:08 INFO - PROCESS | 1984 | Values: 73.0 69.0 69.0 68.0 59.0 62.0 88.0 98.0 70.0 66.0 18:48:08 INFO - PROCESS | 1984 | -------- Summary: end -------- 18:48:08 INFO - PROCESS | 1984 | 18:48:09 INFO - TEST-INFO | 1984: exit 0 18:48:09 INFO - TEST-OK | kraken | took 58389ms 18:48:09 INFO - SUITE-END | took 1169s 18:48:09 INFO - Completed test suite (00:19:29) 18:48:09 INFO - Working with test: dromaeo_css 18:48:09 INFO - Generating results file: dromaeo_css 18:48:09 INFO - Working with test: kraken 18:48:09 INFO - Generating results file: kraken 18:48:09 INFO - javascript benchmark 18:48:09 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:48:10 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 18:48:10 INFO - process_Request line: dromaeo_css 7502.77 graph.html#tests=[[72,64,61]] 18:48:10 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:48:10 INFO - process_Request line: kraken 1546.10 graph.html#tests=[[232,64,61]] 18:48:10 INFO - RETURN: dromaeo_css: 7502.77 18:48:10 INFO - RETURN: kraken: 1546.10 18:48:10 INFO - javascript benchmark 18:48:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3448.0345503259095, 3448.9137771555706, 3492.6681965213297, 3509.5086687863704, 3510.684038436541, 4901.558859702631, 5629.802956896509, 5666.121751128577, 5683.8579035524135, 5693.487586117249, 4460.375547423363, 5638.971805140979, 5712.057510510771, 5737.938481380937, 5815.5638327125525, 5131.666441681288, 5184.144616138333, 5205.609579281569, 5227.869303267411, 5322.414534401213, 4266.850660226893, 5065.569426598725, 5102.489751024905, 5194.246834209038, 5261.631685781997, 5172.353455818023, 5184.326037615124, 5193.221016847466, 5195.740212989335, 5197.48025197481, 5223.2165175223645, 5227.032998895179, 5237.79048838046, 5247.580193584504, 5263.3947096083675, 5067.0879241736475, 5104.0, 5170.793168273264, 5176.715280659562, 5192.8961420771375, 4583.610393116589, 5419.810306639288, 5650.434956504358, 5654.830355089354, 5671.291088613923, 6085.208922840046, 6144.201253837017, 6208.00671892495, 6217.626942383471, 6222.284437289724, 6144.494598823272, 6220.47125994291, 6259.2488901332135, 6260.624362538262, 6295.0, 5823.621464604787, 5835.241418615596, 5851.912221316684, 5871.089981052944, 5921.911171332434, 6136.917362303815, 6173.938260617426, 6248.875022499616, 6262.2172228471445, 6277.435030847246, 6096.939030609726, 6124.693765311717, 6134.7852825151795, 6142.477889379364, 6156.8768624627255, 6183.288921773964, 6252.374762523802, 6252.624842509464, 6255.74977000924, 6260.0, 6060.090986352083, 6148.0, 6204.100405441186, 6220.813375598649, 6235.376462353819, 6171.47542458896, 6216.906746398808, 6217.875642487125, 6223.595466294676, 6243.313235544087, 4770.379850619397, 4840.975795121002, 4858.7570621468785, 4894.241392584155, 4911.852644420673, 4332.935005974913, 4362.716423432466, 4387.736735795863, 4407.140607581555, 4428.4685837699035, 4811.759412029384, 5672.744726487318, 5691.174779656926, 5712.428757124338, 5737.655740655574, 6144.279601711528, 6171.197744293213, 6267.843303917439, 6273.341299163613, 6275.215598050244, 4773.260144677511, 5659.830205093854, 5714.142878568165, 5749.108888122348, 5753.626014309057, 4642.814287428532, 4909.7790599423115, 5143.588512918957, 5252.369715634072, 5382.085045542267, 6198.504119670415, 6230.719617617127, 6285.622862628257, 6285.811425657238, 6297.118403423525, 6223.222097237845, 6260.154879091265, 6269.028300613412, 6274.811755647338, 6277.121203031488, 6152.569320147726, 6226.813195604139, 6254.530910181664, 6269.153664255267, 6288.968555157195, 6132.600268413531, 6180.6291622502795, 6185.659788711484, 6195.19462469876, 6211.0, 5649.954758369715, 6251.624902505864, 6263.530235232284, 6266.530010249158, 6283.183186185766, 5698.8290351289525, 5873.060310350324, 6103.359147289649, 6156.199694039925, 6168.599041062496, 6109.533711909021, 6115.780809617568, 6141.9385806143155, 6150.616111374905, 6160.568760186744, 4626.560476754703, 5942.0, 6011.0, 6012.7294271757, 6062.151298818081, 6063.454289114001, 6116.388361164026, 6117.828170999409, 6169.352218017044, 6175.2589689237575, 6031.125486804301, 6035.0, 6043.969780151071, 6046.788362407295, 6064.757409703562], "unit": "score", "name": "dojo.html", "value": 5643.143400905409}, {"lowerIsBetter": false, "replicates": [399.60838378389195, 438.95090733147765, 463.38601353206997, 526.6313580493654, 592.8912932815635, 33987.32025359492, 37882.4317635235, 37948.43077353842, 38039.619603803956, 38155.85532434028, 39497.0, 39738.0, 39830.8008459958, 39877.401838972364, 39946.0, 9336.953315233415, 9512.66705665302, 9534.904650953471, 9564.282678799083, 9588.232941364675, 9256.6297348106, 9530.475823829687, 9549.09283618055, 9558.713238602853, 9570.425774453555, 9529.0, 9554.952225238863, 9573.99473055326, 9620.278479114095, 9625.278104142182, 9463.668771592995, 9577.0, 9580.760480987996, 9605.951970240174, 9617.374870633386, 9472.336936414455, 9565.473898935556, 9603.855942160873, 9607.951960240154, 9659.855102173473, 37687.05782355436, 38039.42940855889, 38072.80963595164, 38448.61551384506, 38462.038449039, 2787.693353731088, 3179.777415580887, 3231.2729635831984, 3348.2131699050706, 3364.2934983653463, 26303.0, 26325.473490530083, 27182.912683492636, 27355.0, 27733.861330693217, 2774.4589804988036, 2792.3996340786625, 2808.171589381117, 2870.799044066916, 2948.6609039960463, 279753.0, 341311.0, 342699.0, 343907.0, 344080.0, 56129.43870561324, 57149.71425142848, 64731.0, 66725.6663716688, 67025.0, 52368.0, 58483.0, 63710.0, 63952.0, 64161.0, 13449.32753362328, 15900.52298431049, 16244.431444899608, 16264.18679066042, 16271.918640406959, 12213.755724885452, 12243.265404075606, 12307.630771076882, 12307.69230769238, 12592.307423091817, 20036.998150092437, 20843.791562084185, 20859.478513037295, 20893.791062089487, 20988.685169722467, 7160.534565253241, 7278.890816637755, 8431.409801313972, 8603.784905377415, 8675.826483470295, 931.4923366765129, 972.844344904826, 1002.9598816047277, 1051.3691784929135, 1145.4158379226653, 29642.703572964427, 29804.850975744983, 29999.400011999638, 30588.38823223523, 31390.901318454202, 1031.118025119792, 1084.0839490630406, 1179.7050737315672, 1201.7356181640025, 1207.1308657766394, 15263.771043434357, 15269.0, 15370.231488425534, 15519.844801552066, 15593.844061559466, 530980.0, 539553.0, 541606.0, 544141.0, 551309.0, 56308.0, 57446.425535744944, 57727.711361442925, 57893.0, 58164.70917645469, 1215.8784121587948, 1286.9832832062752, 1484.087286318906, 1488.1740633948045, 1497.2214448486725, 30052.549211762278, 30204.09387718372, 30283.242918927204, 30487.847560762053, 30591.847040765544, 48046.5195348042, 48409.27386089282, 48459.5154048455, 48829.51170488392, 49018.264726029855, 388576.0, 388579.0, 399331.0, 401495.9027663193, 490443.0, 33990.0, 44414.555854441045, 44741.55258447504, 45737.0, 45818.0, 43794.34308485439, 43873.78063109664, 44274.55725442704, 44783.0, 44871.51284871487, 35968.820155899055, 36888.922148219994, 37178.6282137186, 37252.0, 37653.87038388853, 36543.81728091343, 36934.0, 37574.81212593919, 38112.618873810905, 38601.6139838598, 35214.64785352216, 35510.5294691443, 35784.105397365274, 35875.64124358723, 36152.63847361493, 27619.447611047264, 31200.0, 31524.52713209258, 32461.837690811393, 33459.83270083634, 20927.581448371253, 25036.37409064715, 25977.610335844598, 26025.869870650524, 26207.21378358652], "unit": "score", "name": "ext.html", "value": 19385.49839294743}, {"lowerIsBetter": false, "replicates": [356.9286142771446, 369.81878879349125, 371.69335298378843, 373.18086799475157, 374.25336453774713, 15342.539723808275, 17309.82690173098, 19436.51408714783, 19709.31017414391, 20167.092480838342, 11474.196806223568, 11638.767224655501, 11720.238184518, 11749.941250293736, 11775.7644847103, 3915.960840391588, 5137.306463627409, 5191.091558977164, 5437.265969094161, 5794.797182098628, 5902.468777809996, 5910.61580997236, 5913.14259432382, 5979.192808970777, 5987.251593550806, 5350.652207606513, 6018.518518518508, 6491.772787952423, 6526.934730652704, 6534.954407294834, 5267.078261304257, 5837.066069428871, 5944.583879128462, 6436.80689579311, 6536.509761767863, 5629.71851407432, 5645.576581756384, 5648.237487939116, 5671.659700417947, 5700.857478563028, 23484.178053768035, 23730.40673983147, 23955.40111497209, 24052.0, 24123.879380602986, 2102.4638717127186, 2156.7304086989125, 2213.767554406796, 2239.3729755668437, 2626.290901456596, 9599.08808663183, 9671.758206044835, 9685.951570242174, 9890.752731181707, 10082.99170082993, 1721.672882152387, 1786.9910650446795, 1816.6911625023777, 1822.7265910113456, 1838.7241913712917, 75414.0, 96734.0, 99548.00451995533, 101829.49085254526, 102204.48897755537, 8929.508877011827, 9512.09635084666, 10408.895911040943, 10463.94768026155, 11199.888001120047, 12908.419121139572, 13331.533396331082, 13340.866591333963, 13367.866321336856, 13409.66475838112, 6573.605583664996, 8153.959230203811, 8312.5428101455, 8346.958265208636, 8364.414490985573, 8239.752807415787, 8287.254147126787, 8291.253787159185, 8372.581370931552, 8398.412111152284, 3914.1584559319313, 4156.189543039079, 4262.70161088727, 4301.16127355169, 4306.138772245564, 1850.3153833081847, 1863.9161237744333, 1865.0861078071648, 1894.4127320530679, 1902.4387805597382, 916.1205242966694, 926.9942112807679, 936.7330310861372, 955.0160656908241, 1032.9586816527406, 19097.140628671743, 19634.803651963583, 19799.60400791976, 20043.498912527302, 20108.296209632594, 974.7855471796194, 977.4379731654327, 978.2125389061731, 1009.5059312217959, 1035.8290882004385, 10703.46482675863, 11004.174686898514, 11108.222424430374, 11117.666470005914, 11135.0, 620600.0, 628982.0, 634935.0, 725652.0, 728644.0, 111964.44017779859, 112309.0, 118281.0, 119264.40367798106, 119424.0, 1207.4687137659225, 1208.1301462946665, 1210.285931300537, 1213.9817902731465, 1216.5255550335376, 13178.934105329412, 14757.778633320295, 18072.638547229246, 18338.81661183371, 18402.171902264163, 40451.797741011105, 51680.74159629178, 52081.47918520766, 53159.46840531545, 53489.10231809332, 74505.62747186446, 75115.49769004699, 75942.0, 76502.6174869122, 77019.22980770345, 7426.403115002151, 7435.92564074374, 7509.061367329084, 7769.572673503011, 7886.842263154819, 8800.735977920673, 9146.862797057916, 11481.851814818452, 12104.576339828063, 12236.877631223573, 9741.756456088655, 10056.446895420822, 10592.417417041828, 10606.204534659777, 10649.361038337725, 10312.381257124596, 10464.790704186025, 10583.153347732317, 10611.31026483276, 10684.626038088629, 10605.310654807412, 10689.412082335546, 10763.138948884227, 10866.022058014816, 11136.33182009082, 7522.398208143226, 7622.885656715264, 7639.427042971911, 7775.883361749691, 7831.0, 9808.16630586408, 9960.601575937171, 10366.896331036894, 10841.512131953923, 10863.837042444527], "unit": "score", "name": "jquery.html", "value": 9071.09825084111}, {"lowerIsBetter": false, "replicates": [1532.4253404973135, 1550.2248875562223, 1781.6169523552433, 1817.7185084515418, 1888.5845114074907, 7938.841223175533, 7967.123616402191, 8647.783805404868, 8947.239484643813, 8970.641174353026, 8693.261072808804, 8736.344774141933, 8736.694215702451, 8851.822963540726, 8871.290296776258, 2179.204590324536, 2357.26924653358, 2491.0658503061354, 2499.2252401755422, 2503.3115893129443, 2466.9753302467016, 2493.887775050118, 2496.450780828215, 2496.8876400562017, 2503.336615796806, 2200.515886504966, 2414.4808866093786, 2455.1161581830524, 2470.29596564979, 2477.7770000699934, 2433.4038160650666, 2452.1049816816912, 2467.1734968785477, 2470.6047032474717, 2479.6280557916366, 2449.926502204919, 2464.125235541375, 2474.022761009391, 2475.282168171246, 2476.4799392127675, 8841.071687472851, 8848.115188481164, 8864.645414183426, 8866.157715017063, 8875.245604123656, 5381.5425688816495, 5506.476884695948, 5521.033819081645, 5545.77816887328, 5562.554995600342, 3611.9097022574383, 3691.298653255873, 3736.869209577652, 3739.1773809761808, 3753.9812300938593, 1048.397171626318, 1053.3048188195753, 1062.2086545523634, 1087.4508373271526, 1099.2634934593761, 12211.877881221162, 12244.0, 12289.877101228964, 12309.56916507918, 12344.876551234462, 4210.200061988274, 4854.514548545118, 4884.780184891689, 4922.704637721677, 4987.526185012418, 7550.848983020419, 10357.326773759682, 10391.428471434143, 10408.791824163625, 10432.64375631163, 5465.836024919259, 5562.249096371938, 5595.272614560081, 5599.244102046172, 5620.353659329229, 5018.2974383586325, 5056.924146137811, 5067.771950262247, 5092.898142037213, 5114.488551144856, 4013.4381186633896, 4018.1160144768105, 4037.4549435826375, 4057.14799892026, 4090.8568200112854, 1130.7166366174288, 1237.270010693677, 1330.973380532384, 1335.0921373465942, 1355.4239448234462, 1066.594694016269, 1096.4517741129434, 1098.1983152298867, 1260.7289432771815, 1351.9932400337934, 7985.640646170937, 8067.717629883044, 8126.83746325082, 8267.586620668942, 8532.70135545253, 1170.9121815863843, 1188.2217147768226, 1202.807550791869, 1206.252123683322, 1217.8964787992943, 6243.157173781572, 6281.560290779602, 6288.5598008139905, 6346.968265158737, 6367.267764207083, 10498.370097794157, 10717.196210284259, 10803.945980270048, 10808.621698240524, 10826.89173108259, 10569.365838049742, 10815.026647601753, 10819.513121909533, 10854.837177442345, 11096.722581935355, 8443.746687599381, 8515.276201522816, 8525.914740852511, 8564.357673174536, 8567.614457349435, 7888.645010974635, 7983.401244906771, 8008.879866801886, 8021.197880211932, 8067.87898181516, 7858.489198202098, 9764.755881103029, 9766.706998790047, 9850.128475589616, 9943.850842237516, 9983.750406239611, 10071.295009349275, 10168.186545076229, 10187.388756674327, 10250.948745256524, 7517.1731109579, 7532.359749421361, 7602.885956710765, 7629.427792915442, 7641.465097443125, 8199.467034642728, 8213.876791848008, 8231.971003624547, 8255.0, 8259.917400825914, 7074.903389974562, 7235.746748863765, 7614.16244213125, 7644.541327520366, 7944.483608565425, 7461.365783908429, 7482.70069197226, 7580.241975802375, 7616.581088040211, 7684.116326622287, 6267.937320626917, 7131.8573628528175, 7611.961940190264, 7657.617119143909, 7669.463137580316, 5920.644761314335, 6860.931390686029, 6889.207741109636, 6945.756898508528, 6979.581225126509, 7064.752733654297, 7158.856822863409, 7162.104736907887, 7162.64186790648, 7189.424846012411], "unit": "score", "name": "mootools.html", "value": 4977.843507402127}, {"lowerIsBetter": false, "replicates": [323.4307618591279, 330.283285270962, 332.199399447332, 334.3763880363122, 340.9532734505069, 4757.1437141314545, 5366.9463305366935, 6348.857205702978, 6421.454176395012, 6736.9663151684235, 6806.591604503733, 6833.248342682314, 6850.725970961155, 6877.0, 6889.896651550218, 4695.600873925703, 5049.293098966157, 5090.643654944155, 5096.745162741867, 5109.20807274873, 4956.2565615157655, 5044.19292913134, 5104.821331253407, 5105.132127538327, 5118.334616499868, 4160.814167962131, 4980.228064649985, 4994.150994330954, 5011.348524691785, 5040.243963405482, 4953.257011448276, 5007.674501157449, 5010.0731364697285, 5031.295618613415, 5053.393592768891, 4256.808443620044, 4275.91448171038, 4285.678574106923, 4296.033392486696, 4296.677749168824, 6274.372562743734, 6587.868242635121, 6601.768938087192, 6631.071649969008, 6668.899966500507, 5784.392638772911, 5785.508231800302, 5786.247787787603, 5792.65244085352, 5862.325832529271, 7202.819929501752, 7231.2768723127265, 7252.891206631904, 7276.490645654806, 7277.454190935701, 3775.6413140751583, 4615.976920115378, 4621.8151273949, 4629.328747331618, 4640.23436133041, 7222.422206223489, 7616.619169041581, 7617.200193979607, 7626.084869815602, 7654.617269136521, 4654.999175177353, 4661.906761864744, 4669.719816811003, 4672.205725026685, 4684.672072954861, 4760.7619619018915, 4761.166795810719, 4763.166445871959, 4781.880452988703, 4791.6406269529925, 5534.695591742493, 5714.828555143353, 5730.596003979052, 5734.885302293931, 5738.799142030009, 7233.89149162763, 7238.457115716237, 7265.5277406969435, 7358.22738612438, 7375.648367463223, 1294.7410517896458, 1569.5291412576182, 1605.6387312854515, 1648.645541208646, 1648.9587760306088, 1002.9749256268651, 1031.7626945802358, 1041.4532370505544, 1053.9156867450586, 1059.5073290919606, 6600.174978127734, 6661.3338666132995, 6676.86646267072, 6680.498962577826, 6692.765753198614, 5333.599980001515, 7342.853142937111, 7424.888626670604, 7443.292887175709, 7450.36671882896, 6461.8061458156335, 6646.368594983469, 6663.967085101817, 6670.166229221348, 6677.799666010027, 3937.0, 3964.6431821136234, 3969.4641223435046, 3975.801209939549, 3980.86066987654, 7715.0, 7715.151333353327, 7716.189800071024, 7721.227877212234, 7723.65243564041, 6060.122399509194, 6249.468795152463, 7601.429892758065, 7672.079350477979, 7915.564643944638, 6317.368263173646, 7724.034495688039, 7733.188015258429, 7758.961205194051, 7775.883361749578, 6255.0, 7262.745803896838, 7426.962865185639, 7435.293647103516, 7498.100227972678, 6168.889599872066, 7246.275372462712, 7558.470907036454, 7560.243975602396, 7574.621268936421, 7954.403419743659, 7966.681332746857, 7977.122516523062, 7990.960045199737, 7996.520208787491, 4703.20045592257, 4766.6901651392545, 4769.451513076041, 4769.499202583679, 4778.092162489255, 7246.927530724625, 7374.594397308199, 7390.593517356597, 7610.200928902385, 7650.273224043707, 7249.855002900018, 7269.818254543467, 7323.084614423197, 7331.670074846751, 7391.113066432063, 7306.634668266459, 7328.706851725871, 7331.523450975669, 7332.5967071811565, 7385.8153546161775, 6949.131358580177, 7153.570785752663, 7153.892691609526, 7172.605506697182, 7176.820579485346, 7359.521631093961, 7366.263373662805, 7367.631618419165, 7375.151857536452, 7383.224761399975, 6947.895781563179, 7186.173590037212, 7191.8561628768175, 7213.891791623235, 7220.422366210795], "unit": "score", "name": "prototype.html", "value": 5228.788428563433}, {"lowerIsBetter": false, "replicates": [720.607269038374, 727.3998950865537, 728.1553398058247, 733.9467863615711, 744.9664765085571, 14506.854931450682, 14768.409263629455, 14819.851801481982, 14884.181370024644, 14966.551003469885, 13114.803277950838, 13124.278164700938, 13131.934340328286, 13146.211227326366, 13182.93408532956, 704.0776582676697, 823.6375994562403, 852.9786755331104, 876.4609764994547, 878.0692465986075, 870.0472982084607, 870.7779516223354, 881.568031664483, 882.2765332427412, 883.011027649034, 813.8657121574932, 918.7106061590611, 922.6632279218071, 925.5048549026272, 925.5973651461602, 912.6167009855876, 913.7076135636532, 914.401067300919, 915.3501014279869, 920.148862302371, 661.6195687479718, 684.6953105867891, 685.7085738561142, 688.7899190746821, 689.3416786968434, 14394.280285985764, 14394.78407823873, 14427.783583246155, 14627.122372657675, 14802.481913132988, 12784.169029013177, 12861.228326300452, 12874.87125128746, 12909.741805163843, 13084.037910644827, 10119.443430611313, 10188.49057547127, 10369.066783989478, 10371.325863818904, 10441.530131144042, 3549.804760738158, 3584.6594573515476, 3584.946225806615, 3586.0, 3587.641235876418, 76349.0, 77800.61099694522, 78674.42651147002, 79285.60357198234, 88017.55991220067, 9448.244140468745, 9506.144446999802, 9618.230541556659, 9707.029297070236, 10156.542955567018, 20203.39389818308, 20254.89872550628, 20272.18911243534, 20275.986200689906, 20442.38672839817, 7407.6666550005375, 7434.851302973911, 7467.887981680279, 7580.0145981022115, 7702.8844567331535, 3197.280611862359, 4036.616521430459, 4079.326911059642, 4215.988162840896, 4222.0500387412585, 3579.552555930509, 3591.5510561179854, 3621.8189090545893, 3624.9093772655897, 3625.4743062256352, 530.3794560364306, 660.4947215380238, 666.3236814633151, 686.1217641418991, 693.4764252989062, 514.7349115205672, 565.9660420374709, 605.7365046204915, 630.6878095342835, 643.0707627478342, 8428.0, 8630.697925572575, 8722.30221582272, 8736.08271131522, 8805.025160784136, 604.4529700620946, 609.2354095610069, 615.6952308607179, 619.170311782214, 619.8171539395889, 3723.9069023274633, 3940.2513522430645, 3966.464527288837, 4242.17277630859, 4451.198784218872, 92740.53629731807, 93746.0, 94573.05426945642, 97487.53768693475, 97627.51186244024, 84465.0, 84672.53274672606, 85405.57297213475, 86340.0, 87685.98512119016, 69528.95706564406, 69592.0, 70870.64564677143, 70913.58172836514, 71773.64113179401, 7883.251091146332, 9037.457752534869, 9051.683191088281, 9162.037986011639, 9187.494687792236, 34759.13102172466, 40226.79886600548, 42662.36006459968, 43247.13505729931, 49836.25245621391, 58831.0, 65388.67305663632, 68172.3182768166, 69498.3050169512, 70088.24779380557, 10809.837852432378, 11028.5037173329, 11091.72270693239, 11362.715932101764, 11805.976527174738, 12110.515579376726, 12202.206856554296, 12507.4371653274, 12762.17045892014, 12786.936065319614, 11265.831012534982, 11797.76404471923, 11800.586979455678, 11827.645170644895, 12398.5660501882, 11654.067674586182, 11700.239484433825, 11722.472488738198, 11732.237404568676, 12333.260004399406, 11263.831042534532, 11664.008559272557, 11670.94164529172, 11672.124590655565, 11673.824892626448, 9173.633054677739, 9190.264778817813, 9325.80843501763, 9651.613935442503, 10257.794844102928, 8777.868331974898, 9280.303977201602, 9356.625734970525, 9391.530423478935, 9865.704028879145], "unit": "score", "name": "yui.html", "value": 6905.541802792958}], "name": "dromaeo_css", "value": 7502.773786693588}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 111.0, 110.0, 115.0, 114.0, 127.0, 114.0, 112.0, 118.0, 114.0], "unit": "score", "name": "ai-astar", "value": 114.8}, {"lowerIsBetter": true, "replicates": [195.0, 161.0, 149.0, 151.0, 108.0, 158.0, 152.0, 142.0, 154.0, 106.0], "unit": "score", "name": "audio-beat-detection", "value": 147.6}, {"lowerIsBetter": true, "replicates": [198.0, 262.0, 200.0, 259.0, 234.0, 199.0, 199.0, 195.0, 204.0, 197.0], "unit": "score", "name": "audio-dft", "value": 214.7}, {"lowerIsBetter": true, "replicates": [70.0, 72.0, 73.0, 124.0, 56.0, 57.0, 59.0, 58.0, 86.0, 56.0], "unit": "score", "name": "audio-fft", "value": 71.1}, {"lowerIsBetter": true, "replicates": [82.0, 84.0, 125.0, 80.0, 82.0, 82.0, 118.0, 82.0, 82.0, 115.0], "unit": "score", "name": "audio-oscillator", "value": 93.2}, {"lowerIsBetter": true, "replicates": [86.0, 92.0, 84.0, 91.0, 85.0, 90.0, 75.0, 139.0, 129.0, 94.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 96.5}, {"lowerIsBetter": true, "replicates": [95.0, 146.0, 100.0, 95.0, 99.0, 96.0, 92.0, 91.0, 151.0, 153.0], "unit": "score", "name": "imaging-darkroom", "value": 111.8}, {"lowerIsBetter": true, "replicates": [93.0, 107.0, 83.0, 83.0, 140.0, 133.0, 127.0, 134.0, 135.0, 127.0], "unit": "score", "name": "imaging-desaturate", "value": 116.2}, {"lowerIsBetter": true, "replicates": [54.0, 54.0, 56.0, 52.0, 62.0, 67.0, 78.0, 92.0, 86.0, 87.0], "unit": "score", "name": "json-parse-financial", "value": 68.8}, {"lowerIsBetter": true, "replicates": [54.0, 83.0, 102.0, 63.0, 98.0, 108.0, 59.0, 57.0, 62.0, 59.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 74.5}, {"lowerIsBetter": true, "replicates": [84.0, 86.0, 84.0, 89.0, 84.0, 86.0, 84.0, 85.0, 83.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.2}, {"lowerIsBetter": true, "replicates": [124.0, 124.0, 129.0, 134.0, 131.0, 144.0, 140.0, 149.0, 127.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 132.8}, {"lowerIsBetter": true, "replicates": [127.0, 138.0, 149.0, 176.0, 186.0, 140.0, 142.0, 142.0, 140.0, 127.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.7}, {"lowerIsBetter": true, "replicates": [73.0, 69.0, 69.0, 68.0, 59.0, 62.0, 88.0, 98.0, 70.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.2}], "name": "kraken", "value": 1546.1000000000001}]} 18:48:10 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1546.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7502.77"}}} 18:48:10 INFO - Return code: 0 18:48:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:48:10 INFO - # TBPL SUCCESS # 18:48:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:48:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:48:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:48:10 INFO - 2016-02-15 18:48:10.591 screenresolution[1989:15020] starting screenresolution argv=screenresolution get 18:48:10 INFO - 2016-02-15 18:48:10.593 screenresolution[1989:15020] Display 0: 1600x1200x32@60 18:48:10 INFO - 2016-02-15 18:48:10.599 screenresolution[1990:15023] starting screenresolution argv=screenresolution list 18:48:10 INFO - Available Modes on Display 0 18:48:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:48:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:48:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:48:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:48:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:48:10 INFO - Intel Iris: 18:48:10 INFO - Chipset Model: Intel Iris 18:48:10 INFO - Type: GPU 18:48:10 INFO - Bus: Built-In 18:48:10 INFO - VRAM (Dynamic, Max): 1536 MB 18:48:10 INFO - Vendor: Intel (0x8086) 18:48:10 INFO - Device ID: 0x0a2e 18:48:10 INFO - Revision ID: 0x0009 18:48:10 INFO - Displays: 18:48:10 INFO - Display: 18:48:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:48:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:48:10 INFO - Display Serial Number: 1600x1200 60 18:48:10 INFO - Main Display: Yes 18:48:10 INFO - Mirror: Off 18:48:10 INFO - Online: Yes 18:48:10 INFO - Rotation: Supported 18:48:10 INFO - Return code: 0 18:48:10 INFO - Running post-action listener: _resource_record_post_action 18:48:10 INFO - Running post-run listener: _resource_record_post_run 18:48:11 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 2543616; Write bytes: 712151552; Read time: 38; Write time: 1962 18:48:11 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 401283584; Write bytes: 396176896; Read time: 30185; Write time: 717 18:48:11 INFO - run-tests - Wall time: 1173s; CPU: 54.0%; Read bytes: 2543616; Write bytes: 304419840; Read time: 38; Write time: 1212 18:48:11 INFO - Running post-run listener: _upload_blobber_files 18:48:11 INFO - Blob upload gear active. 18:48:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:48:11 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:48:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:48:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:48:12 INFO - (blobuploader) - INFO - Open directory for files ... 18:48:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:48:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:48:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:48:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:48:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:48:12 INFO - (blobuploader) - INFO - Done attempting. 18:48:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:48:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:48:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:48:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:48:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:48:14 INFO - (blobuploader) - INFO - Done attempting. 18:48:14 INFO - (blobuploader) - INFO - Iteration through files over. 18:48:14 INFO - Return code: 0 18:48:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:48:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:48:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1d26a29383570fed31ecc15bdf57bfd137dec5ad1091304d80e5aa8c6a62d5bb939bbb993121889435747e96639c81b1718f09cd31b1c4ffda4ed164ef7ca5b4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8575f79569858daf6b4704413ce70c2281519b94389f903ba52b71438cfd73417b3738bcb7415ad490ddb22f874df7d15e73a734f0a53849fe5177339d0369b2"} 18:48:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:48:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:48:14 INFO - Contents: 18:48:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1d26a29383570fed31ecc15bdf57bfd137dec5ad1091304d80e5aa8c6a62d5bb939bbb993121889435747e96639c81b1718f09cd31b1c4ffda4ed164ef7ca5b4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8575f79569858daf6b4704413ce70c2281519b94389f903ba52b71438cfd73417b3738bcb7415ad490ddb22f874df7d15e73a734f0a53849fe5177339d0369b2"} 18:48:14 INFO - Running post-run listener: copy_logs_to_upload_dir 18:48:14 INFO - Copying logs to upload dir... 18:48:14 INFO - mkdir: /builds/slave/test/build/upload/logs 18:48:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.679594 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-02-15 18:48:14.099168) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-15 18:48:14.102713) ========= 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.bXurAHNlMO/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.pF1wYHt0qf/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1d26a29383570fed31ecc15bdf57bfd137dec5ad1091304d80e5aa8c6a62d5bb939bbb993121889435747e96639c81b1718f09cd31b1c4ffda4ed164ef7ca5b4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8575f79569858daf6b4704413ce70c2281519b94389f903ba52b71438cfd73417b3738bcb7415ad490ddb22f874df7d15e73a734f0a53849fe5177339d0369b2"} build_url:https://queue.taskcluster.net/v1/task/CbdsflAUQIGGeBU2kDt50w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011286 build_url: 'https://queue.taskcluster.net/v1/task/CbdsflAUQIGGeBU2kDt50w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1d26a29383570fed31ecc15bdf57bfd137dec5ad1091304d80e5aa8c6a62d5bb939bbb993121889435747e96639c81b1718f09cd31b1c4ffda4ed164ef7ca5b4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8575f79569858daf6b4704413ce70c2281519b94389f903ba52b71438cfd73417b3738bcb7415ad490ddb22f874df7d15e73a734f0a53849fe5177339d0369b2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-15 18:48:14.133314) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 18:48:14.134019) ========= 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.bXurAHNlMO/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.pF1wYHt0qf/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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.005274 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 18:48:14.187321) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-15 18:48:14.187994) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-15 18:48:14.188759) ========= ========= Total master_lag: 0.36 =========