builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0037 starttime: 1455891725.81 results: success (0) buildid: 20160219045300 builduid: 68fa2599c1634b65b78f2b57c095a90f revision: 164d5bc71555fe593f7726ff208dccb730073f34 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-19 06:22:05.811458) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-19 06:22:05.811953) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-19 06:22:05.812269) ========= 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.40Ie1x7dxP/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.mqQaTJBH2U/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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.005527 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-19 06:22:05.837405) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-19 06:22:05.837743) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-19 06:22:05.882906) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 06:22:05.883166) ========= 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.40Ie1x7dxP/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.mqQaTJBH2U/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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.005497 ========= master_lag: 0.51 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 06:22:06.395812) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-19 06:22:06.396098) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-19 06:22:06.396515) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 06:22:06.396788) ========= 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.40Ie1x7dxP/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.mqQaTJBH2U/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-02-19 06:22: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% 45.1M=0s 2016-02-19 06:22:06 (45.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.208215 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 06:22:06.638763) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 06:22:06.639055) ========= 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.40Ie1x7dxP/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.mqQaTJBH2U/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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.027368 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 06:22:06.689098) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-19 06:22:06.689451) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 164d5bc71555fe593f7726ff208dccb730073f34 --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 164d5bc71555fe593f7726ff208dccb730073f34 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.40Ie1x7dxP/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.mqQaTJBH2U/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-02-19 06:22:06,765 truncating revision to first 12 chars 2016-02-19 06:22:06,765 Setting DEBUG logging. 2016-02-19 06:22:06,765 attempt 1/10 2016-02-19 06:22:06,765 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/164d5bc71555?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-19 06:22:07,817 unpacking tar archive at: fx-team-164d5bc71555/testing/mozharness/ program finished with exit code 0 elapsedTime=1.284965 ========= master_lag: 0.28 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-19 06:22:08.258333) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-19 06:22:08.258708) ========= echo 164d5bc71555fe593f7726ff208dccb730073f34 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'164d5bc71555fe593f7726ff208dccb730073f34'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.40Ie1x7dxP/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.mqQaTJBH2U/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 164d5bc71555fe593f7726ff208dccb730073f34 program finished with exit code 0 elapsedTime=0.006068 script_repo_revision: '164d5bc71555fe593f7726ff208dccb730073f34' ========= master_lag: 0.06 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-19 06:22:08.320741) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-19 06:22:08.321017) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-19 06:22:08.357852) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-02-19 06:22:08.358172) ========= /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.40Ie1x7dxP/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.mqQaTJBH2U/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 06:22:08 INFO - MultiFileLogger online at 20160219 06:22:08 in /builds/slave/test 06:22: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 06:22:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:22:08 INFO - {'append_to_log': False, 06:22:08 INFO - 'base_work_dir': '/builds/slave/test', 06:22:08 INFO - 'blob_upload_branch': 'Fx-Team', 06:22:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:22:08 INFO - 'branch': 'Fx-Team', 06:22:08 INFO - 'buildbot_json_path': 'buildprops.json', 06:22:08 INFO - 'config_files': ('talos/mac_config.py',), 06:22:08 INFO - 'default_actions': ('clobber', 06:22:08 INFO - 'read-buildbot-config', 06:22:08 INFO - 'download-and-extract', 06:22:08 INFO - 'populate-webroot', 06:22:08 INFO - 'create-virtualenv', 06:22:08 INFO - 'install', 06:22:08 INFO - 'run-tests'), 06:22:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:22:08 INFO - 'download_minidump_stackwalk': True, 06:22:08 INFO - 'download_symbols': 'ondemand', 06:22:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:22:08 INFO - 'tooltool.py': '/tools/tooltool.py', 06:22:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:22:08 INFO - '/tools/misc-python/virtualenv.py')}, 06:22:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:22:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:22:08 INFO - 'installer_path': 'installer.exe', 06:22:08 INFO - 'log_level': 'info', 06:22:08 INFO - 'log_name': 'talos', 06:22:08 INFO - 'log_to_console': True, 06:22:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:22:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:22:08 INFO - 'opt_config_files': (), 06:22:08 INFO - 'pip_index': False, 06:22:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:22:08 INFO - 'cmd': ('bash', 06:22:08 INFO - '-c', 06:22:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:22:08 INFO - 'enabled': True, 06:22:08 INFO - 'halt_on_failure': False, 06:22:08 INFO - 'name': 'check_screen_resolution'},), 06:22:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:22:08 INFO - 'cmd': ('bash', 06:22:08 INFO - '-c', 06:22:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:22:08 INFO - 'enabled': True, 06:22:08 INFO - 'halt_on_failure': False, 06:22:08 INFO - 'name': 'check_screen_resolution'},), 06:22:08 INFO - 'run_cmd_checks_enabled': True, 06:22:08 INFO - 'sps_profile': False, 06:22:08 INFO - 'sps_profile_interval': 0, 06:22:08 INFO - 'suite': 'dromaeojs-e10s', 06:22:08 INFO - 'system_bits': '32', 06:22:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:22:08 INFO - 'title': 't-yosemite-r7-0037', 06:22:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:22:08 INFO - 'use_talos_json': True, 06:22:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:22:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:22:08 INFO - 'work_dir': 'build'} 06:22:08 INFO - ##### 06:22:08 INFO - ##### Running clobber step. 06:22:08 INFO - ##### 06:22:08 INFO - Running pre-action listener: _resource_record_pre_action 06:22:08 INFO - Running main action method: clobber 06:22:08 INFO - rmtree: /builds/slave/test/build 06:22:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:22:10 INFO - Running post-action listener: _resource_record_post_action 06:22:10 INFO - ##### 06:22:10 INFO - ##### Running read-buildbot-config step. 06:22:10 INFO - ##### 06:22:10 INFO - Running pre-action listener: _resource_record_pre_action 06:22:10 INFO - Running main action method: read_buildbot_config 06:22:10 INFO - Using buildbot properties: 06:22:10 INFO - { 06:22:10 INFO - "project": "", 06:22:10 INFO - "product": "firefox", 06:22:10 INFO - "script_repo_revision": "production", 06:22:10 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 06:22:10 INFO - "repository": "", 06:22:10 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 06:22:10 INFO - "buildid": "20160219045300", 06:22:10 INFO - "pgo_build": "False", 06:22:10 INFO - "basedir": "/builds/slave/test", 06:22:10 INFO - "buildnumber": 425, 06:22:10 INFO - "slavename": "t-yosemite-r7-0037", 06:22:10 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 06:22:10 INFO - "platform": "yosemite_r7", 06:22:10 INFO - "scheduler": "tests-fx-team-macosx64-talos", 06:22:10 INFO - "branch": "fx-team", 06:22:10 INFO - "repo_path": "integration/fx-team", 06:22:10 INFO - "revision": "164d5bc71555fe593f7726ff208dccb730073f34", 06:22:10 INFO - "stage_platform": "macosx64", 06:22:10 INFO - "builduid": "68fa2599c1634b65b78f2b57c095a90f", 06:22:10 INFO - "slavebuilddir": "test" 06:22:10 INFO - } 06:22:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/dIBcVioaQ4euf9QHhWUnpg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 06:22:10 INFO - Running post-action listener: _resource_record_post_action 06:22:10 INFO - ##### 06:22:10 INFO - ##### Running download-and-extract step. 06:22:10 INFO - ##### 06:22:10 INFO - Running pre-action listener: _resource_record_pre_action 06:22:10 INFO - Running main action method: download_and_extract 06:22:10 INFO - mkdir: /builds/slave/test/build/tests 06:22: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')]} 06:22:10 INFO - https://queue.taskcluster.net/v1/task/dIBcVioaQ4euf9QHhWUnpg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:22:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dIBcVioaQ4euf9QHhWUnpg/artifacts/public/build/test_packages.json 06:22:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dIBcVioaQ4euf9QHhWUnpg/artifacts/public/build/test_packages.json 06:22:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dIBcVioaQ4euf9QHhWUnpg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 06:22:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dIBcVioaQ4euf9QHhWUnpg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 06:22:14 INFO - Downloaded 1277 bytes. 06:22:14 INFO - Reading from file /builds/slave/test/build/test_packages.json 06:22:14 INFO - Using the following test package requirements: 06:22:14 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 06:22:14 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:22:14 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 06:22:14 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:22:14 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 06:22:14 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:22:14 INFO - u'jsshell-mac.zip'], 06:22:14 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:22:14 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 06:22:14 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 06:22:14 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:22:14 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 06:22:14 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:22:14 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 06:22:14 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:22:14 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 06:22:14 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 06:22:14 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:22:14 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 06:22:14 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:22:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:22:14 INFO - https://queue.taskcluster.net/v1/task/dIBcVioaQ4euf9QHhWUnpg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:22:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dIBcVioaQ4euf9QHhWUnpg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 06:22:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dIBcVioaQ4euf9QHhWUnpg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 06:22:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dIBcVioaQ4euf9QHhWUnpg/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 06:22:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dIBcVioaQ4euf9QHhWUnpg/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 06:22:16 INFO - Downloaded 17809114 bytes. 06:22:16 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'] 06:22:16 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 06:22:19 INFO - Return code: 0 06:22:19 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 06:22:19 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')]} 06:22:19 INFO - https://queue.taskcluster.net/v1/task/dIBcVioaQ4euf9QHhWUnpg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:22:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dIBcVioaQ4euf9QHhWUnpg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 06:22:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dIBcVioaQ4euf9QHhWUnpg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 06:22:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dIBcVioaQ4euf9QHhWUnpg/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 06:22:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dIBcVioaQ4euf9QHhWUnpg/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 06:22:20 INFO - Downloaded 17809114 bytes. 06:22:20 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'] 06:22:20 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 06:22:23 INFO - Return code: 0 06:22:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:22:23 INFO - https://queue.taskcluster.net/v1/task/dIBcVioaQ4euf9QHhWUnpg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:22:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dIBcVioaQ4euf9QHhWUnpg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 06:22:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dIBcVioaQ4euf9QHhWUnpg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 06:22:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dIBcVioaQ4euf9QHhWUnpg/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 06:22:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dIBcVioaQ4euf9QHhWUnpg/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 06:22:25 INFO - Downloaded 10707015 bytes. 06:22:25 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'] 06:22:25 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 06:22:25 INFO - Return code: 0 06:22:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:22:25 INFO - https://queue.taskcluster.net/v1/task/dIBcVioaQ4euf9QHhWUnpg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 06:22:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dIBcVioaQ4euf9QHhWUnpg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 06:22:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dIBcVioaQ4euf9QHhWUnpg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 06:22:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dIBcVioaQ4euf9QHhWUnpg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 06:22:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dIBcVioaQ4euf9QHhWUnpg/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 06:22:28 INFO - Downloaded 111222951 bytes. 06:22:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dIBcVioaQ4euf9QHhWUnpg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 06:22:28 INFO - mkdir: /builds/slave/test/properties 06:22:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:22:28 INFO - Writing to file /builds/slave/test/properties/build_url 06:22:28 INFO - Contents: 06:22:28 INFO - build_url:https://queue.taskcluster.net/v1/task/dIBcVioaQ4euf9QHhWUnpg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 06:22:29 INFO - Running post-action listener: _resource_record_post_action 06:22:29 INFO - Running post-action listener: set_extra_try_arguments 06:22:29 INFO - ##### 06:22:29 INFO - ##### Running populate-webroot step. 06:22:29 INFO - ##### 06:22:29 INFO - Running pre-action listener: _resource_record_pre_action 06:22:29 INFO - Running main action method: populate_webroot 06:22:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:22:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:22:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:22:29 INFO - '--tppagecycles', 06:22:29 INFO - '7'], 06:22:29 INFO - 'tests': ['tsvgm']}}, 06:22:29 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:22:29 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:22:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:22:29 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 06:22:29 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:22:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:22:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:22:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:22:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:22:29 INFO - 'talos_options': ['--e10s'], 06:22:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:22:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:22:29 INFO - 'tests': ['damp', 'tps']}, 06:22:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:22:29 INFO - 'talos_options': ['--e10s'], 06:22:29 INFO - 'tests': ['damp', 'tps']}, 06:22:29 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:22:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:22:29 INFO - 'other': {'tests': ['a11yr', 06:22:29 INFO - 'ts_paint', 06:22:29 INFO - 'tpaint', 06:22:29 INFO - 'sessionrestore', 06:22:29 INFO - 'sessionrestore_no_auto_restore']}, 06:22:29 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:22:29 INFO - 'tests': ['a11yr', 06:22:29 INFO - 'ts_paint', 06:22:29 INFO - 'tpaint', 06:22:29 INFO - 'sessionrestore', 06:22:29 INFO - 'sessionrestore_no_auto_restore']}, 06:22:29 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:22:29 INFO - 'tests': ['a11yr', 06:22:29 INFO - 'ts_paint', 06:22:29 INFO - 'tpaint', 06:22:29 INFO - 'sessionrestore', 06:22:29 INFO - 'sessionrestore_no_auto_restore']}, 06:22:29 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:22:29 INFO - 'tests': ['a11yr', 06:22:29 INFO - 'ts_paint', 06:22:29 INFO - 'tpaint', 06:22:29 INFO - 'sessionrestore', 06:22:29 INFO - 'sessionrestore_no_auto_restore']}, 06:22:29 INFO - 'other_l64': {'tests': ['a11yr', 06:22:29 INFO - 'ts_paint', 06:22:29 INFO - 'tpaint', 06:22:29 INFO - 'sessionrestore', 06:22:29 INFO - 'sessionrestore_no_auto_restore']}, 06:22:29 INFO - 'other_nol64': {'tests': ['a11yr', 06:22:29 INFO - 'ts_paint', 06:22:29 INFO - 'tpaint', 06:22:29 INFO - 'sessionrestore', 06:22:29 INFO - 'sessionrestore_no_auto_restore']}, 06:22:29 INFO - 'svgr': {'tests': ['tsvgx', 06:22:29 INFO - 'tsvgr_opacity', 06:22:29 INFO - 'tart', 06:22:29 INFO - 'tscrollx', 06:22:29 INFO - 'cart']}, 06:22:29 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:22:29 INFO - 'tests': ['tsvgx', 06:22:29 INFO - 'tsvgr_opacity', 06:22:29 INFO - 'tart', 06:22:29 INFO - 'tscrollx', 06:22:29 INFO - 'cart']}, 06:22:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:22:29 INFO - 'tests': ['tp5o']}, 06:22:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:22:29 INFO - 'talos_options': ['--e10s'], 06:22:29 INFO - 'tests': ['tp5o']}, 06:22:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:22:29 INFO - 'talos_options': ['--xperf_path', 06:22:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:22:29 INFO - 'tests': ['tp5n']}, 06:22:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:22:29 INFO - 'talos_options': ['--e10s', 06:22:29 INFO - '--xperf_path', 06:22:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:22:29 INFO - 'tests': ['tp5n']}}, 06:22:29 INFO - 'talos.zip': {'path': '', 06:22:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:22:29 INFO - Running post-action listener: _resource_record_post_action 06:22:29 INFO - ##### 06:22:29 INFO - ##### Running create-virtualenv step. 06:22:29 INFO - ##### 06:22:29 INFO - Running pre-action listener: _resource_record_pre_action 06:22:29 INFO - Running main action method: create_virtualenv 06:22:29 INFO - Creating virtualenv /builds/slave/test/build/venv 06:22:29 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 06:22:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:22:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:22:30 INFO - Using real prefix '/tools/python27' 06:22:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:22:30 INFO - Installing distribute.............................................................................................................................................................................................done. 06:22:33 INFO - Installing pip.................done. 06:22:33 INFO - Return code: 0 06:22:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:22:33 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')]} 06:22:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:22:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:33 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')]} 06:22:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:22:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:33 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 0x1062aba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062b24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f960ad5fd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10614fd30>, '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 0x105f73db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106146b20>, '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.40Ie1x7dxP/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.mqQaTJBH2U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 06:22:33 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 06:22:33 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 06:22:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.40Ie1x7dxP/Render', 06:22:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:22:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:22:33 INFO - 'HOME': '/Users/cltbld', 06:22:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:22:33 INFO - 'LOGNAME': 'cltbld', 06:22:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:33 INFO - 'MOZ_NO_REMOTE': '1', 06:22:33 INFO - 'NO_EM_RESTART': '1', 06:22:33 INFO - 'PAGER': '/bin/cat', 06:22:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:22:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:33 INFO - 'PWD': '/builds/slave/test', 06:22:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:22:33 INFO - 'SHELL': '/bin/bash', 06:22:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mqQaTJBH2U/Listeners', 06:22:33 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 06:22:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:22:33 INFO - 'USER': 'cltbld', 06:22:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:22:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:22:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:33 INFO - 'XPC_FLAGS': '0x0', 06:22:33 INFO - 'XPC_SERVICE_NAME': '0', 06:22:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:22:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:22: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 06:22:34 INFO - Cleaning up... 06:22:34 INFO - Return code: 0 06:22:34 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:22: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')]} 06:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:22:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22: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')]} 06:22:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:22:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22: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 0x1062aba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062b24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f960ad5fd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10614fd30>, '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 0x105f73db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106146b20>, '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.40Ie1x7dxP/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.mqQaTJBH2U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 06:22: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 06:22: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 06:22:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.40Ie1x7dxP/Render', 06:22:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:22:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:22:34 INFO - 'HOME': '/Users/cltbld', 06:22:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:22:34 INFO - 'LOGNAME': 'cltbld', 06:22:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:34 INFO - 'MOZ_NO_REMOTE': '1', 06:22:34 INFO - 'NO_EM_RESTART': '1', 06:22:34 INFO - 'PAGER': '/bin/cat', 06:22:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:22:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:34 INFO - 'PWD': '/builds/slave/test', 06:22:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:22:34 INFO - 'SHELL': '/bin/bash', 06:22:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mqQaTJBH2U/Listeners', 06:22:34 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 06:22:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:22:34 INFO - 'USER': 'cltbld', 06:22:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:22:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:22:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:34 INFO - 'XPC_FLAGS': '0x0', 06:22:34 INFO - 'XPC_SERVICE_NAME': '0', 06:22:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:22:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:22:34 INFO - Downloading/unpacking psutil>=0.7.1 06:22: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 06:22: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 06:22: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 06:22: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 06:22: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 06:22: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 06:22:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:22:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:22:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:22:36 INFO - Installing collected packages: psutil 06:22:36 INFO - Running setup.py install for psutil 06:22:37 INFO - building 'psutil._psutil_osx' extension 06:22:37 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 06:22:37 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 06:22:37 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 06:22:37 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 06:22:37 INFO - building 'psutil._psutil_posix' extension 06:22:37 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 06:22:37 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:22:37 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:22:37 INFO - ^ 06:22:37 INFO - 1 warning generated. 06:22:37 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 06:22:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:22:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:22:38 INFO - Successfully installed psutil 06:22:38 INFO - Cleaning up... 06:22:38 INFO - Return code: 0 06:22:38 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:22: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')]} 06:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:22:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22: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')]} 06:22:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:22:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22: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 0x1062aba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062b24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f960ad5fd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10614fd30>, '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 0x105f73db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106146b20>, '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.40Ie1x7dxP/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.mqQaTJBH2U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 06:22: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 06:22: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 06:22:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.40Ie1x7dxP/Render', 06:22:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:22:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:22:38 INFO - 'HOME': '/Users/cltbld', 06:22:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:22:38 INFO - 'LOGNAME': 'cltbld', 06:22:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:38 INFO - 'MOZ_NO_REMOTE': '1', 06:22:38 INFO - 'NO_EM_RESTART': '1', 06:22:38 INFO - 'PAGER': '/bin/cat', 06:22:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:22:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:38 INFO - 'PWD': '/builds/slave/test', 06:22:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:22:38 INFO - 'SHELL': '/bin/bash', 06:22:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mqQaTJBH2U/Listeners', 06:22:38 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 06:22:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:22:38 INFO - 'USER': 'cltbld', 06:22:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:22:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:22:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:38 INFO - 'XPC_FLAGS': '0x0', 06:22:38 INFO - 'XPC_SERVICE_NAME': '0', 06:22:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:22:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:22:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:22:38 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 06:22:38 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 06:22:38 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 06:22:38 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 06:22:38 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 06:22:38 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 06:22:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:22:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:22:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:22:40 INFO - Installing collected packages: mozsystemmonitor 06:22:40 INFO - Running setup.py install for mozsystemmonitor 06:22:40 INFO - Successfully installed mozsystemmonitor 06:22:40 INFO - Cleaning up... 06:22:41 INFO - Return code: 0 06:22:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:22: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')]} 06:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:22:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22: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')]} 06:22:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:22:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22: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 0x1062aba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062b24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f960ad5fd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10614fd30>, '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 0x105f73db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106146b20>, '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.40Ie1x7dxP/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.mqQaTJBH2U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 06:22: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 06:22: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 06:22:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.40Ie1x7dxP/Render', 06:22:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:22:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:22:41 INFO - 'HOME': '/Users/cltbld', 06:22:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:22:41 INFO - 'LOGNAME': 'cltbld', 06:22:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:41 INFO - 'MOZ_NO_REMOTE': '1', 06:22:41 INFO - 'NO_EM_RESTART': '1', 06:22:41 INFO - 'PAGER': '/bin/cat', 06:22:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:22:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:41 INFO - 'PWD': '/builds/slave/test', 06:22:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:22:41 INFO - 'SHELL': '/bin/bash', 06:22:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mqQaTJBH2U/Listeners', 06:22:41 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 06:22:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:22:41 INFO - 'USER': 'cltbld', 06:22:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:22:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:22:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:41 INFO - 'XPC_FLAGS': '0x0', 06:22:41 INFO - 'XPC_SERVICE_NAME': '0', 06:22:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:22:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:22:41 INFO - Downloading/unpacking blobuploader==1.2.4 06:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:22:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:22:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:22:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:22:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:22:43 INFO - Downloading blobuploader-1.2.4.tar.gz 06:22:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:22:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:22:43 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 06:22:43 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 06:22:43 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 06:22:43 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 06:22:43 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 06:22:43 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 06:22:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:22:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:22: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 06:22: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 06:22: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 06:22: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 06:22: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 06:22: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 06:22:44 INFO - Downloading docopt-0.6.1.tar.gz 06:22:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:22:44 INFO - Installing collected packages: blobuploader, requests, docopt 06:22:44 INFO - Running setup.py install for blobuploader 06:22:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:22:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:22:45 INFO - Running setup.py install for requests 06:22:45 INFO - Running setup.py install for docopt 06:22:45 INFO - Successfully installed blobuploader requests docopt 06:22:45 INFO - Cleaning up... 06:22:45 INFO - Return code: 0 06:22:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:22:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:22:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:22:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:45 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 0x1062aba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062b24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f960ad5fd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10614fd30>, '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 0x105f73db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106146b20>, '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.40Ie1x7dxP/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.mqQaTJBH2U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 06:22:45 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 06:22:45 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 06:22:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.40Ie1x7dxP/Render', 06:22:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:22:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:22:45 INFO - 'HOME': '/Users/cltbld', 06:22:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:22:45 INFO - 'LOGNAME': 'cltbld', 06:22:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:45 INFO - 'MOZ_NO_REMOTE': '1', 06:22:45 INFO - 'NO_EM_RESTART': '1', 06:22:45 INFO - 'PAGER': '/bin/cat', 06:22:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:22:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:45 INFO - 'PWD': '/builds/slave/test', 06:22:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:22:45 INFO - 'SHELL': '/bin/bash', 06:22:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mqQaTJBH2U/Listeners', 06:22:45 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 06:22:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:22:45 INFO - 'USER': 'cltbld', 06:22:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:22:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:22:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:45 INFO - 'XPC_FLAGS': '0x0', 06:22:45 INFO - 'XPC_SERVICE_NAME': '0', 06:22:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:22:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:22:46 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-RQypWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:22:46 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-_wtIJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:22:46 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-cJ_LMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:22:46 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-1hLTzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:22:46 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-alepSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:22:46 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-ldh55m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:22:46 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-22Jfy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:22:46 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-iR4BsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:22:46 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-cQMzBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:22:47 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-nehDOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:22:47 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-XeGypK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:22:47 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-QNNvNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:22:47 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-A99Opx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:22:47 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-soI3Eh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:22:47 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-ogtX3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:22:47 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-OHIgs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:22:47 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-haKtWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:22:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:22:47 INFO - Running setup.py install for manifestparser 06:22:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:22:47 INFO - Running setup.py install for mozcrash 06:22:48 INFO - Running setup.py install for mozdebug 06:22:48 INFO - Running setup.py install for mozdevice 06:22:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:22:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:22:48 INFO - Running setup.py install for mozfile 06:22:48 INFO - Running setup.py install for mozhttpd 06:22:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:22:48 INFO - Running setup.py install for mozinfo 06:22:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:22:48 INFO - Running setup.py install for mozInstall 06:22:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:22:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:22:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:22:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:22:48 INFO - Running setup.py install for mozleak 06:22:49 INFO - Running setup.py install for mozlog 06:22:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:22:49 INFO - Running setup.py install for moznetwork 06:22:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:22:49 INFO - Running setup.py install for mozprocess 06:22:49 INFO - Running setup.py install for mozprofile 06:22:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:22:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:22:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:22:49 INFO - Running setup.py install for mozrunner 06:22:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:22:49 INFO - Running setup.py install for mozscreenshot 06:22:50 INFO - Running setup.py install for moztest 06:22:50 INFO - Running setup.py install for mozversion 06:22:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:22:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:22:50 INFO - Cleaning up... 06:22:50 INFO - Return code: 0 06:22:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:22: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')]} 06:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:22:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22: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')]} 06:22:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:22:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22: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 0x1062aba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062b24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f960ad5fd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10614fd30>, '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 0x105f73db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106146b20>, '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.40Ie1x7dxP/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.mqQaTJBH2U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 06:22: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 06:22: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 06:22:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.40Ie1x7dxP/Render', 06:22:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:22:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:22:50 INFO - 'HOME': '/Users/cltbld', 06:22:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:22:50 INFO - 'LOGNAME': 'cltbld', 06:22:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:50 INFO - 'MOZ_NO_REMOTE': '1', 06:22:50 INFO - 'NO_EM_RESTART': '1', 06:22:50 INFO - 'PAGER': '/bin/cat', 06:22:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:22:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:50 INFO - 'PWD': '/builds/slave/test', 06:22:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:22:50 INFO - 'SHELL': '/bin/bash', 06:22:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mqQaTJBH2U/Listeners', 06:22:50 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 06:22:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:22:50 INFO - 'USER': 'cltbld', 06:22:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:22:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:22:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:50 INFO - 'XPC_FLAGS': '0x0', 06:22:50 INFO - 'XPC_SERVICE_NAME': '0', 06:22:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:22:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:22:50 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-hDkz6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:22:50 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)) 06:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:22:50 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-ufU8Rr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:22:50 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)) 06:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:22:50 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-hJuVvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:22:50 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)) 06:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:22:50 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-tdk2Tk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:22: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)) 06:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:22:51 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-Ych0cv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:22: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)) 06:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:22:51 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-hbj2w0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:22: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)) 06:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:22:51 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-CCp8JR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:22: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)) 06:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:22:51 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-a2KrMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:22:51 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)) 06:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:22:51 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-1NQsWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:22:51 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)) 06:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:22:51 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-XlBRex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:22:51 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)) 06:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:22:51 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-CMKqI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:22:51 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)) 06:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:22:51 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-T4b1Dm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:22:51 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)) 06:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:22:51 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-CudvBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:22: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)) 06:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:22:52 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-3E9_LO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:22: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)) 06:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:22:52 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-ivuGTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:22: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)) 06:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:22:52 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-fRtGWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:22: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)) 06:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:22:52 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-lm1E29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:22: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)) 06:22: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)) 06:22: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)) 06:22: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)) 06:22: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)) 06:22: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)) 06:22:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:22:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:22:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:22:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:22:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:22:54 INFO - Downloading blessings-1.6.tar.gz 06:22:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:22:54 INFO - Installing collected packages: blessings 06:22:54 INFO - Running setup.py install for blessings 06:22:55 INFO - Successfully installed blessings 06:22:55 INFO - Cleaning up... 06:22:55 INFO - Return code: 0 06:22:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:22:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:22:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:22:55 INFO - Reading from file tmpfile_stdout 06:22:55 INFO - Current package versions: 06:22:55 INFO - blessings == 1.6 06:22:55 INFO - blobuploader == 1.2.4 06:22:55 INFO - docopt == 0.6.1 06:22:55 INFO - manifestparser == 1.1 06:22:55 INFO - mozInstall == 1.12 06:22:55 INFO - mozcrash == 0.16 06:22:55 INFO - mozdebug == 0.1 06:22:55 INFO - mozdevice == 0.48 06:22:55 INFO - mozfile == 1.2 06:22:55 INFO - mozhttpd == 0.7 06:22:55 INFO - mozinfo == 0.9 06:22:55 INFO - mozleak == 0.1 06:22:55 INFO - mozlog == 3.1 06:22:55 INFO - moznetwork == 0.27 06:22:55 INFO - mozprocess == 0.22 06:22:55 INFO - mozprofile == 0.28 06:22:55 INFO - mozrunner == 6.11 06:22:55 INFO - mozscreenshot == 0.1 06:22:55 INFO - mozsystemmonitor == 0.0 06:22:55 INFO - moztest == 0.7 06:22:55 INFO - mozversion == 1.4 06:22:55 INFO - psutil == 3.1.1 06:22:55 INFO - requests == 1.2.3 06:22:55 INFO - wsgiref == 0.1.2 06:22:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:22: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')]} 06:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:22:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22: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')]} 06:22:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:22:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22: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 0x1062aba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062b24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f960ad5fd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10614fd30>, '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 0x105f73db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106146b20>, '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.40Ie1x7dxP/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.mqQaTJBH2U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 06:22: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 06:22: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 06:22:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.40Ie1x7dxP/Render', 06:22:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:22:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:22:55 INFO - 'HOME': '/Users/cltbld', 06:22:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:22:55 INFO - 'LOGNAME': 'cltbld', 06:22:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:55 INFO - 'MOZ_NO_REMOTE': '1', 06:22:55 INFO - 'NO_EM_RESTART': '1', 06:22:55 INFO - 'PAGER': '/bin/cat', 06:22:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:22:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:55 INFO - 'PWD': '/builds/slave/test', 06:22:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:22:55 INFO - 'SHELL': '/bin/bash', 06:22:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mqQaTJBH2U/Listeners', 06:22:55 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 06:22:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:22:55 INFO - 'USER': 'cltbld', 06:22:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:22:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:22:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:55 INFO - 'XPC_FLAGS': '0x0', 06:22:55 INFO - 'XPC_SERVICE_NAME': '0', 06:22:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:22:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:22:55 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)) 06:22:55 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)) 06:22:55 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)) 06:22:55 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)) 06:22:55 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)) 06:22:55 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)) 06:22:55 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)) 06:22:55 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)) 06:22:55 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)) 06:22:55 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)) 06:22:55 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)) 06:22:55 INFO - Cleaning up... 06:22:55 INFO - Return code: 0 06:22:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:22: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')]} 06:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:22:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22: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')]} 06:22:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:22:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:55 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 0x1062aba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062b24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f960ad5fd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10614fd30>, '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 0x105f73db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106146b20>, '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.40Ie1x7dxP/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.mqQaTJBH2U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 06:22:55 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 06:22:55 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 06:22:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.40Ie1x7dxP/Render', 06:22:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:22:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:22:55 INFO - 'HOME': '/Users/cltbld', 06:22:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:22:55 INFO - 'LOGNAME': 'cltbld', 06:22:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:55 INFO - 'MOZ_NO_REMOTE': '1', 06:22:55 INFO - 'NO_EM_RESTART': '1', 06:22:55 INFO - 'PAGER': '/bin/cat', 06:22:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:22:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:55 INFO - 'PWD': '/builds/slave/test', 06:22:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:22:55 INFO - 'SHELL': '/bin/bash', 06:22:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mqQaTJBH2U/Listeners', 06:22:55 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 06:22:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:22:55 INFO - 'USER': 'cltbld', 06:22:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:22:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:22:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:55 INFO - 'XPC_FLAGS': '0x0', 06:22:55 INFO - 'XPC_SERVICE_NAME': '0', 06:22:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:22:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:22:56 INFO - Downloading/unpacking jsonschema 06:22: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 06:22: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 06:22: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 06:22: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 06:22: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 06:22: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 06:22:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:22:58 INFO - Downloading/unpacking functools32 (from jsonschema) 06:22: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 06:22: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 06:22: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 06:22: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 06:22: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 06:22: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 06:22:58 INFO - Downloading functools32-3.2.3-2.tar.gz 06:22:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:22:58 INFO - warning: no files found matching '*.txt' 06:22:58 INFO - no previously-included directories found matching 'build' 06:22:58 INFO - no previously-included directories found matching 'dist' 06:22:58 INFO - no previously-included directories found matching '.git*' 06:22:58 INFO - Installing collected packages: jsonschema, functools32 06:22:58 INFO - Running setup.py install for functools32 06:22:59 INFO - warning: no files found matching '*.txt' 06:22:59 INFO - no previously-included directories found matching 'build' 06:22:59 INFO - no previously-included directories found matching 'dist' 06:22:59 INFO - no previously-included directories found matching '.git*' 06:22:59 INFO - Successfully installed jsonschema functools32 06:22:59 INFO - Cleaning up... 06:22:59 INFO - Return code: 0 06:22:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:22: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')]} 06:22:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:22:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22: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')]} 06:22:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:22:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22: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 0x1062aba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062b24c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f960ad5fd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10614fd30>, '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 0x105f73db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106146b20>, '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.40Ie1x7dxP/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.mqQaTJBH2U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 06:22: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 06:22: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 06:22:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.40Ie1x7dxP/Render', 06:22:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:22:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:22:59 INFO - 'HOME': '/Users/cltbld', 06:22:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:22:59 INFO - 'LOGNAME': 'cltbld', 06:22:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:59 INFO - 'MOZ_NO_REMOTE': '1', 06:22:59 INFO - 'NO_EM_RESTART': '1', 06:22:59 INFO - 'PAGER': '/bin/cat', 06:22:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:22:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:59 INFO - 'PWD': '/builds/slave/test', 06:22:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:22:59 INFO - 'SHELL': '/bin/bash', 06:22:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mqQaTJBH2U/Listeners', 06:22:59 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 06:22:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:22:59 INFO - 'USER': 'cltbld', 06:22:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:22:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:22:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:59 INFO - 'XPC_FLAGS': '0x0', 06:22:59 INFO - 'XPC_SERVICE_NAME': '0', 06:22:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:22:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:22:59 INFO - Downloading/unpacking flake8 06:22: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 06:22: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 06:22: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 06:22: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 06:22: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 06:22: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 06:23:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:23:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:23:01 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 06:23:01 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 06:23:01 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 06:23:01 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 06:23:01 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 06:23:01 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 06:23:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:23:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:23: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 06:23: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 06:23: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 06:23: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 06:23: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 06:23: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 06:23:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:23: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 06:23: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 06:23: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 06:23: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 06:23: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 06:23: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 06:23:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:23:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:23:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:23:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:23:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:23:02 INFO - no previously-included directories found matching 'docs/_build' 06:23:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:23:03 INFO - Running setup.py install for pep8 06:23:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:23:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:23:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:23:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:23:03 INFO - no previously-included directories found matching 'docs/_build' 06:23:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:23:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:23:03 INFO - Cleaning up... 06:23:03 INFO - Return code: 0 06:23:03 INFO - Running post-action listener: _resource_record_post_action 06:23:03 INFO - Running post-action listener: _start_resource_monitoring 06:23:03 INFO - Starting resource monitoring. 06:23:03 INFO - ##### 06:23:03 INFO - ##### Running install step. 06:23:03 INFO - ##### 06:23:03 INFO - Running pre-action listener: _resource_record_pre_action 06:23:03 INFO - Running main action method: install 06:23:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:23:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:23:03 INFO - Reading from file tmpfile_stdout 06:23:03 INFO - Detecting whether we're running mozinstall >=1.0... 06:23:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:23:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:23:03 INFO - Reading from file tmpfile_stdout 06:23:03 INFO - Output received: 06:23:03 INFO - Usage: mozinstall [options] installer 06:23:03 INFO - Options: 06:23:03 INFO - -h, --help show this help message and exit 06:23:03 INFO - -d DEST, --destination=DEST 06:23:03 INFO - Directory to install application into. [default: 06:23:03 INFO - "/builds/slave/test"] 06:23:03 INFO - --app=APP Application being installed. [default: firefox] 06:23:03 INFO - mkdir: /builds/slave/test/build/application 06:23:03 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'] 06:23:03 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 06:23:37 INFO - Reading from file tmpfile_stdout 06:23:37 INFO - Output received: 06:23:37 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:23:37 INFO - Running post-action listener: _resource_record_post_action 06:23:37 INFO - ##### 06:23:37 INFO - ##### Running run-tests step. 06:23:37 INFO - ##### 06:23:37 INFO - Running pre-action listener: _resource_record_pre_action 06:23:37 INFO - Running main action method: run_tests 06:23:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:23:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:23:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:23:37 INFO - 2016-02-19 06:23:37.221 screenresolution[1658:7801] starting screenresolution argv=screenresolution get 06:23:37 INFO - 2016-02-19 06:23:37.224 screenresolution[1658:7801] Display 0: 1600x1200x32@60 06:23:37 INFO - 2016-02-19 06:23:37.231 screenresolution[1659:7803] starting screenresolution argv=screenresolution list 06:23:37 INFO - Available Modes on Display 0 06:23:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:23:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:23:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:23:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:23:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:23:37 INFO - Intel Iris: 06:23:37 INFO - Chipset Model: Intel Iris 06:23:37 INFO - Type: GPU 06:23:37 INFO - Bus: Built-In 06:23:37 INFO - VRAM (Dynamic, Max): 1536 MB 06:23:37 INFO - Vendor: Intel (0x8086) 06:23:37 INFO - Device ID: 0x0a2e 06:23:37 INFO - Revision ID: 0x0009 06:23:37 INFO - Displays: 06:23:37 INFO - Display: 06:23:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:23:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:23:37 INFO - Display Serial Number: 1600x1200 60 06:23:37 INFO - Main Display: Yes 06:23:37 INFO - Mirror: Off 06:23:37 INFO - Online: Yes 06:23:37 INFO - Rotation: Supported 06:23:37 INFO - Return code: 0 06:23:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:23:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:23:37 INFO - Python 2.7.3 06:23:37 INFO - Return code: 0 06:23:37 INFO - grabbing minidump binary from tooltool 06:23:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:23:37 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 0x10614fd30>, '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 0x105f73db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106146b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:23:37 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 06:23:37 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 06:23:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:23:37 INFO - Return code: 0 06:23:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:23:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:23:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:23:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:23:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:23:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:23:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:23:38 INFO - Return code: 0 06:23:38 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/dIBcVioaQ4euf9QHhWUnpg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0037', '--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 06:23:38 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/dIBcVioaQ4euf9QHhWUnpg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0037 --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 06:23:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.40Ie1x7dxP/Render', 06:23:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:23:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:23:38 INFO - 'HOME': '/Users/cltbld', 06:23:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:23:38 INFO - 'LOGNAME': 'cltbld', 06:23:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:23:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:23:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:38 INFO - 'MOZ_NO_REMOTE': '1', 06:23:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:23:38 INFO - 'NO_EM_RESTART': '1', 06:23:38 INFO - 'PAGER': '/bin/cat', 06:23:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:23:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:38 INFO - 'PWD': '/builds/slave/test', 06:23:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:23:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:23:38 INFO - 'SHELL': '/bin/bash', 06:23:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mqQaTJBH2U/Listeners', 06:23:38 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 06:23:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:23:38 INFO - 'USER': 'cltbld', 06:23:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:23:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:23:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:38 INFO - 'XPC_FLAGS': '0x0', 06:23:38 INFO - 'XPC_SERVICE_NAME': '0', 06:23:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:23:38 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/dIBcVioaQ4euf9QHhWUnpg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0037', '--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 06:23:39 INFO - mozversion application_buildid: 20160219045300 06:23:39 INFO - mozversion application_changeset: 164d5bc71555fe593f7726ff208dccb730073f34 06:23:39 INFO - mozversion application_display_name: Nightly 06:23:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:23:39 INFO - mozversion application_name: Firefox 06:23:39 INFO - mozversion application_remotingname: firefox 06:23:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:23:39 INFO - mozversion application_vendor: Mozilla 06:23:39 INFO - mozversion application_version: 47.0a1 06:23:39 INFO - mozversion platform_buildid: 20160219045300 06:23:39 INFO - mozversion platform_changeset: 164d5bc71555fe593f7726ff208dccb730073f34 06:23:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:23:39 INFO - mozversion platform_version: 47.0a1 06:23:39 INFO - using testdate: 1455891819 06:23:39 INFO - actual date: 1455891819 06:23:39 INFO - starting webserver on 'localhost:49275' 06:23:39 INFO - SUITE-START | Running 2 tests 06:23:39 INFO - TEST-START | dromaeo_css 06:23:39 INFO - operating with platform_type : mac_ 06:23:39 INFO - Initialising browser for dromaeo_css test... 06:23:39 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmprzNJuF/profile http://localhost:49275/getInfo.html) 06:23:42 INFO - PROCESS | 1677 | __metrics Screen width/height:1600/1200 06:23:42 INFO - PROCESS | 1677 | colorDepth:24 06:23:42 INFO - PROCESS | 1677 | Browser inner width/height: 1024/689 06:23:42 INFO - PROCESS | 1677 | __metrics 06:23:42 ERROR - PROCESS | 1677 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 06:23:42 INFO - TEST-INFO | 1677: exit 0 06:23:42 INFO - Browser initialized. 06:23:42 INFO - Running cycle 1/1 for dromaeo_css test... 06:23:42 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmprzNJuF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:23:54 INFO - PROCESS | 1681 | RSS: Main: 255455232 06:23:54 INFO - PROCESS | 1681 | 06:24:44 INFO - PROCESS | 1681 | 1455891884556 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] 06:26:55 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 06:26:56 INFO - PROCESS | 1681 | RSS: Main: 271392768 06:26:56 INFO - PROCESS | 1681 | 06:29:58 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 06:29:59 INFO - PROCESS | 1681 | RSS: Main: 283045888 06:29:59 INFO - PROCESS | 1681 | 06:33:00 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 06:33:01 INFO - PROCESS | 1681 | RSS: Main: 285810688 06:33:01 INFO - PROCESS | 1681 | 06:36:03 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 06:36:03 INFO - PROCESS | 1681 | RSS: Main: 286887936 06:36:03 INFO - PROCESS | 1681 | 06:39:06 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 06:39:07 INFO - PROCESS | 1681 | RSS: Main: 289296384 06:39:07 INFO - PROCESS | 1681 | 06:42:09 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 06:42:09 INFO - PROCESS | 1681 | RSS: Main: 292081664 06:42:09 INFO - PROCESS | 1681 | 06:42:09 INFO - PROCESS | 1681 | __start_tp_report 06:42:09 INFO - PROCESS | 1681 | _x_x_mozilla_page_load 06:42:09 INFO - PROCESS | 1681 | _x_x_mozilla_page_load_details 06:42:09 INFO - PROCESS | 1681 | |i|pagename|runs| 06:42:09 INFO - PROCESS | 1681 | |0;dojo.html;3504.404251277283;3519.4544845548935;3543.3267679140977;3576.159602493414;3593.371160046992;4578.931316030262;5629.0149223885755;5673.546116310701;5794.855128621782;5804.2744656917885;5387.164989426636;5703.201551782743;5831.620944638596;5857.297124345085;5876.471117599415;5185.066687996159;5247.291615631898;5306.575473962093;5360.624756267063;5455.18172274158;5152.433232344458;5230.555402790767;5353.464653534655;5355.839324820262;5376.086065368897;4646.930296045562;4964.131277026506;5222.164453687411;5230.660007099526;5264.368275806889;5253.789848406059;5268.4994925482015;5273.815416460444;5279.208118782175;5296.232046353296;5196.2465442511;5206.713630750307;5244.344456942882;5246.265522826808;5253.579713622901;5491.670499769986;5583.078791999315;5672.319321681424;5695.5443564514735;5705;5889.146073819272;6104.147103685057;6125.021800333839;6204.317525072239;6284.99440089588;6172.135900973867;6263.217097862767;6289.182406287199;6290.528210384239;6331.050342448623;5887.116932460122;5911.822645320647;5913.408659134138;5928.051511758098;5981.700914954235;6197.318294987548;6285.931391663428;6307.810765677037;6320.431161195423;6331.018692102732;6181.536384771161;6216.720247588869;6219.844503887439;6223.190985171898;6230.345813689588;6160.9383906161265;6221.96889015552;6288.654124023131;6319.557630965788;6345.302016778151;6202.255729312421;6264.561480696399;6272.3100458949475;6275.058741188858;6283.151774510383;6238.625682459067;6284.308726040132;6289.77985770505;6311.652859092794;6325.841853953688;4832.95167048325;4855.951440485621;4916.164252077156;4929.162042452792;4967.627427942846;4375.343698445258;4392.121575684876;4435.578620031092;4437.64498840092;4472.2620767573635;5640.266765320564;5753.482186603226;5810.564207684441;5843.590948633555;5874.089516125007;6228.781992630326;6275.592086514362;6284.183056202756;6289.654069026156;6300.3699630037545;4754.809807607726;4883.804647814048;5775.27809023872;5822.563307751935;5839;4328.567143285646;5340.626156169109;5380.435054319319;5403.189521571717;5467.015937131355;6222.284437289679;6302.905456418249;6360.809175724736;6393.2328120625825;6407.903881441782;6227.875442491216;6264.968675156595;6267.2792628848265;6281.152044473937;6289.150964619717;6284.748610055546;6393.041043843461;6421.197350331208;6424.357564243538;6443.387878151568;6159.753609855556;6196.349383314687;6199.256089269316;6213.720382582705;6225.31521532622;6229.065640154013;6229.781957631461;6241.282252541016;6254.186955695731;6262;5074.746262686777;6148.631082135086;6161.075838624242;6168.321484636596;6190.792795404853;5798.536117110705;6143.447089761943;6150.876982460415;6167.167432396569;6180.938190618216;5848.4151584841175;5920.437558431942;5956.791512297049;5990.7004649768205;6035.215421995288;6117.059633871721;6162.753489860355;6183.505319574333;6203.410675985774;6204.3795620437595;6049.606775559574;6059.969805133226;6064.151018857276;6068.241469816273;6082.878342433215 06:42:09 INFO - PROCESS | 1681 | |1;ext.html;447.45634054623645;456.1265177185689;483.36678950574736;600.1298117729293;619.3001907844135;38637.99999999996;38800.22399552011;38838.805805971;38869.02827429316;38888.833334999996;40008;40499.19001619966;40618;40679.983000425;40965.97585060375;9384.343095983284;9594.808103837953;9610;9618.615255389775;9628.614855405775;9510.286728495355;9718.31971761977;9730.951345243298;9776.853347199798;9777.022297770201;9703.369280996749;9810.215182785396;9813.214942804594;9824.263180261472;9833.557489912935;9656.758581035496;9743.853842192337;9749;9771.951140244324;9802.313838031341;9541.856872146924;9702.563384647709;9715.22278217748;9727.756806079904;9737.464439455827;38509.22981540354;38860.83417497479;39005.63480278205;39125.80437097825;39183;2639.5116903372746;3226.532152837849;3384.7969121852766;3394.7114495267683;3549.7337699672626;29181.854090729623;29278.707212928024;29324.706752932623;29538.113856584336;29819.403611927857;2786.6656001279775;2835.5463125899755;2872.6552813662493;2881.7118288171223;2995.65549961755;441025;445406;446061.53938460525;449403;449638;45161.54838451639;45796;46065.53934460613;65999;66437;44744.77627611841;45118.09763804705;45347.09305813865;45443.31835022477;45652.315215271796;15335.846641533442;15419.229038548028;15483.071015739091;15519.37922483088;15522.379104835905;12162.08784341178;12257.816132758016;12371.75256494865;12470.688232794253;12505.124641275206;14790;14808.259587020606;14833.629159271104;14889.329980150702;14947.551573452596;6287.245530536365;6398.136251606066;6428.935710642927;6435.774747883802;6466.6766661666725;915.2632131134368;952.6475204174361;999.8950110238466;1031.0874875735028;1075.4945175767377;24935.87532062328;27144.864275678494;29213.7078629211;29958.850205749266;30709.69290307113;968.5302628225305;1062.792755412687;1079.8164312066967;1079.8434227037035;1088.7931293054294;13192.010599205098;14780.637365051816;14817.40730370773;15060.698786024437;16539.50381488557;618040;748268;755230;756203;762478;58297.70851145802;58735;59082.11376829351;59107.70446147742;59262;1251.7294945630192;1364.9317534123254;1439.5105664074265;1459.6423876150411;1588.8252292247844;25277.609731464945;29722.554161688025;29992.100236992927;30111.58321089603;30926.22684432907;51803.48196517987;52025.699357516365;52470.73764631152;52660;52796.73601632121;502938;503071;506737;508558;512270;32801.01596952095;33290.500642490864;33358.66641333556;33440.66237350479;33723.83138084392;44351;44955;45488.77255613701;45902.77048614869;46600.533994660975;36846.078848029014;37570.8121459391;38371.23257534778;38382.23235535218;38459.23081538297;31075;31806.52290215695;34265.486017709256;36213.63786362103;36849.263014739015;31196.844015780684;37096;37432.438513421774;37562;37572.436413454365;32193.195170120933;33408.49887251742;33542.16144596405;33632.15919602029;33643.327133457686;19993.900030499753;26024;26228.08201712931;26475.94096236129;27214.047508337113 06:42:09 INFO - PROCESS | 1681 | |2;jquery.html;359.23662217787205;363.28976850257743;364.4478614898429;368.123865200822;368.1789609171547;14344.713105737905;15504.379824806994;18983.81016189838;19851;20665.793342066576;11814.822777658343;12107.091968102384;18464.81535184648;19293.903530482326;19811;3929.017745563609;5130.769115389798;5427.755750991215;5439.075357189287;5441.1838224266285;5728.226689396941;5858.970705146468;6034.0948857671265;6038.735474197176;6057.061155520902;5792.218050563183;5962.850928726773;5969.283685957691;6034.275886893557;6035.094735789623;5703.08750599902;5892.616979896293;5933.139694744281;5945.37573554777;5980.162777211194;5693;5735.397783232742;5747.339056008571;5767.106098554731;5789.507891829157;19635.607287854305;25294.620580691306;25436.872815635805;25507.362315942064;25618.615720764203;1927.874688145266;2114.080375036864;2351.8471299365488;2384.977930724916;2761.1716485054603;8986.741856140146;9563.90436095637;9816.852747208797;9876.45679487635;9890.258230632659;1639.2377544441892;1793.3812834572052;1807.1054827860162;1841.1806745998035;1865.6175484025741;84355.5782221091;99917.5004124982;109849;112208;112776;9212.493312867857;10840;11345.773084538429;11361.091112710963;11367.829482557769;12558.120931534888;12814;13272.070955033056;13656.726865462833;13810.792838107436;6404.423601875854;6549.345065493508;8029.277365037175;8620.13798620133;8620.87928569282;6225.937740622627;6624.039514270404;8612.09572994839;8716.912830871737;8829.867551986725;3671.742977991515;4217.915641687149;4442.067165895133;4467.441569803775;4483.417155769795;1573.5987323232503;1623.4317988703858;1927.1327902443957;1963.1754663041556;1981.2570286142698;865.913278835058;902.309733054214;1009.0313299232819;1009.405599774142;1042.7080417483116;19425.611487770166;19694.70457943132;19754;20314;20365.796342036687;776.7359097906739;920.1856357123994;968.9951550242204;979.5298256836616;1071.0735214039955;10597.046265836112;10897.509612067475;10910.945445272722;10938.398388088732;10946.4526773661;651424;654608;665886;666827;672910;93668.53165734127;103797;108641;120666.79333206732;125314;1031.2265800649513;1041.0786453988276;1041.4948749856314;1071.7159952612565;1072.2815713471994;18436.539086522946;18747.812521875152;18751.34370297033;18898.14958326851;18928.958907260232;36131.63868361283;42659.14681706411;47045;49985.50014499954;51759.74120129375;70245.64877175582;73217.6339118301;73420.63289683517;73975.8903616457;74481.62759186169;7600.581967991592;7855.253750893656;7887.526748395115;7954.204579542231;7958.204179581995;10336.586536538454;12423.379218803784;12428.440720167795;12740.74518509606;12743.49026038948;6317.873642527032;7866.252705992922;10318.793624127626;10960.506777195205;11245.718857028312;10482.842757358798;10633.680989570325;10787.784244315228;10849.620263290746;11026.173037022416;5414.079606466831;7598.96200519016;9320.555313926352;10979.890201097887;11246.381449020382;6399.2640846303275;7675.385969122569;7948.801279968047;7978.3218426434405;7979.361651068017;8985.865212021694;11022.889771102185;11115.444227788417;11360.829587556358;11369.602063928054 06:42:09 INFO - PROCESS | 1681 | |3;mootools.html;1550.6511035017122;1567.592425969248;1583.6674298397336;1918.645050665626;1928.7106933959913;7809.960950195241;7858.921410785891;7988.640511177004;8790.428622139565;8887.511186884718;8525;8603.139686031394;8681.782955426117;8707.91292087079;8713.215810577047;2112.725345705056;2410.5058463015084;2421.140495124232;2433.9756602434013;2445.8504502883616;2480.355107672;2481.8759062046915;2520.3447103752974;2523.3691577105724;2534.6704928359286;2155.7628660847295;2410.987945060272;2465.642481840132;2481.5161043596504;2498.4378514834107;2440.9633855492184;2452.203034013935;2479.764422379871;2484.2795589279085;2488.091846476041;2106.8314534837177;2399.4121440247077;2457.213691618683;2459.9914035245465;2468.629705544183;8561.700340488052;8616.741497755078;8625.094365091638;8665.480071195749;8731.825363492695;4861.562459378673;4953.628477864175;5415.918761218585;5479.75341109651;5486.286782718221;2941.9852900735573;3591.7306202034692;3604.873829415958;3737.9252414951548;3785.62143785622;904.6291020681489;1080.827067669177;1082.3289560472558;1103.4593049405814;1105.9944700276528;11659.708507287301;11723.179377443583;11781.352025638587;11814.46834892432;11860.110491713156;4876.463589005207;4876.707397556158;4900.852974410774;4937.1606826839525;4955.529224723646;10100.696979090639;10155.136813370946;10182.949085254526;10186.03232692893;10199.28604997658;5444.50999410055;5469.808556700496;5474.452554744574;5482.5613950883835;5491;4024.4164596133396;4945.604351651859;4959.454460009396;4969.105560999054;5025.422076461181;3784.7729136251914;3842.2315536892734;3845.9038524037123;3881.6312450317173;3889.6110388961442;1268.898488120948;1280.2446556531504;1282.8460584729892;1301.076235872541;1304.341307639636;1017.9389236645825;1117.1118960426481;1134.6482590397004;1251.380566619511;1355.593322003395;7699.26856948589;7846.058472983279;7874;7927.128015918244;7941.205879412013;641.9550631455753;646.802725168828;652.7062821730145;654.8199245207607;793.8092860708937;6019.578629495893;6034.1853849730605;6150.446459818638;6185.8144255672405;6203.131561581382;10233.59065637381;10257.128144107834;10628.946855265674;10740.73148171302;10802.837957430645;10578.994995475417;10655.946720266504;10694.572217111228;10725.30285531438;10739.979701928305;8085.838283234302;8262.876056859152;8264.421490495608;8272.214139656722;8351.916480835236;7701.537907725555;7743.845123097394;7748.496347737379;7790.9220907790195;7801.102873169431;9332.16010559053;9382.953085234803;9415.85876211871;9506.572204250688;9597.28020398459;9542.284328675238;9799.85300220483;9900.306978511435;9958.103770660675;9983.301168918397;7267.672954717156;7415.073115860518;7421.220771818881;7428.9628551856895;7443.069616297963;8026.916366290476;8088.110307866248;8202.09776924526;8210.63052162642;8313.958430207811;6691.799246022627;7238.963805180941;7365.8158546036775;7428.071491063617;7571.886421703789;7106.253843346581;7252.129744430702;7344.045274114331;7347.889781653173;7368.447366447645;7643.197464266172;7655.349295309961;7667.731629392944;7675.654595543102;7677.078750549969;6845.691943862438;6921.6193109379465;6935;6953.721851125898;6964.860702786017;6031.336552979256;6984.301569842975;7001.859962800817;7115.039469671528;7198.280171982759 06:42:09 INFO - PROCESS | 1681 | |4;prototype.html;324.5164704590161;332.8601987165392;334.0446323514746;336.2870714086137;340.70699198689107;6807.557508761927;6976.441884649223;6984.790456286313;6992.182032671504;7013.719451221945;5524.723763811803;6914.44684425246;6978.232394436608;6995.370416662499;7027.47293952953;5151.896962060757;5154.819581314655;5160.200168973796;5164.561012313958;5179.611529135311;4333.811425230254;4859.2225243960975;5018.121828679985;5171.991461664977;5194.584433245332;4935.259711043336;4948.529889660476;4949.406071271453;4956.7025978441225;4970.353853998975;4946.010797840447;4948.851534453972;4950.702957822542;4958.256261560777;4981.103401387785;3009.277773334406;3760.7401520490394;4041.8989525262105;4219.156168766228;4223.21870453967;5927.703614819242;6127.479164270998;6493;6632.1046658701425;6707.3628005339415;5329.493698098674;5832.125181222808;5863.618864773819;5887.587868849182;5892.941070589282;7338.926610733931;7341.082364704412;7346.045014148127;7352.77941661751;7373.705051797921;4254.765987870666;4307.117041006586;4665.113628410591;4673.789679464432;4680.4149481314835;7462.813429664247;7803.258690424401;7813.570253636105;7835.138134805167;7845.293923546908;4724.929126063112;4764.690295130806;4776.188048031843;4793.23308270675;4800.255960326155;4848.17581011229;4849.199882019498;4862.5380588844;4872.3909511311085;4872.829450969199;5596.944030559724;5789.88420231593;5850.063989761617;5861.70691465425;5919.644821310735;6137.570370074052;7397.8150546236775;7428.739994100289;7437.405007599379;7444.106707195063;1300.3953161779818;1747;1752.5618595351161;1763.6825371433265;1771.6013896873358;1141.1612464838338;1141.5319718915205;1153.1581945180067;1153.6481373181093;1166.7083229192701;6819.522633415613;6848.178218613798;6855.040294358794;6855.400914519917;6881.967704844214;7693.07683078023;7704.961475192588;7720.922790772132;7730.420218483636;7743.651535680795;5477.4248703886315;5552.472515111058;6841;6851.931480685229;6981.965090174516;3442.7934323940644;4093.140440507527;4242.745435273893;4247.617714405718;4254.489461264668;6964.93035069653;7726.652300646484;7887.2112788721815;8085.838283234302;8192.303654189342;7838.372930165687;8011;8048.678052877819;8067.112617612058;8153.510789352657;7582.165961744204;8113.675452981933;8114.229148230908;8117.837643246984;8139.511629302261;7644.617769111411;7814.6483408247905;7830.530168189927;7846.725364612211;7847.8038049046945;7644.503107298008;7645.01229680276;7653.387728981556;7659.348955338859;7666.310032097138;8124.309433698202;8125;8135.583055116746;8159.918400815915;8185.672573097248;4608.239640459286;4741.57325840676;4746.928796067993;4766.118268120409;4791.089692958327;7456.66445009965;7600.581967991813;7609.923900761143;7665.386769058574;7835.686572537034;6062.393760623902;7483.850322993619;7500.699972001059;7500.812479688051;7503.962480187564;6906.827329316808;7209.35115839577;7446;7473.327400533978;7508;6260.4019331976715;6930.237673855972;7265.818354540967;7274.236205198589;7302.306280903305;7441.10706715176;7447.329740323397;7466.514676546007;7478.588677622565;7484.850302994018;7056.329648683367;7277.2722727726805;7298.744543940937;7325.523840950321;7340.192578816219 06:42:09 INFO - PROCESS | 1681 | |5;yui.html;685.8662560800643;720.9351158395743;746.1456632156181;755.4900442201513;755.9039392880318;14030.579082627524;14155.929220353884;14231.71536569268;14281.428742850274;14319.427222911085;12586.496540138407;12674.302913339763;12806.103572749911;12822.102452828305;12854.871451285484;702.8242939265184;856.6873091321685;863.7236084452977;883.4434306386967;884.4604791077437;736.6519269736369;853.5604163855619;871.8648609465542;877.934154938379;886.1492966751894;919.6229545886188;919.7194855569048;934.7849994501269;934.8177105464437;941.3645789092369;920.7882187096939;931.8835145606799;934.8083642853233;938.5823308627663;941.7033634405175;675.189772273274;694.7325279767275;694.7498900395854;696.2098018748705;698.1900994846005;13575.592732218049;13756.931215343859;13799.86200138006;13802.447902083904;13855.515056972958;11198.936101070467;12090.33503157326;12178;12320.876791232062;12594.937025314906;7891.921080789176;9262.351635385527;9447.858282125773;9486.430814151174;9762.633231347618;2834.503961806696;3183.9363212735616;3267.493538501536;3300.5874265716784;3368.949465757991;59930.700346497986;76293;76808.23191768066;76968.23031769667;79292.20707792907;7768.2620151086685;8780.253678437277;8863.423877447945;8977.955110224408;9119.088091190828;18475.722864157047;18483.075846207637;18483.98338091418;18528;18528.258869645062;6630.138082049302;6675.732970681215;6862.725490980405;6884.862302754017;6903.827404314832;3786.5645450772963;3852.210296889131;3854.5374555053572;3861.4787003754695;3866.5360156781367;3302.884399046022;3353.027621989596;3355.8489867956;3356.2616224430585;3361.596608407007;624.7001439309157;647.8121344810047;654.6039646014189;682.8634273145391;687.4740823270203;495.90825697246123;496.85591178557814;565.7708628005664;585.6661702829432;627.8807026664919;7914.920850791418;7984.441089123706;7989.934564764009;8068;8182.386321025828;491.98278060267717;549.8762778374834;574.6523353371234;635.7774778827466;636.096742625473;3673.5959044505084;3723.4600982857874;3767.2088861339425;3854.0750219947013;3895.8052097395016;95512;95979;98394;98761.50619246857;98821;82489.58755206186;82798.58600706958;84016.15983840084;84069;84445.57777211198;71929.56140877258;72344.55310893753;73414.63292683609;73832.63083684548;74060.62969685117;7585.279398457138;7650.273224043707;7685.5004424712215;7708.2677145673315;7759.883601746092;49835.75082124566;51086.489135108175;51734;51739.48260517346;52041;67037.66481167563;70857;71923.28076719165;72105;72760.63619681868;9147.908520914705;9148.130927561871;9188.816223675356;9228.169464748205;9411;9852.314697446349;9902.306838521523;9943.552540135855;9958.850617240892;9963.800723985334;9521.904780952102;9522.761930951781;9525.190358819578;9542.379745316532;9554.952225238829;8566.871496927426;8888.866666999871;9451.763705907408;9534.380265282734;9534.570944307661;9081.910170779285;9449.102335278138;9608.807823843625;10465.162786977176;10526.368417894952;9127.954360228156;9237.861432078658;9397;9427.24582033422;9484.762880927756;6999.930000699927;9103.998560158245;9379.643755820325;9470.74373722563;9971.451570163421 06:42:09 INFO - PROCESS | 1681 | __end_tp_report 06:42:09 INFO - PROCESS | 1681 | __start_cc_report 06:42:09 INFO - PROCESS | 1681 | _x_x_mozilla_cycle_collect,338 06:42:09 INFO - PROCESS | 1681 | __end_cc_report 06:42:09 INFO - PROCESS | 1681 | __startTimestamp1455892929538__endTimestamp 06:42:09 INFO - PROCESS | 1681 | 06:42:09 INFO - PROCESS | 1681 | ------- Summary: start ------- 06:42:09 INFO - PROCESS | 1681 | Number of tests: 6 06:42:09 INFO - PROCESS | 1681 | 06:42:09 INFO - PROCESS | 1681 | [#0] dojo.html Cycles:165 Average:5753.35 Median:6035.22 stddev:658.35 (10.9%) stddev-sans-first:636.29 06:42:09 INFO - PROCESS | 1681 | Values: 3504.4 3519.5 3543.3 3576.2 3593.4 4578.9 5629.0 5673.5 5794.9 5804.3 5387.2 5703.2 5831.6 5857.3 5876.5 5185.1 5247.3 5306.6 5360.6 5455.2 5152.4 5230.6 5353.5 5355.8 5376.1 4646.9 4964.1 5222.2 5230.7 5264.4 5253.8 5268.5 5273.8 5279.2 5296.2 5196.2 5206.7 5244.3 5246.3 5253.6 5491.7 5583.1 5672.3 5695.5 5705.0 5889.1 6104.1 6125.0 6204.3 6285.0 6172.1 6263.2 6289.2 6290.5 6331.1 5887.1 5911.8 5913.4 5928.1 5981.7 6197.3 6285.9 6307.8 6320.4 6331.0 6181.5 6216.7 6219.8 6223.2 6230.3 6160.9 6222.0 6288.7 6319.6 6345.3 6202.3 6264.6 6272.3 6275.1 6283.2 6238.6 6284.3 6289.8 6311.7 6325.8 4833.0 4856.0 4916.2 4929.2 4967.6 4375.3 4392.1 4435.6 4437.6 4472.3 5640.3 5753.5 5810.6 5843.6 5874.1 6228.8 6275.6 6284.2 6289.7 6300.4 4754.8 4883.8 5775.3 5822.6 5839.0 4328.6 5340.6 5380.4 5403.2 5467.0 6222.3 6302.9 6360.8 6393.2 6407.9 6227.9 6265.0 6267.3 6281.2 6289.2 6284.7 6393.0 6421.2 6424.4 6443.4 6159.8 6196.3 6199.3 6213.7 6225.3 6229.1 6229.8 6241.3 6254.2 6262.0 5074.7 6148.6 6161.1 6168.3 6190.8 5798.5 6143.4 6150.9 6167.2 6180.9 5848.4 5920.4 5956.8 5990.7 6035.2 6117.1 6162.8 6183.5 6203.4 6204.4 6049.6 6060.0 6064.2 6068.2 6082.9 06:42:09 INFO - PROCESS | 1681 | 06:42:09 INFO - PROCESS | 1681 | [#1] ext.html Cycles:180 Average:68464.81 Median:38864.93 stddev:153996.69 (396.2%) stddev-sans-first:154344.02 06:42:09 INFO - PROCESS | 1681 | Values: 447.5 456.1 483.4 600.1 619.3 38638.0 38800.2 38838.8 38869.0 38888.8 40008.0 40499.2 40618.0 40680.0 40966.0 9384.3 9594.8 9610.0 9618.6 9628.6 9510.3 9718.3 9731.0 9776.9 9777.0 9703.4 9810.2 9813.2 9824.3 9833.6 9656.8 9743.9 9749.0 9772.0 9802.3 9541.9 9702.6 9715.2 9727.8 9737.5 38509.2 38860.8 39005.6 39125.8 39183.0 2639.5 3226.5 3384.8 3394.7 3549.7 29181.9 29278.7 29324.7 29538.1 29819.4 2786.7 2835.5 2872.7 2881.7 2995.7 441025.0 445406.0 446061.5 449403.0 449638.0 45161.5 45796.0 46065.5 65999.0 66437.0 44744.8 45118.1 45347.1 45443.3 45652.3 15335.8 15419.2 15483.1 15519.4 15522.4 12162.1 12257.8 12371.8 12470.7 12505.1 14790.0 14808.3 14833.6 14889.3 14947.6 6287.2 6398.1 6428.9 6435.8 6466.7 915.3 952.6 999.9 1031.1 1075.5 24935.9 27144.9 29213.7 29958.9 30709.7 968.5 1062.8 1079.8 1079.8 1088.8 13192.0 14780.6 14817.4 15060.7 16539.5 618040.0 748268.0 755230.0 756203.0 762478.0 58297.7 58735.0 59082.1 59107.7 59262.0 1251.7 1364.9 1439.5 1459.6 1588.8 25277.6 29722.6 29992.1 30111.6 30926.2 51803.5 52025.7 52470.7 52660.0 52796.7 502938.0 503071.0 506737.0 508558.0 512270.0 32801.0 33290.5 33358.7 33440.7 33723.8 44351.0 44955.0 45488.8 45902.8 46600.5 36846.1 37570.8 38371.2 38382.2 38459.2 31075.0 31806.5 34265.5 36213.6 36849.3 31196.8 37096.0 37432.4 37562.0 37572.4 32193.2 33408.5 33542.2 33632.2 33643.3 19993.9 26024.0 26228.1 26475.9 27214.0 06:42:09 INFO - PROCESS | 1681 | 06:42:09 INFO - PROCESS | 1681 | [#2] jquery.html Cycles:180 Average:35048.12 Median:18247.46 stddev:109421.37 (599.7%) stddev-sans-first:109697.32 06:42:09 INFO - PROCESS | 1681 | Values: 359.2 363.3 364.4 368.1 368.2 14344.7 15504.4 18983.8 19851.0 20665.8 11814.8 12107.1 18464.8 19293.9 19811.0 3929.0 5130.8 5427.8 5439.1 5441.2 5728.2 5859.0 6034.1 6038.7 6057.1 5792.2 5962.9 5969.3 6034.3 6035.1 5703.1 5892.6 5933.1 5945.4 5980.2 5693.0 5735.4 5747.3 5767.1 5789.5 19635.6 25294.6 25436.9 25507.4 25618.6 1927.9 2114.1 2351.8 2385.0 2761.2 8986.7 9563.9 9816.9 9876.5 9890.3 1639.2 1793.4 1807.1 1841.2 1865.6 84355.6 99917.5 109849.0 112208.0 112776.0 9212.5 10840.0 11345.8 11361.1 11367.8 12558.1 12814.0 13272.1 13656.7 13810.8 6404.4 6549.3 8029.3 8620.1 8620.9 6225.9 6624.0 8612.1 8716.9 8829.9 3671.7 4217.9 4442.1 4467.4 4483.4 1573.6 1623.4 1927.1 1963.2 1981.3 865.9 902.3 1009.0 1009.4 1042.7 19425.6 19694.7 19754.0 20314.0 20365.8 776.7 920.2 969.0 979.5 1071.1 10597.0 10897.5 10910.9 10938.4 10946.5 651424.0 654608.0 665886.0 666827.0 672910.0 93668.5 103797.0 108641.0 120666.8 125314.0 1031.2 1041.1 1041.5 1071.7 1072.3 18436.5 18747.8 18751.3 18898.1 18929.0 36131.6 42659.1 47045.0 49985.5 51759.7 70245.6 73217.6 73420.6 73975.9 74481.6 7600.6 7855.3 7887.5 7954.2 7958.2 10336.6 12423.4 12428.4 12740.7 12743.5 6317.9 7866.3 10318.8 10960.5 11245.7 10482.8 10633.7 10787.8 10849.6 11026.2 5414.1 7599.0 9320.6 10979.9 11246.4 6399.3 7675.4 7948.8 7978.3 7979.4 8985.9 11022.9 11115.4 11360.8 11369.6 06:42:09 INFO - PROCESS | 1681 | 06:42:09 INFO - PROCESS | 1681 | [#3] mootools.html Cycles:180 Average:5981.65 Median:5481.16 stddev:3173.39 (57.9%) stddev-sans-first:3164.82 06:42:09 INFO - PROCESS | 1681 | Values: 1550.7 1567.6 1583.7 1918.6 1928.7 7810.0 7858.9 7988.6 8790.4 8887.5 8525.0 8603.1 8681.8 8707.9 8713.2 2112.7 2410.5 2421.1 2434.0 2445.9 2480.4 2481.9 2520.3 2523.4 2534.7 2155.8 2411.0 2465.6 2481.5 2498.4 2441.0 2452.2 2479.8 2484.3 2488.1 2106.8 2399.4 2457.2 2460.0 2468.6 8561.7 8616.7 8625.1 8665.5 8731.8 4861.6 4953.6 5415.9 5479.8 5486.3 2942.0 3591.7 3604.9 3737.9 3785.6 904.6 1080.8 1082.3 1103.5 1106.0 11659.7 11723.2 11781.4 11814.5 11860.1 4876.5 4876.7 4900.9 4937.2 4955.5 10100.7 10155.1 10182.9 10186.0 10199.3 5444.5 5469.8 5474.5 5482.6 5491.0 4024.4 4945.6 4959.5 4969.1 5025.4 3784.8 3842.2 3845.9 3881.6 3889.6 1268.9 1280.2 1282.8 1301.1 1304.3 1017.9 1117.1 1134.6 1251.4 1355.6 7699.3 7846.1 7874.0 7927.1 7941.2 642.0 646.8 652.7 654.8 793.8 6019.6 6034.2 6150.4 6185.8 6203.1 10233.6 10257.1 10628.9 10740.7 10802.8 10579.0 10655.9 10694.6 10725.3 10740.0 8085.8 8262.9 8264.4 8272.2 8351.9 7701.5 7743.8 7748.5 7790.9 7801.1 9332.2 9383.0 9415.9 9506.6 9597.3 9542.3 9799.9 9900.3 9958.1 9983.3 7267.7 7415.1 7421.2 7429.0 7443.1 8026.9 8088.1 8202.1 8210.6 8314.0 6691.8 7239.0 7365.8 7428.1 7571.9 7106.3 7252.1 7344.0 7347.9 7368.4 7643.2 7655.3 7667.7 7675.7 7677.1 6845.7 6921.6 6935.0 6953.7 6964.9 6031.3 6984.3 7001.9 7115.0 7198.3 06:42:09 INFO - PROCESS | 1681 | 06:42:09 INFO - PROCESS | 1681 | [#4] prototype.html Cycles:180 Average:5999.50 Median:6853.49 stddev:1978.47 (28.9%) stddev-sans-first:1937.62 06:42:09 INFO - PROCESS | 1681 | Values: 324.5 332.9 334.0 336.3 340.7 6807.6 6976.4 6984.8 6992.2 7013.7 5524.7 6914.4 6978.2 6995.4 7027.5 5151.9 5154.8 5160.2 5164.6 5179.6 4333.8 4859.2 5018.1 5172.0 5194.6 4935.3 4948.5 4949.4 4956.7 4970.4 4946.0 4948.9 4950.7 4958.3 4981.1 3009.3 3760.7 4041.9 4219.2 4223.2 5927.7 6127.5 6493.0 6632.1 6707.4 5329.5 5832.1 5863.6 5887.6 5892.9 7338.9 7341.1 7346.0 7352.8 7373.7 4254.8 4307.1 4665.1 4673.8 4680.4 7462.8 7803.3 7813.6 7835.1 7845.3 4724.9 4764.7 4776.2 4793.2 4800.3 4848.2 4849.2 4862.5 4872.4 4872.8 5596.9 5789.9 5850.1 5861.7 5919.6 6137.6 7397.8 7428.7 7437.4 7444.1 1300.4 1747.0 1752.6 1763.7 1771.6 1141.2 1141.5 1153.2 1153.6 1166.7 6819.5 6848.2 6855.0 6855.4 6882.0 7693.1 7705.0 7720.9 7730.4 7743.7 5477.4 5552.5 6841.0 6851.9 6982.0 3442.8 4093.1 4242.7 4247.6 4254.5 6964.9 7726.7 7887.2 8085.8 8192.3 7838.4 8011.0 8048.7 8067.1 8153.5 7582.2 8113.7 8114.2 8117.8 8139.5 7644.6 7814.6 7830.5 7846.7 7847.8 7644.5 7645.0 7653.4 7659.3 7666.3 8124.3 8125.0 8135.6 8159.9 8185.7 4608.2 4741.6 4746.9 4766.1 4791.1 7456.7 7600.6 7609.9 7665.4 7835.7 6062.4 7483.9 7500.7 7500.8 7504.0 6906.8 7209.4 7446.0 7473.3 7508.0 6260.4 6930.2 7265.8 7274.2 7302.3 7441.1 7447.3 7466.5 7478.6 7484.9 7056.3 7277.3 7298.7 7325.5 7340.2 06:42:09 INFO - PROCESS | 1681 | 06:42:09 INFO - PROCESS | 1681 | [#5] yui.html Cycles:180 Average:18024.00 Median:37284.64 stddev:26618.93 (71.4%) stddev-sans-first:26661.77 06:42:09 INFO - PROCESS | 1681 | Values: 685.9 720.9 746.1 755.5 755.9 14030.6 14155.9 14231.7 14281.4 14319.4 12586.5 12674.3 12806.1 12822.1 12854.9 702.8 856.7 863.7 883.4 884.5 736.7 853.6 871.9 877.9 886.1 919.6 919.7 934.8 934.8 941.4 920.8 931.9 934.8 938.6 941.7 675.2 694.7 694.7 696.2 698.2 13575.6 13756.9 13799.9 13802.4 13855.5 11198.9 12090.3 12178.0 12320.9 12594.9 7891.9 9262.4 9447.9 9486.4 9762.6 2834.5 3183.9 3267.5 3300.6 3368.9 59930.7 76293.0 76808.2 76968.2 79292.2 7768.3 8780.3 8863.4 8978.0 9119.1 18475.7 18483.1 18484.0 18528.0 18528.3 6630.1 6675.7 6862.7 6884.9 6903.8 3786.6 3852.2 3854.5 3861.5 3866.5 3302.9 3353.0 3355.8 3356.3 3361.6 624.7 647.8 654.6 682.9 687.5 495.9 496.9 565.8 585.7 627.9 7914.9 7984.4 7989.9 8068.0 8182.4 492.0 549.9 574.7 635.8 636.1 3673.6 3723.5 3767.2 3854.1 3895.8 95512.0 95979.0 98394.0 98761.5 98821.0 82489.6 82798.6 84016.2 84069.0 84445.6 71929.6 72344.6 73414.6 73832.6 74060.6 7585.3 7650.3 7685.5 7708.3 7759.9 49835.8 51086.5 51734.0 51739.5 52041.0 67037.7 70857.0 71923.3 72105.0 72760.6 9147.9 9148.1 9188.8 9228.2 9411.0 9852.3 9902.3 9943.6 9958.9 9963.8 9521.9 9522.8 9525.2 9542.4 9555.0 8566.9 8888.9 9451.8 9534.4 9534.6 9081.9 9449.1 9608.8 10465.2 10526.4 9128.0 9237.9 9397.0 9427.2 9484.8 6999.9 9104.0 9379.6 9470.7 9971.5 06:42:09 INFO - PROCESS | 1681 | -------- Summary: end -------- 06:42:09 INFO - PROCESS | 1681 | 06:42:10 INFO - TEST-INFO | 1681: exit 0 06:42:10 INFO - TEST-OK | dromaeo_css | took 1110663ms 06:42:10 INFO - TEST-START | kraken 06:42:10 INFO - operating with platform_type : mac_ 06:42:10 INFO - Initialising browser for kraken test... 06:42:10 INFO - TEST-INFO | started process 1690 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmpcQsTfF/profile http://localhost:49275/getInfo.html) 06:42:12 INFO - PROCESS | 1690 | __metrics Screen width/height:1600/1200 06:42:12 INFO - PROCESS | 1690 | colorDepth:24 06:42:12 INFO - PROCESS | 1690 | Browser inner width/height: 1024/689 06:42:12 INFO - PROCESS | 1690 | __metrics 06:42:13 ERROR - PROCESS | 1690 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 06:42:13 INFO - TEST-INFO | 1690: exit 0 06:42:13 INFO - Browser initialized. 06:42:13 INFO - Running cycle 1/1 for kraken test... 06:42:13 INFO - TEST-INFO | started process 1693 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmpcQsTfF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:42:25 INFO - PROCESS | 1693 | RSS: Main: 255496192 06:42:25 INFO - PROCESS | 1693 | 06:42:28 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 06:42:28 INFO - PROCESS | 1693 | RSS: Main: 268652544 06:42:28 INFO - PROCESS | 1693 | 06:42:31 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 06:42:32 INFO - PROCESS | 1693 | RSS: Main: 277991424 06:42:32 INFO - PROCESS | 1693 | 06:42:35 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 06:42:36 INFO - PROCESS | 1693 | RSS: Main: 281174016 06:42:36 INFO - PROCESS | 1693 | 06:42:38 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 06:42:38 INFO - PROCESS | 1693 | RSS: Main: 281620480 06:42:38 INFO - PROCESS | 1693 | 06:42:40 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:42:41 INFO - PROCESS | 1693 | RSS: Main: 283545600 06:42:41 INFO - PROCESS | 1693 | 06:42:44 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 06:42:44 INFO - PROCESS | 1693 | RSS: Main: 282501120 06:42:44 INFO - PROCESS | 1693 | 06:42:47 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 06:42:48 INFO - PROCESS | 1693 | RSS: Main: 282824704 06:42:48 INFO - PROCESS | 1693 | 06:42:51 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 06:42:51 INFO - PROCESS | 1693 | RSS: Main: 283435008 06:42:51 INFO - PROCESS | 1693 | 06:42:53 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:42:53 INFO - PROCESS | 1693 | RSS: Main: 283697152 06:42:53 INFO - PROCESS | 1693 | 06:42:55 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:42:56 INFO - PROCESS | 1693 | RSS: Main: 284168192 06:42:56 INFO - PROCESS | 1693 | 06:42:58 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:42:58 INFO - PROCESS | 1693 | RSS: Main: 284020736 06:42:58 INFO - PROCESS | 1693 | 06:43:01 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:43:02 INFO - PROCESS | 1693 | RSS: Main: 283521024 06:43:02 INFO - PROCESS | 1693 | 06:43:04 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:43:05 INFO - PROCESS | 1693 | RSS: Main: 284049408 06:43:05 INFO - PROCESS | 1693 | 06:43:06 INFO - PROCESS | 1693 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 06:43:07 INFO - PROCESS | 1693 | RSS: Main: 285323264 06:43:07 INFO - PROCESS | 1693 | 06:43:07 INFO - PROCESS | 1693 | __start_tp_report 06:43:07 INFO - PROCESS | 1693 | _x_x_mozilla_page_load 06:43:07 INFO - PROCESS | 1693 | _x_x_mozilla_page_load_details 06:43:07 INFO - PROCESS | 1693 | |i|pagename|runs| 06:43:07 INFO - PROCESS | 1693 | |0;ai-astar;114;112;117;114;113;124;114;116;115;115 06:43:07 INFO - PROCESS | 1693 | |1;audio-beat-detection;152;123;160;191;122;139;140;121;160;119 06:43:07 INFO - PROCESS | 1693 | |2;audio-dft;234;278;208;198;207;271;279;219;200;197 06:43:07 INFO - PROCESS | 1693 | |3;audio-fft;77;68;71;107;58;55;60;58;116;84 06:43:07 INFO - PROCESS | 1693 | |4;audio-oscillator;80;83;114;82;84;88;116;79;82;112 06:43:07 INFO - PROCESS | 1693 | |5;imaging-gaussian-blur;85;87;132;141;85;112;87;90;86;92 06:43:07 INFO - PROCESS | 1693 | |6;imaging-darkroom;95;96;93;99;96;98;156;152;95;95 06:43:07 INFO - PROCESS | 1693 | |7;imaging-desaturate;91;111;133;90;93;92;93;94;90;92 06:43:07 INFO - PROCESS | 1693 | |8;json-parse-financial;57;59;57;56;57;56;59;65;56;54 06:43:07 INFO - PROCESS | 1693 | |9;json-stringify-tinderbox;63;63;67;67;70;75;71;68;66;67 06:43:07 INFO - PROCESS | 1693 | |10;stanford-crypto-aes;87;82;86;84;85;84;85;87;81;87 06:43:07 INFO - PROCESS | 1693 | |11;stanford-crypto-ccm;145;137;148;118;139;136;140;141;134;132 06:43:07 INFO - PROCESS | 1693 | |12;stanford-crypto-pbkdf2;131;145;156;184;185;149;142;136;141;141 06:43:07 INFO - PROCESS | 1693 | |13;stanford-crypto-sha256-iterative;70;69;66;69;68;68;65;66;67;66 06:43:07 INFO - PROCESS | 1693 | __end_tp_report 06:43:07 INFO - PROCESS | 1693 | __start_cc_report 06:43:07 INFO - PROCESS | 1693 | _x_x_mozilla_cycle_collect,865 06:43:07 INFO - PROCESS | 1693 | __end_cc_report 06:43:07 INFO - PROCESS | 1693 | __startTimestamp1455892987240__endTimestamp 06:43:07 INFO - PROCESS | 1693 | 06:43:07 INFO - PROCESS | 1693 | ------- Summary: start ------- 06:43:07 INFO - PROCESS | 1693 | Number of tests: 14 06:43:07 INFO - PROCESS | 1693 | 06:43:07 INFO - PROCESS | 1693 | [#0] ai-astar Cycles:10 Average:115.40 Median:115.00 stddev:3.34 (2.9%) stddev-sans-first:3.50 06:43:07 INFO - PROCESS | 1693 | Values: 114.0 112.0 117.0 114.0 113.0 124.0 114.0 116.0 115.0 115.0 06:43:07 INFO - PROCESS | 1693 | 06:43:07 INFO - PROCESS | 1693 | [#1] audio-beat-detection Cycles:10 Average:142.70 Median:146.00 stddev:23.30 (16.0%) stddev-sans-first:24.47 06:43:07 INFO - PROCESS | 1693 | Values: 152.0 123.0 160.0 191.0 122.0 139.0 140.0 121.0 160.0 119.0 06:43:07 INFO - PROCESS | 1693 | 06:43:07 INFO - PROCESS | 1693 | [#2] audio-dft Cycles:10 Average:229.10 Median:226.50 stddev:34.22 (15.1%) stddev-sans-first:36.25 06:43:07 INFO - PROCESS | 1693 | Values: 234.0 278.0 208.0 198.0 207.0 271.0 279.0 219.0 200.0 197.0 06:43:07 INFO - PROCESS | 1693 | 06:43:07 INFO - PROCESS | 1693 | [#3] audio-fft Cycles:10 Average:75.40 Median:64.00 stddev:21.23 (33.2%) stddev-sans-first:22.51 06:43:07 INFO - PROCESS | 1693 | Values: 77.0 68.0 71.0 107.0 58.0 55.0 60.0 58.0 116.0 84.0 06:43:07 INFO - PROCESS | 1693 | 06:43:07 INFO - PROCESS | 1693 | [#4] audio-oscillator Cycles:10 Average:92.00 Median:82.00 stddev:15.40 (18.8%) stddev-sans-first:15.71 06:43:07 INFO - PROCESS | 1693 | Values: 80.0 83.0 114.0 82.0 84.0 88.0 116.0 79.0 82.0 112.0 06:43:07 INFO - PROCESS | 1693 | 06:43:07 INFO - PROCESS | 1693 | [#5] imaging-gaussian-blur Cycles:10 Average:99.70 Median:86.50 stddev:21.07 (24.4%) stddev-sans-first:21.67 06:43:07 INFO - PROCESS | 1693 | Values: 85.0 87.0 132.0 141.0 85.0 112.0 87.0 90.0 86.0 92.0 06:43:07 INFO - PROCESS | 1693 | 06:43:07 INFO - PROCESS | 1693 | [#6] imaging-darkroom Cycles:10 Average:107.50 Median:95.50 stddev:24.58 (25.7%) stddev-sans-first:25.65 06:43:07 INFO - PROCESS | 1693 | Values: 95.0 96.0 93.0 99.0 96.0 98.0 156.0 152.0 95.0 95.0 06:43:07 INFO - PROCESS | 1693 | 06:43:07 INFO - PROCESS | 1693 | [#7] imaging-desaturate Cycles:10 Average:97.90 Median:92.00 stddev:13.78 (15.0%) stddev-sans-first:14.39 06:43:07 INFO - PROCESS | 1693 | Values: 91.0 111.0 133.0 90.0 93.0 92.0 93.0 94.0 90.0 92.0 06:43:07 INFO - PROCESS | 1693 | 06:43:07 INFO - PROCESS | 1693 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:57.00 stddev:2.99 (5.2%) stddev-sans-first:3.16 06:43:07 INFO - PROCESS | 1693 | Values: 57.0 59.0 57.0 56.0 57.0 56.0 59.0 65.0 56.0 54.0 06:43:07 INFO - PROCESS | 1693 | 06:43:07 INFO - PROCESS | 1693 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:67.50 stddev:3.62 (5.4%) stddev-sans-first:3.42 06:43:07 INFO - PROCESS | 1693 | Values: 63.0 63.0 67.0 67.0 70.0 75.0 71.0 68.0 66.0 67.0 06:43:07 INFO - PROCESS | 1693 | 06:43:07 INFO - PROCESS | 1693 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:85.50 stddev:2.10 (2.5%) stddev-sans-first:2.07 06:43:07 INFO - PROCESS | 1693 | Values: 87.0 82.0 86.0 84.0 85.0 84.0 85.0 87.0 81.0 87.0 06:43:07 INFO - PROCESS | 1693 | 06:43:07 INFO - PROCESS | 1693 | [#11] stanford-crypto-ccm Cycles:10 Average:137.00 Median:139.50 stddev:8.23 (5.9%) stddev-sans-first:8.21 06:43:07 INFO - PROCESS | 1693 | Values: 145.0 137.0 148.0 118.0 139.0 136.0 140.0 141.0 134.0 132.0 06:43:07 INFO - PROCESS | 1693 | 06:43:07 INFO - PROCESS | 1693 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.00 Median:147.00 stddev:18.90 (12.9%) stddev-sans-first:18.61 06:43:07 INFO - PROCESS | 1693 | Values: 131.0 145.0 156.0 184.0 185.0 149.0 142.0 136.0 141.0 141.0 06:43:07 INFO - PROCESS | 1693 | 06:43:07 INFO - PROCESS | 1693 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:68.00 stddev:1.65 (2.4%) stddev-sans-first:1.45 06:43:07 INFO - PROCESS | 1693 | Values: 70.0 69.0 66.0 69.0 68.0 68.0 65.0 66.0 67.0 66.0 06:43:07 INFO - PROCESS | 1693 | -------- Summary: end -------- 06:43:07 INFO - PROCESS | 1693 | 06:43:07 INFO - TEST-INFO | 1693: exit 0 06:43:08 INFO - TEST-OK | kraken | took 57936ms 06:43:08 INFO - SUITE-END | took 1168s 06:43:08 INFO - Completed test suite (00:19:29) 06:43:08 INFO - Working with test: dromaeo_css 06:43:08 INFO - Generating results file: dromaeo_css 06:43:08 INFO - Working with test: kraken 06:43:08 INFO - Generating results file: kraken 06:43:08 INFO - javascript benchmark 06:43:08 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:43:08 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 06:43:08 INFO - process_Request line: dromaeo_css 7424.64 graph.html#tests=[[72,64,61]] 06:43:08 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:43:08 INFO - process_Request line: kraken 1525.20 graph.html#tests=[[232,64,61]] 06:43:08 INFO - RETURN: dromaeo_css: 7424.64 06:43:08 INFO - RETURN: kraken: 1525.20 06:43:08 INFO - javascript benchmark 06:43:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3504.404251277283, 3519.4544845548935, 3543.3267679140977, 3576.159602493414, 3593.371160046992, 4578.931316030262, 5629.0149223885755, 5673.546116310701, 5794.855128621782, 5804.2744656917885, 5387.164989426636, 5703.201551782743, 5831.620944638596, 5857.297124345085, 5876.471117599415, 5185.066687996159, 5247.291615631898, 5306.575473962093, 5360.624756267063, 5455.18172274158, 5152.433232344458, 5230.555402790767, 5353.464653534655, 5355.839324820262, 5376.086065368897, 4646.930296045562, 4964.131277026506, 5222.164453687411, 5230.660007099526, 5264.368275806889, 5253.789848406059, 5268.4994925482015, 5273.815416460444, 5279.208118782175, 5296.232046353296, 5196.2465442511, 5206.713630750307, 5244.344456942882, 5246.265522826808, 5253.579713622901, 5491.670499769986, 5583.078791999315, 5672.319321681424, 5695.5443564514735, 5705.0, 5889.146073819272, 6104.147103685057, 6125.021800333839, 6204.317525072239, 6284.99440089588, 6172.135900973867, 6263.217097862767, 6289.182406287199, 6290.528210384239, 6331.050342448623, 5887.116932460122, 5911.822645320647, 5913.408659134138, 5928.051511758098, 5981.700914954235, 6197.318294987548, 6285.931391663428, 6307.810765677037, 6320.431161195423, 6331.018692102732, 6181.536384771161, 6216.720247588869, 6219.844503887439, 6223.190985171898, 6230.345813689588, 6160.9383906161265, 6221.96889015552, 6288.654124023131, 6319.557630965788, 6345.302016778151, 6202.255729312421, 6264.561480696399, 6272.3100458949475, 6275.058741188858, 6283.151774510383, 6238.625682459067, 6284.308726040132, 6289.77985770505, 6311.652859092794, 6325.841853953688, 4832.95167048325, 4855.951440485621, 4916.164252077156, 4929.162042452792, 4967.627427942846, 4375.343698445258, 4392.121575684876, 4435.578620031092, 4437.64498840092, 4472.2620767573635, 5640.266765320564, 5753.482186603226, 5810.564207684441, 5843.590948633555, 5874.089516125007, 6228.781992630326, 6275.592086514362, 6284.183056202756, 6289.654069026156, 6300.3699630037545, 4754.809807607726, 4883.804647814048, 5775.27809023872, 5822.563307751935, 5839.0, 4328.567143285646, 5340.626156169109, 5380.435054319319, 5403.189521571717, 5467.015937131355, 6222.284437289679, 6302.905456418249, 6360.809175724736, 6393.2328120625825, 6407.903881441782, 6227.875442491216, 6264.968675156595, 6267.2792628848265, 6281.152044473937, 6289.150964619717, 6284.748610055546, 6393.041043843461, 6421.197350331208, 6424.357564243538, 6443.387878151568, 6159.753609855556, 6196.349383314687, 6199.256089269316, 6213.720382582705, 6225.31521532622, 6229.065640154013, 6229.781957631461, 6241.282252541016, 6254.186955695731, 6262.0, 5074.746262686777, 6148.631082135086, 6161.075838624242, 6168.321484636596, 6190.792795404853, 5798.536117110705, 6143.447089761943, 6150.876982460415, 6167.167432396569, 6180.938190618216, 5848.4151584841175, 5920.437558431942, 5956.791512297049, 5990.7004649768205, 6035.215421995288, 6117.059633871721, 6162.753489860355, 6183.505319574333, 6203.410675985774, 6204.3795620437595, 6049.606775559574, 6059.969805133226, 6064.151018857276, 6068.241469816273, 6082.878342433215], "unit": "score", "name": "dojo.html", "value": 5713.242988902014}, {"lowerIsBetter": false, "replicates": [447.45634054623645, 456.1265177185689, 483.36678950574736, 600.1298117729293, 619.3001907844135, 38637.99999999996, 38800.22399552011, 38838.805805971, 38869.02827429316, 38888.833334999996, 40008.0, 40499.19001619966, 40618.0, 40679.983000425, 40965.97585060375, 9384.343095983284, 9594.808103837953, 9610.0, 9618.615255389775, 9628.614855405775, 9510.286728495355, 9718.31971761977, 9730.951345243298, 9776.853347199798, 9777.022297770201, 9703.369280996749, 9810.215182785396, 9813.214942804594, 9824.263180261472, 9833.557489912935, 9656.758581035496, 9743.853842192337, 9749.0, 9771.951140244324, 9802.313838031341, 9541.856872146924, 9702.563384647709, 9715.22278217748, 9727.756806079904, 9737.464439455827, 38509.22981540354, 38860.83417497479, 39005.63480278205, 39125.80437097825, 39183.0, 2639.5116903372746, 3226.532152837849, 3384.7969121852766, 3394.7114495267683, 3549.7337699672626, 29181.854090729623, 29278.707212928024, 29324.706752932623, 29538.113856584336, 29819.403611927857, 2786.6656001279775, 2835.5463125899755, 2872.6552813662493, 2881.7118288171223, 2995.65549961755, 441025.0, 445406.0, 446061.53938460525, 449403.0, 449638.0, 45161.54838451639, 45796.0, 46065.53934460613, 65999.0, 66437.0, 44744.77627611841, 45118.09763804705, 45347.09305813865, 45443.31835022477, 45652.315215271796, 15335.846641533442, 15419.229038548028, 15483.071015739091, 15519.37922483088, 15522.379104835905, 12162.08784341178, 12257.816132758016, 12371.75256494865, 12470.688232794253, 12505.124641275206, 14790.0, 14808.259587020606, 14833.629159271104, 14889.329980150702, 14947.551573452596, 6287.245530536365, 6398.136251606066, 6428.935710642927, 6435.774747883802, 6466.6766661666725, 915.2632131134368, 952.6475204174361, 999.8950110238466, 1031.0874875735028, 1075.4945175767377, 24935.87532062328, 27144.864275678494, 29213.7078629211, 29958.850205749266, 30709.69290307113, 968.5302628225305, 1062.792755412687, 1079.8164312066967, 1079.8434227037035, 1088.7931293054294, 13192.010599205098, 14780.637365051816, 14817.40730370773, 15060.698786024437, 16539.50381488557, 618040.0, 748268.0, 755230.0, 756203.0, 762478.0, 58297.70851145802, 58735.0, 59082.11376829351, 59107.70446147742, 59262.0, 1251.7294945630192, 1364.9317534123254, 1439.5105664074265, 1459.6423876150411, 1588.8252292247844, 25277.609731464945, 29722.554161688025, 29992.100236992927, 30111.58321089603, 30926.22684432907, 51803.48196517987, 52025.699357516365, 52470.73764631152, 52660.0, 52796.73601632121, 502938.0, 503071.0, 506737.0, 508558.0, 512270.0, 32801.01596952095, 33290.500642490864, 33358.66641333556, 33440.66237350479, 33723.83138084392, 44351.0, 44955.0, 45488.77255613701, 45902.77048614869, 46600.533994660975, 36846.078848029014, 37570.8121459391, 38371.23257534778, 38382.23235535218, 38459.23081538297, 31075.0, 31806.52290215695, 34265.486017709256, 36213.63786362103, 36849.263014739015, 31196.844015780684, 37096.0, 37432.438513421774, 37562.0, 37572.436413454365, 32193.195170120933, 33408.49887251742, 33542.16144596405, 33632.15919602029, 33643.327133457686, 19993.900030499753, 26024.0, 26228.08201712931, 26475.94096236129, 27214.047508337113], "unit": "score", "name": "ext.html", "value": 19285.240466937717}, {"lowerIsBetter": false, "replicates": [359.23662217787205, 363.28976850257743, 364.4478614898429, 368.123865200822, 368.1789609171547, 14344.713105737905, 15504.379824806994, 18983.81016189838, 19851.0, 20665.793342066576, 11814.822777658343, 12107.091968102384, 18464.81535184648, 19293.903530482326, 19811.0, 3929.017745563609, 5130.769115389798, 5427.755750991215, 5439.075357189287, 5441.1838224266285, 5728.226689396941, 5858.970705146468, 6034.0948857671265, 6038.735474197176, 6057.061155520902, 5792.218050563183, 5962.850928726773, 5969.283685957691, 6034.275886893557, 6035.094735789623, 5703.08750599902, 5892.616979896293, 5933.139694744281, 5945.37573554777, 5980.162777211194, 5693.0, 5735.397783232742, 5747.339056008571, 5767.106098554731, 5789.507891829157, 19635.607287854305, 25294.620580691306, 25436.872815635805, 25507.362315942064, 25618.615720764203, 1927.874688145266, 2114.080375036864, 2351.8471299365488, 2384.977930724916, 2761.1716485054603, 8986.741856140146, 9563.90436095637, 9816.852747208797, 9876.45679487635, 9890.258230632659, 1639.2377544441892, 1793.3812834572052, 1807.1054827860162, 1841.1806745998035, 1865.6175484025741, 84355.5782221091, 99917.5004124982, 109849.0, 112208.0, 112776.0, 9212.493312867857, 10840.0, 11345.773084538429, 11361.091112710963, 11367.829482557769, 12558.120931534888, 12814.0, 13272.070955033056, 13656.726865462833, 13810.792838107436, 6404.423601875854, 6549.345065493508, 8029.277365037175, 8620.13798620133, 8620.87928569282, 6225.937740622627, 6624.039514270404, 8612.09572994839, 8716.912830871737, 8829.867551986725, 3671.742977991515, 4217.915641687149, 4442.067165895133, 4467.441569803775, 4483.417155769795, 1573.5987323232503, 1623.4317988703858, 1927.1327902443957, 1963.1754663041556, 1981.2570286142698, 865.913278835058, 902.309733054214, 1009.0313299232819, 1009.405599774142, 1042.7080417483116, 19425.611487770166, 19694.70457943132, 19754.0, 20314.0, 20365.796342036687, 776.7359097906739, 920.1856357123994, 968.9951550242204, 979.5298256836616, 1071.0735214039955, 10597.046265836112, 10897.509612067475, 10910.945445272722, 10938.398388088732, 10946.4526773661, 651424.0, 654608.0, 665886.0, 666827.0, 672910.0, 93668.53165734127, 103797.0, 108641.0, 120666.79333206732, 125314.0, 1031.2265800649513, 1041.0786453988276, 1041.4948749856314, 1071.7159952612565, 1072.2815713471994, 18436.539086522946, 18747.812521875152, 18751.34370297033, 18898.14958326851, 18928.958907260232, 36131.63868361283, 42659.14681706411, 47045.0, 49985.50014499954, 51759.74120129375, 70245.64877175582, 73217.6339118301, 73420.63289683517, 73975.8903616457, 74481.62759186169, 7600.581967991592, 7855.253750893656, 7887.526748395115, 7954.204579542231, 7958.204179581995, 10336.586536538454, 12423.379218803784, 12428.440720167795, 12740.74518509606, 12743.49026038948, 6317.873642527032, 7866.252705992922, 10318.793624127626, 10960.506777195205, 11245.718857028312, 10482.842757358798, 10633.680989570325, 10787.784244315228, 10849.620263290746, 11026.173037022416, 5414.079606466831, 7598.96200519016, 9320.555313926352, 10979.890201097887, 11246.381449020382, 6399.2640846303275, 7675.385969122569, 7948.801279968047, 7978.3218426434405, 7979.361651068017, 8985.865212021694, 11022.889771102185, 11115.444227788417, 11360.829587556358, 11369.602063928054], "unit": "score", "name": "jquery.html", "value": 9057.496390319115}, {"lowerIsBetter": false, "replicates": [1550.6511035017122, 1567.592425969248, 1583.6674298397336, 1918.645050665626, 1928.7106933959913, 7809.960950195241, 7858.921410785891, 7988.640511177004, 8790.428622139565, 8887.511186884718, 8525.0, 8603.139686031394, 8681.782955426117, 8707.91292087079, 8713.215810577047, 2112.725345705056, 2410.5058463015084, 2421.140495124232, 2433.9756602434013, 2445.8504502883616, 2480.355107672, 2481.8759062046915, 2520.3447103752974, 2523.3691577105724, 2534.6704928359286, 2155.7628660847295, 2410.987945060272, 2465.642481840132, 2481.5161043596504, 2498.4378514834107, 2440.9633855492184, 2452.203034013935, 2479.764422379871, 2484.2795589279085, 2488.091846476041, 2106.8314534837177, 2399.4121440247077, 2457.213691618683, 2459.9914035245465, 2468.629705544183, 8561.700340488052, 8616.741497755078, 8625.094365091638, 8665.480071195749, 8731.825363492695, 4861.562459378673, 4953.628477864175, 5415.918761218585, 5479.75341109651, 5486.286782718221, 2941.9852900735573, 3591.7306202034692, 3604.873829415958, 3737.9252414951548, 3785.62143785622, 904.6291020681489, 1080.827067669177, 1082.3289560472558, 1103.4593049405814, 1105.9944700276528, 11659.708507287301, 11723.179377443583, 11781.352025638587, 11814.46834892432, 11860.110491713156, 4876.463589005207, 4876.707397556158, 4900.852974410774, 4937.1606826839525, 4955.529224723646, 10100.696979090639, 10155.136813370946, 10182.949085254526, 10186.03232692893, 10199.28604997658, 5444.50999410055, 5469.808556700496, 5474.452554744574, 5482.5613950883835, 5491.0, 4024.4164596133396, 4945.604351651859, 4959.454460009396, 4969.105560999054, 5025.422076461181, 3784.7729136251914, 3842.2315536892734, 3845.9038524037123, 3881.6312450317173, 3889.6110388961442, 1268.898488120948, 1280.2446556531504, 1282.8460584729892, 1301.076235872541, 1304.341307639636, 1017.9389236645825, 1117.1118960426481, 1134.6482590397004, 1251.380566619511, 1355.593322003395, 7699.26856948589, 7846.058472983279, 7874.0, 7927.128015918244, 7941.205879412013, 641.9550631455753, 646.802725168828, 652.7062821730145, 654.8199245207607, 793.8092860708937, 6019.578629495893, 6034.1853849730605, 6150.446459818638, 6185.8144255672405, 6203.131561581382, 10233.59065637381, 10257.128144107834, 10628.946855265674, 10740.73148171302, 10802.837957430645, 10578.994995475417, 10655.946720266504, 10694.572217111228, 10725.30285531438, 10739.979701928305, 8085.838283234302, 8262.876056859152, 8264.421490495608, 8272.214139656722, 8351.916480835236, 7701.537907725555, 7743.845123097394, 7748.496347737379, 7790.9220907790195, 7801.102873169431, 9332.16010559053, 9382.953085234803, 9415.85876211871, 9506.572204250688, 9597.28020398459, 9542.284328675238, 9799.85300220483, 9900.306978511435, 9958.103770660675, 9983.301168918397, 7267.672954717156, 7415.073115860518, 7421.220771818881, 7428.9628551856895, 7443.069616297963, 8026.916366290476, 8088.110307866248, 8202.09776924526, 8210.63052162642, 8313.958430207811, 6691.799246022627, 7238.963805180941, 7365.8158546036775, 7428.071491063617, 7571.886421703789, 7106.253843346581, 7252.129744430702, 7344.045274114331, 7347.889781653173, 7368.447366447645, 7643.197464266172, 7655.349295309961, 7667.731629392944, 7675.654595543102, 7677.078750549969, 6845.691943862438, 6921.6193109379465, 6935.0, 6953.721851125898, 6964.860702786017, 6031.336552979256, 6984.301569842975, 7001.859962800817, 7115.039469671528, 7198.280171982759], "unit": "score", "name": "mootools.html", "value": 4821.559447092667}, {"lowerIsBetter": false, "replicates": [324.5164704590161, 332.8601987165392, 334.0446323514746, 336.2870714086137, 340.70699198689107, 6807.557508761927, 6976.441884649223, 6984.790456286313, 6992.182032671504, 7013.719451221945, 5524.723763811803, 6914.44684425246, 6978.232394436608, 6995.370416662499, 7027.47293952953, 5151.896962060757, 5154.819581314655, 5160.200168973796, 5164.561012313958, 5179.611529135311, 4333.811425230254, 4859.2225243960975, 5018.121828679985, 5171.991461664977, 5194.584433245332, 4935.259711043336, 4948.529889660476, 4949.406071271453, 4956.7025978441225, 4970.353853998975, 4946.010797840447, 4948.851534453972, 4950.702957822542, 4958.256261560777, 4981.103401387785, 3009.277773334406, 3760.7401520490394, 4041.8989525262105, 4219.156168766228, 4223.21870453967, 5927.703614819242, 6127.479164270998, 6493.0, 6632.1046658701425, 6707.3628005339415, 5329.493698098674, 5832.125181222808, 5863.618864773819, 5887.587868849182, 5892.941070589282, 7338.926610733931, 7341.082364704412, 7346.045014148127, 7352.77941661751, 7373.705051797921, 4254.765987870666, 4307.117041006586, 4665.113628410591, 4673.789679464432, 4680.4149481314835, 7462.813429664247, 7803.258690424401, 7813.570253636105, 7835.138134805167, 7845.293923546908, 4724.929126063112, 4764.690295130806, 4776.188048031843, 4793.23308270675, 4800.255960326155, 4848.17581011229, 4849.199882019498, 4862.5380588844, 4872.3909511311085, 4872.829450969199, 5596.944030559724, 5789.88420231593, 5850.063989761617, 5861.70691465425, 5919.644821310735, 6137.570370074052, 7397.8150546236775, 7428.739994100289, 7437.405007599379, 7444.106707195063, 1300.3953161779818, 1747.0, 1752.5618595351161, 1763.6825371433265, 1771.6013896873358, 1141.1612464838338, 1141.5319718915205, 1153.1581945180067, 1153.6481373181093, 1166.7083229192701, 6819.522633415613, 6848.178218613798, 6855.040294358794, 6855.400914519917, 6881.967704844214, 7693.07683078023, 7704.961475192588, 7720.922790772132, 7730.420218483636, 7743.651535680795, 5477.4248703886315, 5552.472515111058, 6841.0, 6851.931480685229, 6981.965090174516, 3442.7934323940644, 4093.140440507527, 4242.745435273893, 4247.617714405718, 4254.489461264668, 6964.93035069653, 7726.652300646484, 7887.2112788721815, 8085.838283234302, 8192.303654189342, 7838.372930165687, 8011.0, 8048.678052877819, 8067.112617612058, 8153.510789352657, 7582.165961744204, 8113.675452981933, 8114.229148230908, 8117.837643246984, 8139.511629302261, 7644.617769111411, 7814.6483408247905, 7830.530168189927, 7846.725364612211, 7847.8038049046945, 7644.503107298008, 7645.01229680276, 7653.387728981556, 7659.348955338859, 7666.310032097138, 8124.309433698202, 8125.0, 8135.583055116746, 8159.918400815915, 8185.672573097248, 4608.239640459286, 4741.57325840676, 4746.928796067993, 4766.118268120409, 4791.089692958327, 7456.66445009965, 7600.581967991813, 7609.923900761143, 7665.386769058574, 7835.686572537034, 6062.393760623902, 7483.850322993619, 7500.699972001059, 7500.812479688051, 7503.962480187564, 6906.827329316808, 7209.35115839577, 7446.0, 7473.327400533978, 7508.0, 6260.4019331976715, 6930.237673855972, 7265.818354540967, 7274.236205198589, 7302.306280903305, 7441.10706715176, 7447.329740323397, 7466.514676546007, 7478.588677622565, 7484.850302994018, 7056.329648683367, 7277.2722727726805, 7298.744543940937, 7325.523840950321, 7340.192578816219], "unit": "score", "name": "prototype.html", "value": 5340.6905131186295}, {"lowerIsBetter": false, "replicates": [685.8662560800643, 720.9351158395743, 746.1456632156181, 755.4900442201513, 755.9039392880318, 14030.579082627524, 14155.929220353884, 14231.71536569268, 14281.428742850274, 14319.427222911085, 12586.496540138407, 12674.302913339763, 12806.103572749911, 12822.102452828305, 12854.871451285484, 702.8242939265184, 856.6873091321685, 863.7236084452977, 883.4434306386967, 884.4604791077437, 736.6519269736369, 853.5604163855619, 871.8648609465542, 877.934154938379, 886.1492966751894, 919.6229545886188, 919.7194855569048, 934.7849994501269, 934.8177105464437, 941.3645789092369, 920.7882187096939, 931.8835145606799, 934.8083642853233, 938.5823308627663, 941.7033634405175, 675.189772273274, 694.7325279767275, 694.7498900395854, 696.2098018748705, 698.1900994846005, 13575.592732218049, 13756.931215343859, 13799.86200138006, 13802.447902083904, 13855.515056972958, 11198.936101070467, 12090.33503157326, 12178.0, 12320.876791232062, 12594.937025314906, 7891.921080789176, 9262.351635385527, 9447.858282125773, 9486.430814151174, 9762.633231347618, 2834.503961806696, 3183.9363212735616, 3267.493538501536, 3300.5874265716784, 3368.949465757991, 59930.700346497986, 76293.0, 76808.23191768066, 76968.23031769667, 79292.20707792907, 7768.2620151086685, 8780.253678437277, 8863.423877447945, 8977.955110224408, 9119.088091190828, 18475.722864157047, 18483.075846207637, 18483.98338091418, 18528.0, 18528.258869645062, 6630.138082049302, 6675.732970681215, 6862.725490980405, 6884.862302754017, 6903.827404314832, 3786.5645450772963, 3852.210296889131, 3854.5374555053572, 3861.4787003754695, 3866.5360156781367, 3302.884399046022, 3353.027621989596, 3355.8489867956, 3356.2616224430585, 3361.596608407007, 624.7001439309157, 647.8121344810047, 654.6039646014189, 682.8634273145391, 687.4740823270203, 495.90825697246123, 496.85591178557814, 565.7708628005664, 585.6661702829432, 627.8807026664919, 7914.920850791418, 7984.441089123706, 7989.934564764009, 8068.0, 8182.386321025828, 491.98278060267717, 549.8762778374834, 574.6523353371234, 635.7774778827466, 636.096742625473, 3673.5959044505084, 3723.4600982857874, 3767.2088861339425, 3854.0750219947013, 3895.8052097395016, 95512.0, 95979.0, 98394.0, 98761.50619246857, 98821.0, 82489.58755206186, 82798.58600706958, 84016.15983840084, 84069.0, 84445.57777211198, 71929.56140877258, 72344.55310893753, 73414.63292683609, 73832.63083684548, 74060.62969685117, 7585.279398457138, 7650.273224043707, 7685.5004424712215, 7708.2677145673315, 7759.883601746092, 49835.75082124566, 51086.489135108175, 51734.0, 51739.48260517346, 52041.0, 67037.66481167563, 70857.0, 71923.28076719165, 72105.0, 72760.63619681868, 9147.908520914705, 9148.130927561871, 9188.816223675356, 9228.169464748205, 9411.0, 9852.314697446349, 9902.306838521523, 9943.552540135855, 9958.850617240892, 9963.800723985334, 9521.904780952102, 9522.761930951781, 9525.190358819578, 9542.379745316532, 9554.952225238829, 8566.871496927426, 8888.866666999871, 9451.763705907408, 9534.380265282734, 9534.570944307661, 9081.910170779285, 9449.102335278138, 9608.807823843625, 10465.162786977176, 10526.368417894952, 9127.954360228156, 9237.861432078658, 9397.0, 9427.24582033422, 9484.762880927756, 6999.930000699927, 9103.998560158245, 9379.643755820325, 9470.74373722563, 9971.451570163421], "unit": "score", "name": "yui.html", "value": 6518.033914105214}], "name": "dromaeo_css", "value": 7424.636028949469}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 112.0, 117.0, 114.0, 113.0, 124.0, 114.0, 116.0, 115.0, 115.0], "unit": "score", "name": "ai-astar", "value": 115.4}, {"lowerIsBetter": true, "replicates": [152.0, 123.0, 160.0, 191.0, 122.0, 139.0, 140.0, 121.0, 160.0, 119.0], "unit": "score", "name": "audio-beat-detection", "value": 142.7}, {"lowerIsBetter": true, "replicates": [234.0, 278.0, 208.0, 198.0, 207.0, 271.0, 279.0, 219.0, 200.0, 197.0], "unit": "score", "name": "audio-dft", "value": 229.1}, {"lowerIsBetter": true, "replicates": [77.0, 68.0, 71.0, 107.0, 58.0, 55.0, 60.0, 58.0, 116.0, 84.0], "unit": "score", "name": "audio-fft", "value": 75.4}, {"lowerIsBetter": true, "replicates": [80.0, 83.0, 114.0, 82.0, 84.0, 88.0, 116.0, 79.0, 82.0, 112.0], "unit": "score", "name": "audio-oscillator", "value": 92.0}, {"lowerIsBetter": true, "replicates": [85.0, 87.0, 132.0, 141.0, 85.0, 112.0, 87.0, 90.0, 86.0, 92.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 99.7}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 93.0, 99.0, 96.0, 98.0, 156.0, 152.0, 95.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 107.5}, {"lowerIsBetter": true, "replicates": [91.0, 111.0, 133.0, 90.0, 93.0, 92.0, 93.0, 94.0, 90.0, 92.0], "unit": "score", "name": "imaging-desaturate", "value": 97.9}, {"lowerIsBetter": true, "replicates": [57.0, 59.0, 57.0, 56.0, 57.0, 56.0, 59.0, 65.0, 56.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.6}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 67.0, 67.0, 70.0, 75.0, 71.0, 68.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [87.0, 82.0, 86.0, 84.0, 85.0, 84.0, 85.0, 87.0, 81.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.8}, {"lowerIsBetter": true, "replicates": [145.0, 137.0, 148.0, 118.0, 139.0, 136.0, 140.0, 141.0, 134.0, 132.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 137.0}, {"lowerIsBetter": true, "replicates": [131.0, 145.0, 156.0, 184.0, 185.0, 149.0, 142.0, 136.0, 141.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.0}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 66.0, 69.0, 68.0, 68.0, 65.0, 66.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.4}], "name": "kraken", "value": 1525.2}]} 06:43:08 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1525.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7424.64"}}} 06:43:08 INFO - Return code: 0 06:43:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:43:08 ERROR - # TBPL SUCCESS # 06:43:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:43:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:43:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:43:08 INFO - 2016-02-19 06:43:08.693 screenresolution[1698:10616] starting screenresolution argv=screenresolution get 06:43:08 INFO - 2016-02-19 06:43:08.695 screenresolution[1698:10616] Display 0: 1600x1200x32@60 06:43:08 INFO - 2016-02-19 06:43:08.701 screenresolution[1699:10619] starting screenresolution argv=screenresolution list 06:43:08 INFO - Available Modes on Display 0 06:43:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:43:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:43:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:43:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:43:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:43:08 INFO - Intel Iris: 06:43:08 INFO - Chipset Model: Intel Iris 06:43:08 INFO - Type: GPU 06:43:08 INFO - Bus: Built-In 06:43:08 INFO - VRAM (Dynamic, Max): 1536 MB 06:43:08 INFO - Vendor: Intel (0x8086) 06:43:08 INFO - Device ID: 0x0a2e 06:43:08 INFO - Revision ID: 0x0009 06:43:08 INFO - Displays: 06:43:08 INFO - Display: 06:43:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:43:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:43:08 INFO - Display Serial Number: 1600x1200 60 06:43:08 INFO - Main Display: Yes 06:43:08 INFO - Mirror: Off 06:43:08 INFO - Online: Yes 06:43:08 INFO - Rotation: Supported 06:43:08 INFO - Return code: 0 06:43:08 INFO - Running post-action listener: _resource_record_post_action 06:43:08 INFO - Running post-run listener: _resource_record_post_run 06:43:09 INFO - Total resource usage - Wall time: 1205s; CPU: 53.0%; Read bytes: 34110976; Write bytes: 709127168; Read time: 358; Write time: 2095 06:43:09 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 384668160; Write bytes: 377882112; Read time: 28653; Write time: 770 06:43:10 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 33189376; Write bytes: 303736320; Read time: 345; Write time: 1259 06:43:10 INFO - Running post-run listener: _upload_blobber_files 06:43:10 INFO - Blob upload gear active. 06:43:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:43:10 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 06:43:10 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'] 06:43:10 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 06:43:10 INFO - (blobuploader) - INFO - Open directory for files ... 06:43:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:43:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:43:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:43:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:43:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:43:11 INFO - (blobuploader) - INFO - Done attempting. 06:43:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:43:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:43:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:43:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:43:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:43:12 INFO - (blobuploader) - INFO - Done attempting. 06:43:12 INFO - (blobuploader) - INFO - Iteration through files over. 06:43:12 INFO - Return code: 0 06:43:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:43:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:43:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ca9ca85dc0f7e9f706a95ad52b289a04437f810d28172b19d3bfe54517bea2f7b42069650490e2abe3cbe8776dfeb97437b955b6da2a1f2d74aac2fa7735ea97", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2ccd3cb7f981fe3cd3c69ccb4afbeb9253e511492f54bbbbea1ab6c70bc5e0e4da9c44e6ed45b5978d4073cc68381f3eabb875bd2b134f27b4ad5956b7224149"} 06:43:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:43:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:43:12 INFO - Contents: 06:43:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ca9ca85dc0f7e9f706a95ad52b289a04437f810d28172b19d3bfe54517bea2f7b42069650490e2abe3cbe8776dfeb97437b955b6da2a1f2d74aac2fa7735ea97", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2ccd3cb7f981fe3cd3c69ccb4afbeb9253e511492f54bbbbea1ab6c70bc5e0e4da9c44e6ed45b5978d4073cc68381f3eabb875bd2b134f27b4ad5956b7224149"} 06:43:12 INFO - Running post-run listener: copy_logs_to_upload_dir 06:43:12 INFO - Copying logs to upload dir... 06:43:12 INFO - mkdir: /builds/slave/test/build/upload/logs 06:43:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.546971 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-02-19 06:43:12.941881) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-19 06:43:12.945716) ========= 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.40Ie1x7dxP/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.mqQaTJBH2U/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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/ca9ca85dc0f7e9f706a95ad52b289a04437f810d28172b19d3bfe54517bea2f7b42069650490e2abe3cbe8776dfeb97437b955b6da2a1f2d74aac2fa7735ea97", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2ccd3cb7f981fe3cd3c69ccb4afbeb9253e511492f54bbbbea1ab6c70bc5e0e4da9c44e6ed45b5978d4073cc68381f3eabb875bd2b134f27b4ad5956b7224149"} build_url:https://queue.taskcluster.net/v1/task/dIBcVioaQ4euf9QHhWUnpg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010779 build_url: 'https://queue.taskcluster.net/v1/task/dIBcVioaQ4euf9QHhWUnpg/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/ca9ca85dc0f7e9f706a95ad52b289a04437f810d28172b19d3bfe54517bea2f7b42069650490e2abe3cbe8776dfeb97437b955b6da2a1f2d74aac2fa7735ea97", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2ccd3cb7f981fe3cd3c69ccb4afbeb9253e511492f54bbbbea1ab6c70bc5e0e4da9c44e6ed45b5978d4073cc68381f3eabb875bd2b134f27b4ad5956b7224149"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-19 06:43:12.972213) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 06:43:12.972537) ========= 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.40Ie1x7dxP/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.mqQaTJBH2U/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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.005324 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 06:43:13.021344) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-19 06:43:13.021689) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-19 06:43:13.022098) ========= ========= Total master_lag: 1.02 =========