builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0136 starttime: 1454676925.09 results: success (0) buildid: 20160205025613 builduid: b8c1176441f04e338cf95f72129e9b22 revision: 522c4736df761986d42115e26e9b04897e6402c1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-05 04:55:25.095134) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-05 04:55:25.095638) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-05 04:55:25.095979) ========= 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.4sxm4UcnHf/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.vIRSkljFCA/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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.005802 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-05 04:55:25.118483) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-05 04:55:25.118814) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-05 04:55:25.133911) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-05 04:55:25.134229) ========= 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.4sxm4UcnHf/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.vIRSkljFCA/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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.005329 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-05 04:55:25.182989) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-05 04:55:25.183331) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-05 04:55:25.183807) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-05 04:55:25.184157) ========= 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.4sxm4UcnHf/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.vIRSkljFCA/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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-05 04:55:25-- 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% 49.9M=0s 2016-02-05 04:55:25 (49.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125802 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-05 04:55:25.326393) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-05 04:55:25.326775) ========= 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.4sxm4UcnHf/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.vIRSkljFCA/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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.020025 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-05 04:55:25.376746) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-05 04:55:25.377145) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 522c4736df761986d42115e26e9b04897e6402c1 --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 522c4736df761986d42115e26e9b04897e6402c1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4sxm4UcnHf/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.vIRSkljFCA/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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-05 04:55:25,732 truncating revision to first 12 chars 2016-02-05 04:55:25,732 Setting DEBUG logging. 2016-02-05 04:55:25,732 attempt 1/10 2016-02-05 04:55:25,732 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/522c4736df76?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-05 04:55:26,664 unpacking tar archive at: fx-team-522c4736df76/testing/mozharness/ program finished with exit code 0 elapsedTime=1.180272 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-05 04:55:26.573709) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-05 04:55:26.574124) ========= echo 522c4736df761986d42115e26e9b04897e6402c1 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'522c4736df761986d42115e26e9b04897e6402c1'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4sxm4UcnHf/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.vIRSkljFCA/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 522c4736df761986d42115e26e9b04897e6402c1 program finished with exit code 0 elapsedTime=0.005685 script_repo_revision: '522c4736df761986d42115e26e9b04897e6402c1' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-05 04:55:26.625967) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-05 04:55:26.626730) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-05 04:55:26.642824) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-02-05 04:55:26.643158) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4sxm4UcnHf/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.vIRSkljFCA/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 04:55:27 INFO - MultiFileLogger online at 20160205 04:55:27 in /builds/slave/test 04:55:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 04:55:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:55:27 INFO - {'append_to_log': False, 04:55:27 INFO - 'base_work_dir': '/builds/slave/test', 04:55:27 INFO - 'blob_upload_branch': 'Fx-Team', 04:55:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:55:27 INFO - 'branch': 'Fx-Team', 04:55:27 INFO - 'buildbot_json_path': 'buildprops.json', 04:55:27 INFO - 'config_files': ('talos/mac_config.py',), 04:55:27 INFO - 'default_actions': ('clobber', 04:55:27 INFO - 'read-buildbot-config', 04:55:27 INFO - 'download-and-extract', 04:55:27 INFO - 'populate-webroot', 04:55:27 INFO - 'create-virtualenv', 04:55:27 INFO - 'install', 04:55:27 INFO - 'run-tests'), 04:55:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:55:27 INFO - 'download_minidump_stackwalk': True, 04:55:27 INFO - 'download_symbols': 'ondemand', 04:55:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:55:27 INFO - 'tooltool.py': '/tools/tooltool.py', 04:55:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:55:27 INFO - '/tools/misc-python/virtualenv.py')}, 04:55:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:55:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:55:27 INFO - 'installer_path': 'installer.exe', 04:55:27 INFO - 'log_level': 'info', 04:55:27 INFO - 'log_name': 'talos', 04:55:27 INFO - 'log_to_console': True, 04:55:27 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:55:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:55:27 INFO - 'opt_config_files': (), 04:55:27 INFO - 'pip_index': False, 04:55:27 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:55:27 INFO - 'cmd': ('bash', 04:55:27 INFO - '-c', 04:55:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:55:27 INFO - 'enabled': True, 04:55:27 INFO - 'halt_on_failure': False, 04:55:27 INFO - 'name': 'check_screen_resolution'},), 04:55:27 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:55:27 INFO - 'cmd': ('bash', 04:55:27 INFO - '-c', 04:55:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:55:27 INFO - 'enabled': True, 04:55:27 INFO - 'halt_on_failure': False, 04:55:27 INFO - 'name': 'check_screen_resolution'},), 04:55:27 INFO - 'run_cmd_checks_enabled': True, 04:55:27 INFO - 'sps_profile': False, 04:55:27 INFO - 'sps_profile_interval': 0, 04:55:27 INFO - 'suite': 'dromaeojs', 04:55:27 INFO - 'system_bits': '32', 04:55:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:55:27 INFO - 'title': 't-yosemite-r7-0136', 04:55:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:55:27 INFO - 'use_talos_json': True, 04:55:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:55:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:55:27 INFO - 'work_dir': 'build'} 04:55:27 INFO - ##### 04:55:27 INFO - ##### Running clobber step. 04:55:27 INFO - ##### 04:55:27 INFO - Running pre-action listener: _resource_record_pre_action 04:55:27 INFO - Running main action method: clobber 04:55:27 INFO - rmtree: /builds/slave/test/build 04:55:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:55:28 INFO - Running post-action listener: _resource_record_post_action 04:55:28 INFO - ##### 04:55:28 INFO - ##### Running read-buildbot-config step. 04:55:28 INFO - ##### 04:55:28 INFO - Running pre-action listener: _resource_record_pre_action 04:55:28 INFO - Running main action method: read_buildbot_config 04:55:28 INFO - Using buildbot properties: 04:55:28 INFO - { 04:55:28 INFO - "project": "", 04:55:28 INFO - "product": "firefox", 04:55:28 INFO - "script_repo_revision": "production", 04:55:28 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 04:55:28 INFO - "repository": "", 04:55:28 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 04:55:28 INFO - "buildid": "20160205025613", 04:55:28 INFO - "pgo_build": "False", 04:55:28 INFO - "basedir": "/builds/slave/test", 04:55:28 INFO - "buildnumber": 322, 04:55:28 INFO - "slavename": "t-yosemite-r7-0136", 04:55:28 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 04:55:28 INFO - "platform": "yosemite_r7", 04:55:28 INFO - "scheduler": "tests-fx-team-macosx64-talos", 04:55:28 INFO - "branch": "fx-team", 04:55:28 INFO - "repo_path": "integration/fx-team", 04:55:28 INFO - "revision": "522c4736df761986d42115e26e9b04897e6402c1", 04:55:28 INFO - "stage_platform": "macosx64", 04:55:28 INFO - "builduid": "b8c1176441f04e338cf95f72129e9b22", 04:55:28 INFO - "slavebuilddir": "test" 04:55:28 INFO - } 04:55:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/a4faPleuRCWCJf3q-BupRQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 04:55:28 INFO - Running post-action listener: _resource_record_post_action 04:55:28 INFO - ##### 04:55:28 INFO - ##### Running download-and-extract step. 04:55:28 INFO - ##### 04:55:28 INFO - Running pre-action listener: _resource_record_pre_action 04:55:28 INFO - Running main action method: download_and_extract 04:55:28 INFO - mkdir: /builds/slave/test/build/tests 04:55:28 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')]} 04:55:28 INFO - https://queue.taskcluster.net/v1/task/a4faPleuRCWCJf3q-BupRQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:55:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a4faPleuRCWCJf3q-BupRQ/artifacts/public/build/test_packages.json 04:55:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a4faPleuRCWCJf3q-BupRQ/artifacts/public/build/test_packages.json 04:55:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a4faPleuRCWCJf3q-BupRQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:55:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a4faPleuRCWCJf3q-BupRQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:55:29 INFO - Downloaded 1277 bytes. 04:55:29 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:55:29 INFO - Using the following test package requirements: 04:55:29 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:55:29 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:55:29 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 04:55:29 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:55:29 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 04:55:29 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:55:29 INFO - u'jsshell-mac.zip'], 04:55:29 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:55:29 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 04:55:29 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:55:29 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:55:29 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 04:55:29 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:55:29 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 04:55:29 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:55:29 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 04:55:29 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:55:29 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:55:29 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 04:55:29 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:55:29 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')]} 04:55:29 INFO - https://queue.taskcluster.net/v1/task/a4faPleuRCWCJf3q-BupRQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:55:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a4faPleuRCWCJf3q-BupRQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:55:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a4faPleuRCWCJf3q-BupRQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:55:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a4faPleuRCWCJf3q-BupRQ/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 04:55:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a4faPleuRCWCJf3q-BupRQ/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 04:55:30 INFO - Downloaded 17745894 bytes. 04:55:30 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'] 04:55:30 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 04:55:33 INFO - Return code: 0 04:55:33 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 04:55: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')]} 04:55:33 INFO - https://queue.taskcluster.net/v1/task/a4faPleuRCWCJf3q-BupRQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:55:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a4faPleuRCWCJf3q-BupRQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:55:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a4faPleuRCWCJf3q-BupRQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:55:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a4faPleuRCWCJf3q-BupRQ/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 04:55:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a4faPleuRCWCJf3q-BupRQ/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 04:55:35 INFO - Downloaded 17745894 bytes. 04:55:35 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'] 04:55:35 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 04:55:39 INFO - Return code: 0 04:55:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:39 INFO - https://queue.taskcluster.net/v1/task/a4faPleuRCWCJf3q-BupRQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:55:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a4faPleuRCWCJf3q-BupRQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 04:55:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a4faPleuRCWCJf3q-BupRQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 04:55:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a4faPleuRCWCJf3q-BupRQ/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 04:55:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a4faPleuRCWCJf3q-BupRQ/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 04:55:40 INFO - Downloaded 10706547 bytes. 04:55:40 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'] 04:55:40 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 04:55:40 INFO - Return code: 0 04:55:40 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')]} 04:55:40 INFO - https://queue.taskcluster.net/v1/task/a4faPleuRCWCJf3q-BupRQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:55:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a4faPleuRCWCJf3q-BupRQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:55:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a4faPleuRCWCJf3q-BupRQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:55:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a4faPleuRCWCJf3q-BupRQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 04:55:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a4faPleuRCWCJf3q-BupRQ/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 04:55:43 INFO - Downloaded 111799732 bytes. 04:55:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a4faPleuRCWCJf3q-BupRQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:55:43 INFO - mkdir: /builds/slave/test/properties 04:55:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:55:43 INFO - Writing to file /builds/slave/test/properties/build_url 04:55:43 INFO - Contents: 04:55:43 INFO - build_url:https://queue.taskcluster.net/v1/task/a4faPleuRCWCJf3q-BupRQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:55:44 INFO - Running post-action listener: _resource_record_post_action 04:55:44 INFO - Running post-action listener: set_extra_try_arguments 04:55:44 INFO - ##### 04:55:44 INFO - ##### Running populate-webroot step. 04:55:44 INFO - ##### 04:55:44 INFO - Running pre-action listener: _resource_record_pre_action 04:55:44 INFO - Running main action method: populate_webroot 04:55:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:55:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:55:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:55:44 INFO - '--tppagecycles', 04:55:44 INFO - '7'], 04:55:44 INFO - 'tests': ['tsvgm']}}, 04:55:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:55:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:55:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:55:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:55:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:55:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:55:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:55:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:55:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:55:44 INFO - 'talos_options': ['--e10s'], 04:55:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:55:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:55:44 INFO - 'tests': ['damp', 'tps']}, 04:55:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:55:44 INFO - 'talos_options': ['--e10s'], 04:55:44 INFO - 'tests': ['damp', 'tps']}, 04:55:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:55:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:55:44 INFO - 'other': {'tests': ['a11yr', 04:55:44 INFO - 'ts_paint', 04:55:44 INFO - 'tpaint', 04:55:44 INFO - 'sessionrestore', 04:55:44 INFO - 'sessionrestore_no_auto_restore']}, 04:55:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:55:44 INFO - 'tests': ['a11yr', 04:55:44 INFO - 'ts_paint', 04:55:44 INFO - 'tpaint', 04:55:44 INFO - 'sessionrestore', 04:55:44 INFO - 'sessionrestore_no_auto_restore']}, 04:55:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:55:44 INFO - 'tests': ['a11yr', 04:55:44 INFO - 'ts_paint', 04:55:44 INFO - 'tpaint', 04:55:44 INFO - 'sessionrestore', 04:55:44 INFO - 'sessionrestore_no_auto_restore']}, 04:55:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:55:44 INFO - 'tests': ['a11yr', 04:55:44 INFO - 'ts_paint', 04:55:44 INFO - 'tpaint', 04:55:44 INFO - 'sessionrestore', 04:55:44 INFO - 'sessionrestore_no_auto_restore']}, 04:55:44 INFO - 'other_l64': {'tests': ['a11yr', 04:55:44 INFO - 'ts_paint', 04:55:44 INFO - 'tpaint', 04:55:44 INFO - 'sessionrestore', 04:55:44 INFO - 'sessionrestore_no_auto_restore']}, 04:55:44 INFO - 'other_nol64': {'tests': ['a11yr', 04:55:44 INFO - 'ts_paint', 04:55:44 INFO - 'tpaint', 04:55:44 INFO - 'sessionrestore', 04:55:44 INFO - 'sessionrestore_no_auto_restore']}, 04:55:44 INFO - 'svgr': {'tests': ['tsvgx', 04:55:44 INFO - 'tsvgr_opacity', 04:55:44 INFO - 'tart', 04:55:44 INFO - 'tscrollx', 04:55:44 INFO - 'cart']}, 04:55:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:55:44 INFO - 'tests': ['tsvgx', 04:55:44 INFO - 'tsvgr_opacity', 04:55:44 INFO - 'tart', 04:55:44 INFO - 'tscrollx', 04:55:44 INFO - 'cart']}, 04:55:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:55:44 INFO - 'tests': ['tp5o']}, 04:55:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:55:44 INFO - 'talos_options': ['--e10s'], 04:55:44 INFO - 'tests': ['tp5o']}, 04:55:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:55:44 INFO - 'talos_options': ['--xperf_path', 04:55:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:55:44 INFO - 'tests': ['tp5n']}, 04:55:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:55:44 INFO - 'talos_options': ['--e10s', 04:55:44 INFO - '--xperf_path', 04:55:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:55:44 INFO - 'tests': ['tp5n']}}, 04:55:44 INFO - 'talos.zip': {'path': '', 04:55:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:55:44 INFO - Running post-action listener: _resource_record_post_action 04:55:44 INFO - ##### 04:55:44 INFO - ##### Running create-virtualenv step. 04:55:44 INFO - ##### 04:55:44 INFO - Running pre-action listener: _resource_record_pre_action 04:55:44 INFO - Running main action method: create_virtualenv 04:55:44 INFO - Creating virtualenv /builds/slave/test/build/venv 04:55:44 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 04:55:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:55:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:55:44 INFO - Using real prefix '/tools/python27' 04:55:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:55:45 INFO - Installing distribute.............................................................................................................................................................................................done. 04:55:48 INFO - Installing pip.................done. 04:55:48 INFO - Return code: 0 04:55:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:55:48 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')]} 04:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:48 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')]} 04:55:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:48 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 0x106a6ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a734c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd89c92990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106911d30>, '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 0x106734db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106907b20>, '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.4sxm4UcnHf/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.vIRSkljFCA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 04:55:48 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 04:55:48 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 04:55:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4sxm4UcnHf/Render', 04:55:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:55:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:55:48 INFO - 'HOME': '/Users/cltbld', 04:55:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:55:48 INFO - 'LOGNAME': 'cltbld', 04:55:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:48 INFO - 'MOZ_NO_REMOTE': '1', 04:55:48 INFO - 'NO_EM_RESTART': '1', 04:55:48 INFO - 'PAGER': '/bin/cat', 04:55:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:55:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:48 INFO - 'PWD': '/builds/slave/test', 04:55:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:55:48 INFO - 'SHELL': '/bin/bash', 04:55:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vIRSkljFCA/Listeners', 04:55:48 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 04:55:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:55:48 INFO - 'USER': 'cltbld', 04:55:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:55:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:55:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:48 INFO - 'XPC_FLAGS': '0x0', 04:55:48 INFO - 'XPC_SERVICE_NAME': '0', 04:55:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:55:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:48 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 04:55:48 INFO - Cleaning up... 04:55:48 INFO - Return code: 0 04:55:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:55:48 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')]} 04:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:48 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')]} 04:55:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:48 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 0x106a6ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a734c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd89c92990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106911d30>, '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 0x106734db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106907b20>, '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.4sxm4UcnHf/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.vIRSkljFCA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 04:55:48 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 04:55:48 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 04:55:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4sxm4UcnHf/Render', 04:55:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:55:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:55:48 INFO - 'HOME': '/Users/cltbld', 04:55:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:55:48 INFO - 'LOGNAME': 'cltbld', 04:55:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:48 INFO - 'MOZ_NO_REMOTE': '1', 04:55:48 INFO - 'NO_EM_RESTART': '1', 04:55:48 INFO - 'PAGER': '/bin/cat', 04:55:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:55:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:48 INFO - 'PWD': '/builds/slave/test', 04:55:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:55:48 INFO - 'SHELL': '/bin/bash', 04:55:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vIRSkljFCA/Listeners', 04:55:48 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 04:55:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:55:48 INFO - 'USER': 'cltbld', 04:55:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:55:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:55:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:48 INFO - 'XPC_FLAGS': '0x0', 04:55:48 INFO - 'XPC_SERVICE_NAME': '0', 04:55:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:55:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:48 INFO - Downloading/unpacking psutil>=0.7.1 04:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:55:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:55:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:55:51 INFO - Installing collected packages: psutil 04:55:51 INFO - Running setup.py install for psutil 04:55:51 INFO - building 'psutil._psutil_osx' extension 04:55:51 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 04:55:51 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 04:55:51 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 04:55:51 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 04:55:51 INFO - building 'psutil._psutil_posix' extension 04:55:51 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 04:55:51 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:55:51 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:55:51 INFO - ^ 04:55:51 INFO - 1 warning generated. 04:55:51 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 04:55:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:55:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:55:51 INFO - Successfully installed psutil 04:55:51 INFO - Cleaning up... 04:55:51 INFO - Return code: 0 04:55:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:55:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106a6ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a734c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd89c92990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106911d30>, '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 0x106734db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106907b20>, '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.4sxm4UcnHf/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.vIRSkljFCA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 04:55:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:55:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:55:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4sxm4UcnHf/Render', 04:55:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:55:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:55:51 INFO - 'HOME': '/Users/cltbld', 04:55:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:55:51 INFO - 'LOGNAME': 'cltbld', 04:55:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:51 INFO - 'MOZ_NO_REMOTE': '1', 04:55:51 INFO - 'NO_EM_RESTART': '1', 04:55:51 INFO - 'PAGER': '/bin/cat', 04:55:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:55:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:51 INFO - 'PWD': '/builds/slave/test', 04:55:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:55:51 INFO - 'SHELL': '/bin/bash', 04:55:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vIRSkljFCA/Listeners', 04:55:51 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 04:55:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:55:51 INFO - 'USER': 'cltbld', 04:55:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:55:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:55:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:51 INFO - 'XPC_FLAGS': '0x0', 04:55:51 INFO - 'XPC_SERVICE_NAME': '0', 04:55:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:55:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:55: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 04:55: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 04:55: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 04:55: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 04:55: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 04:55: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 04:55:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:55:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:55:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:55:54 INFO - Installing collected packages: mozsystemmonitor 04:55:54 INFO - Running setup.py install for mozsystemmonitor 04:55:54 INFO - Successfully installed mozsystemmonitor 04:55:54 INFO - Cleaning up... 04:55:54 INFO - Return code: 0 04:55:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:55:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:54 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 0x106a6ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a734c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd89c92990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106911d30>, '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 0x106734db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106907b20>, '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.4sxm4UcnHf/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.vIRSkljFCA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 04:55:54 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 04:55:54 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 04:55:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4sxm4UcnHf/Render', 04:55:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:55:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:55:54 INFO - 'HOME': '/Users/cltbld', 04:55:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:55:54 INFO - 'LOGNAME': 'cltbld', 04:55:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:54 INFO - 'MOZ_NO_REMOTE': '1', 04:55:54 INFO - 'NO_EM_RESTART': '1', 04:55:54 INFO - 'PAGER': '/bin/cat', 04:55:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:55:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:54 INFO - 'PWD': '/builds/slave/test', 04:55:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:55:54 INFO - 'SHELL': '/bin/bash', 04:55:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vIRSkljFCA/Listeners', 04:55:54 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 04:55:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:55:54 INFO - 'USER': 'cltbld', 04:55:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:55:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:55:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:54 INFO - 'XPC_FLAGS': '0x0', 04:55:54 INFO - 'XPC_SERVICE_NAME': '0', 04:55:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:55:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:55 INFO - Downloading/unpacking blobuploader==1.2.4 04:55:55 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 04:55:55 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 04:55:55 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 04:55:55 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 04:55:55 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 04:55:55 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 04:55:57 INFO - Downloading blobuploader-1.2.4.tar.gz 04:55:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:55:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:55:57 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 04:55:57 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 04:55:57 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 04:55:57 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 04:55:57 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 04:55:57 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 04:55:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:55:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:55: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 04:55: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 04:55: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 04:55: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 04:55: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 04:55: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 04:55:58 INFO - Downloading docopt-0.6.1.tar.gz 04:55:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:55:58 INFO - Installing collected packages: blobuploader, requests, docopt 04:55:58 INFO - Running setup.py install for blobuploader 04:55:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:55:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:55:58 INFO - Running setup.py install for requests 04:55:59 INFO - Running setup.py install for docopt 04:55:59 INFO - Successfully installed blobuploader requests docopt 04:55:59 INFO - Cleaning up... 04:55:59 INFO - Return code: 0 04:55:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:55: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')]} 04:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55: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')]} 04:55:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:59 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 0x106a6ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a734c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd89c92990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106911d30>, '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 0x106734db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106907b20>, '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.4sxm4UcnHf/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.vIRSkljFCA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 04:55:59 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 04:55:59 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 04:55:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4sxm4UcnHf/Render', 04:55:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:55:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:55:59 INFO - 'HOME': '/Users/cltbld', 04:55:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:55:59 INFO - 'LOGNAME': 'cltbld', 04:55:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:59 INFO - 'MOZ_NO_REMOTE': '1', 04:55:59 INFO - 'NO_EM_RESTART': '1', 04:55:59 INFO - 'PAGER': '/bin/cat', 04:55:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:55:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:59 INFO - 'PWD': '/builds/slave/test', 04:55:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:55:59 INFO - 'SHELL': '/bin/bash', 04:55:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vIRSkljFCA/Listeners', 04:55:59 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 04:55:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:55:59 INFO - 'USER': 'cltbld', 04:55:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:55:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:55:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:59 INFO - 'XPC_FLAGS': '0x0', 04:55:59 INFO - 'XPC_SERVICE_NAME': '0', 04:55:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:55:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:55:59 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-MrZGeX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:55:59 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-UYVMfJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:55:59 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-zEpzIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:56:00 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-mKuWad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:56:00 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-39hWZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:56:00 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-Z4N7aV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:56:00 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-3xbBll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:56:00 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-sUaFco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:56:00 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-GRAOnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:56:00 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-Pf_vPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:56:00 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-c6uD2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:56:00 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-P_LP8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:56:00 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-SyfpUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:56:01 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-LqEZZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:56:01 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-EGwtwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:56:01 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-fFRz1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:56:01 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-9O5XvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:56:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:56:01 INFO - Running setup.py install for manifestparser 04:56:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:56:01 INFO - Running setup.py install for mozcrash 04:56:01 INFO - Running setup.py install for mozdebug 04:56:01 INFO - Running setup.py install for mozdevice 04:56:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:56:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:56:02 INFO - Running setup.py install for mozfile 04:56:02 INFO - Running setup.py install for mozhttpd 04:56:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:56:02 INFO - Running setup.py install for mozinfo 04:56:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:56:02 INFO - Running setup.py install for mozInstall 04:56:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:56:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:56:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:56:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:56:02 INFO - Running setup.py install for mozleak 04:56:02 INFO - Running setup.py install for mozlog 04:56:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:56:02 INFO - Running setup.py install for moznetwork 04:56:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:56:03 INFO - Running setup.py install for mozprocess 04:56:03 INFO - Running setup.py install for mozprofile 04:56:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:56:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:56:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:56:03 INFO - Running setup.py install for mozrunner 04:56:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:56:03 INFO - Running setup.py install for mozscreenshot 04:56:03 INFO - Running setup.py install for moztest 04:56:03 INFO - Running setup.py install for mozversion 04:56:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:56:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:56:04 INFO - Cleaning up... 04:56:04 INFO - Return code: 0 04:56:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:56:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:04 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 0x106a6ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a734c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd89c92990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106911d30>, '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 0x106734db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106907b20>, '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.4sxm4UcnHf/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.vIRSkljFCA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 04:56:04 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 04:56:04 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 04:56:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4sxm4UcnHf/Render', 04:56:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:04 INFO - 'HOME': '/Users/cltbld', 04:56:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:04 INFO - 'LOGNAME': 'cltbld', 04:56:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:04 INFO - 'MOZ_NO_REMOTE': '1', 04:56:04 INFO - 'NO_EM_RESTART': '1', 04:56:04 INFO - 'PAGER': '/bin/cat', 04:56:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:04 INFO - 'PWD': '/builds/slave/test', 04:56:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:04 INFO - 'SHELL': '/bin/bash', 04:56:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vIRSkljFCA/Listeners', 04:56:04 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 04:56:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:04 INFO - 'USER': 'cltbld', 04:56:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:04 INFO - 'XPC_FLAGS': '0x0', 04:56:04 INFO - 'XPC_SERVICE_NAME': '0', 04:56:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:56:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:56:04 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-U8Frt9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:56:04 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)) 04:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:56:04 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-0DEOHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:56:04 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)) 04:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:56:04 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-Tt0tMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:56:04 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)) 04:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:56:04 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-vvW8V3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:56:04 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)) 04:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:56:04 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-JjGAvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:56:04 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)) 04:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:56:04 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-kqOmbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:56:04 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)) 04:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:56:04 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-qLCjd5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:56:05 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)) 04:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:56:05 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-eovlSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:56:05 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)) 04:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:56:05 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-cidLJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:56:05 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)) 04:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:56:05 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-20SiWC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:56:05 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)) 04:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:56:05 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-UIBH7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:56:05 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)) 04:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:56:05 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-u3fL6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:56:05 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)) 04:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:56:05 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-9bUuod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:56:05 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)) 04:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:56:05 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-YJwjSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:56:05 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)) 04:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:56:05 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-88PAyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:56:05 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)) 04:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:56:05 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-roDFah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:56:06 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)) 04:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:56:06 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-ZAGmIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:56:06 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)) 04:56:06 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)) 04:56:06 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)) 04:56:06 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)) 04:56:06 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)) 04:56:06 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)) 04:56:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:08 INFO - Downloading blessings-1.6.tar.gz 04:56:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:56:08 INFO - Installing collected packages: blessings 04:56:08 INFO - Running setup.py install for blessings 04:56:08 INFO - Successfully installed blessings 04:56:08 INFO - Cleaning up... 04:56:08 INFO - Return code: 0 04:56:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:56:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:56:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:56:09 INFO - Reading from file tmpfile_stdout 04:56:09 INFO - Current package versions: 04:56:09 INFO - blessings == 1.6 04:56:09 INFO - blobuploader == 1.2.4 04:56:09 INFO - docopt == 0.6.1 04:56:09 INFO - manifestparser == 1.1 04:56:09 INFO - mozInstall == 1.12 04:56:09 INFO - mozcrash == 0.16 04:56:09 INFO - mozdebug == 0.1 04:56:09 INFO - mozdevice == 0.48 04:56:09 INFO - mozfile == 1.2 04:56:09 INFO - mozhttpd == 0.7 04:56:09 INFO - mozinfo == 0.9 04:56:09 INFO - mozleak == 0.1 04:56:09 INFO - mozlog == 3.1 04:56:09 INFO - moznetwork == 0.27 04:56:09 INFO - mozprocess == 0.22 04:56:09 INFO - mozprofile == 0.28 04:56:09 INFO - mozrunner == 6.11 04:56:09 INFO - mozscreenshot == 0.1 04:56:09 INFO - mozsystemmonitor == 0.0 04:56:09 INFO - moztest == 0.7 04:56:09 INFO - mozversion == 1.4 04:56:09 INFO - psutil == 3.1.1 04:56:09 INFO - requests == 1.2.3 04:56:09 INFO - wsgiref == 0.1.2 04:56:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:56:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:09 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 0x106a6ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a734c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd89c92990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106911d30>, '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 0x106734db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106907b20>, '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.4sxm4UcnHf/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.vIRSkljFCA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 04:56:09 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 04:56:09 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 04:56:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4sxm4UcnHf/Render', 04:56:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:09 INFO - 'HOME': '/Users/cltbld', 04:56:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:09 INFO - 'LOGNAME': 'cltbld', 04:56:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:09 INFO - 'MOZ_NO_REMOTE': '1', 04:56:09 INFO - 'NO_EM_RESTART': '1', 04:56:09 INFO - 'PAGER': '/bin/cat', 04:56:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:09 INFO - 'PWD': '/builds/slave/test', 04:56:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:09 INFO - 'SHELL': '/bin/bash', 04:56:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vIRSkljFCA/Listeners', 04:56:09 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 04:56:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:09 INFO - 'USER': 'cltbld', 04:56:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:09 INFO - 'XPC_FLAGS': '0x0', 04:56:09 INFO - 'XPC_SERVICE_NAME': '0', 04:56:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:56:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:09 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)) 04:56:09 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)) 04:56:09 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)) 04:56:09 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)) 04:56:09 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)) 04:56:09 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)) 04:56:09 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)) 04:56:09 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)) 04:56:09 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)) 04:56:09 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)) 04:56:09 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)) 04:56:09 INFO - Cleaning up... 04:56:09 INFO - Return code: 0 04:56:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:56:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:09 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 0x106a6ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a734c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd89c92990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106911d30>, '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 0x106734db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106907b20>, '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.4sxm4UcnHf/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.vIRSkljFCA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 04:56:09 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 04:56:09 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 04:56:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4sxm4UcnHf/Render', 04:56:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:09 INFO - 'HOME': '/Users/cltbld', 04:56:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:09 INFO - 'LOGNAME': 'cltbld', 04:56:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:09 INFO - 'MOZ_NO_REMOTE': '1', 04:56:09 INFO - 'NO_EM_RESTART': '1', 04:56:09 INFO - 'PAGER': '/bin/cat', 04:56:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:09 INFO - 'PWD': '/builds/slave/test', 04:56:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:09 INFO - 'SHELL': '/bin/bash', 04:56:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vIRSkljFCA/Listeners', 04:56:09 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 04:56:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:09 INFO - 'USER': 'cltbld', 04:56:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:09 INFO - 'XPC_FLAGS': '0x0', 04:56:09 INFO - 'XPC_SERVICE_NAME': '0', 04:56:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:56:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:09 INFO - Downloading/unpacking jsonschema 04:56:09 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 04:56:09 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 04:56:09 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 04:56:09 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 04:56:09 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 04:56:09 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 04:56:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:56:11 INFO - Downloading/unpacking functools32 (from jsonschema) 04:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:12 INFO - Downloading functools32-3.2.3-2.tar.gz 04:56:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:56:12 INFO - warning: no files found matching '*.txt' 04:56:12 INFO - no previously-included directories found matching 'build' 04:56:12 INFO - no previously-included directories found matching 'dist' 04:56:12 INFO - no previously-included directories found matching '.git*' 04:56:12 INFO - Installing collected packages: jsonschema, functools32 04:56:12 INFO - Running setup.py install for functools32 04:56:12 INFO - warning: no files found matching '*.txt' 04:56:12 INFO - no previously-included directories found matching 'build' 04:56:12 INFO - no previously-included directories found matching 'dist' 04:56:12 INFO - no previously-included directories found matching '.git*' 04:56:12 INFO - Successfully installed jsonschema functools32 04:56:12 INFO - Cleaning up... 04:56:12 INFO - Return code: 0 04:56:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:56:12 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')]} 04:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:12 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')]} 04:56:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:12 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 0x106a6ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a734c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd89c92990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106911d30>, '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 0x106734db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106907b20>, '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.4sxm4UcnHf/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.vIRSkljFCA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 04:56:12 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 04:56:12 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 04:56:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4sxm4UcnHf/Render', 04:56:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:12 INFO - 'HOME': '/Users/cltbld', 04:56:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:12 INFO - 'LOGNAME': 'cltbld', 04:56:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:12 INFO - 'MOZ_NO_REMOTE': '1', 04:56:12 INFO - 'NO_EM_RESTART': '1', 04:56:12 INFO - 'PAGER': '/bin/cat', 04:56:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:12 INFO - 'PWD': '/builds/slave/test', 04:56:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:12 INFO - 'SHELL': '/bin/bash', 04:56:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vIRSkljFCA/Listeners', 04:56:12 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 04:56:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:12 INFO - 'USER': 'cltbld', 04:56:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:12 INFO - 'XPC_FLAGS': '0x0', 04:56:12 INFO - 'XPC_SERVICE_NAME': '0', 04:56:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:56:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:12 INFO - Downloading/unpacking flake8 04:56:12 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 04:56:12 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 04:56:12 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 04:56:12 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 04:56:12 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 04:56:12 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 04:56:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:56:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:56:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:56:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:56:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:56:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:56:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:56:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:56:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:56:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:56:16 INFO - no previously-included directories found matching 'docs/_build' 04:56:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:56:16 INFO - Running setup.py install for pep8 04:56:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:56:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:56:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:56:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:56:16 INFO - no previously-included directories found matching 'docs/_build' 04:56:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:56:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:56:16 INFO - Cleaning up... 04:56:16 INFO - Return code: 0 04:56:16 INFO - Running post-action listener: _resource_record_post_action 04:56:16 INFO - Running post-action listener: _start_resource_monitoring 04:56:16 INFO - Starting resource monitoring. 04:56:16 INFO - ##### 04:56:16 INFO - ##### Running install step. 04:56:16 INFO - ##### 04:56:16 INFO - Running pre-action listener: _resource_record_pre_action 04:56:16 INFO - Running main action method: install 04:56:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:56:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:56:17 INFO - Reading from file tmpfile_stdout 04:56:17 INFO - Detecting whether we're running mozinstall >=1.0... 04:56:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:56:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:56:17 INFO - Reading from file tmpfile_stdout 04:56:17 INFO - Output received: 04:56:17 INFO - Usage: mozinstall [options] installer 04:56:17 INFO - Options: 04:56:17 INFO - -h, --help show this help message and exit 04:56:17 INFO - -d DEST, --destination=DEST 04:56:17 INFO - Directory to install application into. [default: 04:56:17 INFO - "/builds/slave/test"] 04:56:17 INFO - --app=APP Application being installed. [default: firefox] 04:56:17 INFO - mkdir: /builds/slave/test/build/application 04:56:17 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'] 04:56:17 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 04:56:51 INFO - Reading from file tmpfile_stdout 04:56:51 INFO - Output received: 04:56:51 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:56:51 INFO - Running post-action listener: _resource_record_post_action 04:56:51 INFO - ##### 04:56:51 INFO - ##### Running run-tests step. 04:56:51 INFO - ##### 04:56:51 INFO - Running pre-action listener: _resource_record_pre_action 04:56:51 INFO - Running main action method: run_tests 04:56:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:56:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:56:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:56:51 INFO - 2016-02-05 04:56:51.267 screenresolution[6833:115180] starting screenresolution argv=screenresolution get 04:56:51 INFO - 2016-02-05 04:56:51.270 screenresolution[6833:115180] Display 0: 1600x1200x32@60 04:56:51 INFO - 2016-02-05 04:56:51.276 screenresolution[6834:115183] starting screenresolution argv=screenresolution list 04:56:51 INFO - Available Modes on Display 0 04:56:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:56:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:56:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:56:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:56:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:56:51 INFO - Intel Iris: 04:56:51 INFO - Chipset Model: Intel Iris 04:56:51 INFO - Type: GPU 04:56:51 INFO - Bus: Built-In 04:56:51 INFO - VRAM (Dynamic, Max): 1536 MB 04:56:51 INFO - Vendor: Intel (0x8086) 04:56:51 INFO - Device ID: 0x0a2e 04:56:51 INFO - Revision ID: 0x0009 04:56:51 INFO - Displays: 04:56:51 INFO - Display: 04:56:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:56:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:56:51 INFO - Display Serial Number: 1600x1200 60 04:56:51 INFO - Main Display: Yes 04:56:51 INFO - Mirror: Off 04:56:51 INFO - Online: Yes 04:56:51 INFO - Rotation: Supported 04:56:51 INFO - Return code: 0 04:56:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:56:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:56:51 INFO - Python 2.7.3 04:56:51 INFO - Return code: 0 04:56:51 INFO - grabbing minidump binary from tooltool 04:56:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:51 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 0x106911d30>, '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 0x106734db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106907b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:56:51 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 04:56:51 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 04:56:51 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:56:51 INFO - Return code: 0 04:56:51 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:56:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:56:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:56:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:56:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:56:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:56:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:56:52 INFO - Return code: 0 04:56:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a4faPleuRCWCJf3q-BupRQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0136', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:56:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/a4faPleuRCWCJf3q-BupRQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0136 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:56:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4sxm4UcnHf/Render', 04:56:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:52 INFO - 'HOME': '/Users/cltbld', 04:56:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:52 INFO - 'LOGNAME': 'cltbld', 04:56:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:56:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:56:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:52 INFO - 'MOZ_NO_REMOTE': '1', 04:56:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:56:52 INFO - 'NO_EM_RESTART': '1', 04:56:52 INFO - 'PAGER': '/bin/cat', 04:56:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:52 INFO - 'PWD': '/builds/slave/test', 04:56:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:56:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:52 INFO - 'SHELL': '/bin/bash', 04:56:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vIRSkljFCA/Listeners', 04:56:52 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 04:56:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:52 INFO - 'USER': 'cltbld', 04:56:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:52 INFO - 'XPC_FLAGS': '0x0', 04:56:52 INFO - 'XPC_SERVICE_NAME': '0', 04:56:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:56:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a4faPleuRCWCJf3q-BupRQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0136', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:56:53 INFO - mozversion application_buildid: 20160205025613 04:56:53 INFO - mozversion application_changeset: 522c4736df761986d42115e26e9b04897e6402c1 04:56:53 INFO - mozversion application_display_name: Nightly 04:56:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:56:53 INFO - mozversion application_name: Firefox 04:56:53 INFO - mozversion application_remotingname: firefox 04:56:53 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:56:53 INFO - mozversion application_vendor: Mozilla 04:56:53 INFO - mozversion application_version: 47.0a1 04:56:53 INFO - mozversion platform_buildid: 20160205025613 04:56:53 INFO - mozversion platform_changeset: 522c4736df761986d42115e26e9b04897e6402c1 04:56:53 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:56:53 INFO - mozversion platform_version: 47.0a1 04:56:53 INFO - using testdate: 1454677013 04:56:53 INFO - actual date: 1454677013 04:56:53 INFO - starting webserver on 'localhost:65208' 04:56:53 INFO - SUITE-START | Running 2 tests 04:56:53 INFO - TEST-START | dromaeo_css 04:56:53 INFO - operating with platform_type : mac_ 04:56:53 INFO - Initialising browser for dromaeo_css test... 04:56:53 INFO - TEST-INFO | started process 6852 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/tmpnwhsNH/profile http://localhost:65208/getInfo.html) 04:56:53 INFO - PROCESS | 6852 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 04:56:55 INFO - PROCESS | 6852 | __metrics Screen width/height:1600/1200 04:56:55 INFO - PROCESS | 6852 | colorDepth:24 04:56:55 INFO - PROCESS | 6852 | Browser inner width/height: 1024/689 04:56:55 INFO - PROCESS | 6852 | __metrics 04:56:55 INFO - PROCESS | 6852 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:56:55 INFO - PROCESS | 6852 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:56:56 INFO - TEST-INFO | 6852: exit 0 04:56:56 INFO - Browser initialized. 04:56:56 INFO - Running cycle 1/1 for dromaeo_css test... 04:56:56 INFO - TEST-INFO | started process 6855 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/tmpnwhsNH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:57:08 INFO - PROCESS | 6855 | RSS: Main: 245075968 04:57:08 INFO - PROCESS | 6855 | 04:58:04 INFO - PROCESS | 6855 | 1454677084471 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] 05:00:10 INFO - PROCESS | 6855 | Cycle 1(1): loaded http://localhost:65208/tests/dromaeo/cssquery-dojo.html (next: http://localhost:65208/tests/dromaeo/cssquery-ext.html) 05:00:12 INFO - PROCESS | 6855 | RSS: Main: 434618368 05:00:12 INFO - PROCESS | 6855 | 05:03:15 INFO - PROCESS | 6855 | Cycle 1(1): loaded http://localhost:65208/tests/dromaeo/cssquery-ext.html (next: http://localhost:65208/tests/dromaeo/cssquery-jquery.html) 05:03:15 INFO - PROCESS | 6855 | RSS: Main: 380276736 05:03:15 INFO - PROCESS | 6855 | 05:06:17 INFO - PROCESS | 6855 | Cycle 1(1): loaded http://localhost:65208/tests/dromaeo/cssquery-jquery.html (next: http://localhost:65208/tests/dromaeo/cssquery-mootools.html) 05:06:18 INFO - PROCESS | 6855 | RSS: Main: 379842560 05:06:18 INFO - PROCESS | 6855 | 05:09:20 INFO - PROCESS | 6855 | Cycle 1(1): loaded http://localhost:65208/tests/dromaeo/cssquery-mootools.html (next: http://localhost:65208/tests/dromaeo/cssquery-prototype.html) 05:09:21 INFO - PROCESS | 6855 | RSS: Main: 352940032 05:09:21 INFO - PROCESS | 6855 | 05:12:24 INFO - PROCESS | 6855 | Cycle 1(1): loaded http://localhost:65208/tests/dromaeo/cssquery-prototype.html (next: http://localhost:65208/tests/dromaeo/cssquery-yui.html) 05:12:25 INFO - PROCESS | 6855 | RSS: Main: 352931840 05:12:25 INFO - PROCESS | 6855 | 05:15:27 INFO - PROCESS | 6855 | Cycle 1(1): loaded http://localhost:65208/tests/dromaeo/cssquery-yui.html (next: http://localhost:65208/tests/dromaeo/cssquery-dojo.html) 05:15:28 INFO - PROCESS | 6855 | RSS: Main: 421064704 05:15:28 INFO - PROCESS | 6855 | 05:15:28 INFO - PROCESS | 6855 | __start_tp_report 05:15:28 INFO - PROCESS | 6855 | _x_x_mozilla_page_load 05:15:28 INFO - PROCESS | 6855 | _x_x_mozilla_page_load_details 05:15:28 INFO - PROCESS | 6855 | |i|pagename|runs| 05:15:28 INFO - PROCESS | 6855 | |0;dojo.html;3396.5754280714905;3443.6728510791468;3468.323676883009;3472.843722032509;3517.4547945068507;5670.432956704328;5737.770489180428;5761.337446193684;5764.250647415835;5771.913421298684;5648.378678345389;5710.600257981943;5717.914231286523;5727.799527016556;5749.281339832521;5128.512791284822;5135.717535535544;5157.277981082651;5177.948220517803;5222.686638801684;5224.320838291036;5227.73861306935;5231.293775340338;5232.502912223333;5237.947620523784;5228.398734145584;5233.345831771028;5237.031149237384;5294.814681486148;5302.3106996090455;5286.022085914118;5286.788528458857;5292.52367286946;5300.469953004707;5305.230741542493;5040.294358789773;5215.739213039333;5239.318888544503;5259.842204733826;5275.235090911835;5748.683822389767;5760.596758226926;5822.854428639275;5829.242198514208;5853.619514731571;6112.381899552462;6149.477294429978;6201.565890387675;6231.626102433823;6236.625802451822;5679.716014199274;5991.610545314541;6048.053434547144;6190.350013248634;6280.591761535486;5850.707464626752;5859.824205273849;5866.501347385435;5871.55963302754;5917;6171.166892469549;6237.376262373817;6299.5275354348605;6301.495880329563;6307.653079080695;5816.302043754777;6111.014442317784;6137.171481849893;6171;6200.3799620037635;6259.2488901332135;6292.968535157295;6293.056041593706;6298.307186209513;6307.810765676945;6116.908246376308;6209.316975132731;6255.96872015637;6267.435930766253;6283.465905398092;6056.091586262096;6139.706800529493;6189.226346706661;6196.1635179250225;6259.0924315973925;4291.249031419489;4937.7777999990085;4947.960928205045;4948.529889660476;4987.451380348159;3600.801955892451;4444.355568442623;4446.177457170434;4460.174867649495;4487.394201782783;5590.552755779528;5649.915251271234;5657.094864821691;5667.319921609434;5680.744366503517;6135.875804921915;6211;6238.251409830849;6245.156903817927;6263.96868015657;5684.573656975744;5711.428857114255;5719.914201286984;5731.627444216196;5747.195392645033;5071.318522936221;5393.8112166074;5394.460553944574;5400.972995134999;5424.294841670558;6186.19579454677;6266.091416744638;6284.340144284875;6295.370462953668;6398.136251606066;6240.500759939103;6242.063690446469;6262.373762623702;6284.748610055546;6286.308506064421;6319.6840157991;6338.492920566436;6361.2048493938255;6362.618242905441;6386.680665966776;5961;6072.817815465543;6092.939070609415;6209.161763161916;6226.906596400967;5208.479152084761;5835.183074369676;5975.877192982387;6180.4746596538;6296.905546416716;6127;6171.84570385744;6181.289151747426;6183.443490085914;6195.783147589993;5955.315138758925;6111.40942266768;6113.780377411107;6163.414475624809;6176.35148309421;5926.733297001559;5931.258592675916;5941.168236446987;5980.132880732356;5987.461128498456;6054.006533531684;6084.90872636902;6110.175126358063;6110.61618780752;6165.537584681257;5822.854428639149;5857.414258574108;5870.530357571299;5920;5927.051671732502 05:15:28 INFO - PROCESS | 6855 | |1;ext.html;429.8452557079449;460.99078018439633;537.2961420539092;569.6183557016799;660.8248814064273;26186.607200892002;29466.852665736697;29541.85229073854;29544.965926192588;29585.112446626583;30515;30876.38247235054;31014.689853101463;38663;38836.80581597088;9513.28650351223;9665.855012174823;9695.127438530531;9697.466639334834;9716.465594392306;9468.431894086343;9585.66450174244;9596.520173991308;9606.855897161548;9613.615455381776;9544.093311135432;9620.27847911406;9624.422534647909;9635;9635.132838044574;9503.477308748015;9592.184664303508;9593.952030239805;9699.51502424883;9700.902990970071;9515.524223788783;9671.226301895831;9683.612655493771;9691.806163876683;9697.224222062217;38856.41715374272;38936;39186.80406597977;39209.41185882214;39212.60787392118;3106.673799251091;3141.167590588496;3223.3069889973767;3474.934089242192;3569.5894972078286;27513.587296190373;28127.578086328722;28239.43521129566;28388.29029274264;29184.124476265744;2720.1295585412677;2730.30377253801;2770.7367800058964;2808.213700163937;2890.089621769136;363365;364072;364266;364358;364613.3538664606;61259;61657.383426165165;61825;61990.9999999991;62004;64359.356406435334;64549;64654;64728;64849;14959.700805983819;16381.918090409472;16561.585960351087;16568.6686266274;16592.668146637;11176.658800943938;11270.605528806453;11274.774504509864;11280.2667826591;11286.830697539543;16659.833401665826;16716.563451602946;19309.903450482656;19353.12910919012;19744.11151498186;8540.359473039547;8749.56252187388;8760.693375731818;8765.561721913879;8796.824063518694;857.4812238595684;875.6322344615277;970.3498655900563;1096.2326371539955;1150.4995327032768;26783.330416739736;31504.369912601618;31735.52396714051;31843.52234716481;32349.35301293961;852.8464876322322;1018.2007124407305;1075.639660713654;1148.8506494155706;1199.2264989081993;14652.047616904867;14653.780193297109;14913.776293355608;14931;14956.700865982619;668988;674417;677329;678595;679116;49313.75343123333;50153;56262.718686406304;57390.426095738505;58242.7087864558;1405.2622373253919;1420.1479112532604;1445.5085271007908;1448.2251995182526;1449.3405500497458;25375.261636599516;26939.730602694508;28669.713302866705;29367.26581835386;29867;50034.49965500298;50659;50678.74660626673;50682.49317506778;50743.74628126836;496914;503775;504628.47685761336;506181;506983;32154.67845321517;32482.350352992336;32512.349753004335;32559.837200813843;41462.58537414708;42008.36987445252;42880.57119428766;44117.89705257266;44146.77926610475;44272.335914960655;28580;29626.703732962393;35717.46423803593;36897.44653830249;37367.439488408236;29404.85297573584;35384.155157800065;35760.821195893855;36695;36871.63128368789;29796.85101574478;35843.462348065324;36035.819820900724;36485;36618.8169059153;31362.686373135977;32203.355932880742;32660.183495411853;32662;32728.34543309168;23736;24130.82629496791;24318.392040199138;24734.752652473246;24838.50322993566 05:15:28 INFO - PROCESS | 6855 | |2;jquery.html;364.42420974859715;370.96475834795694;372.3149405094627;373.8411175250518;377.5054678371332;14487.565373038798;15042;18628;18646.254149834007;19254.614907701856;19590.804091959075;19768.901155494237;19947.40157795265;20978.89510552449;20980;4652.13935421948;6420.967895160517;6737.966310168442;6750.729970801162;6752.392284694377;4802.4237091548885;4857.805687772485;7293.416526677879;7559.319661230488;7573.924260757404;6506.674666266667;6683.696679147568;7295.635218239094;7429.479936404454;7547.43394245431;7167.641617919109;7434.479586428952;7442.03253577037;7457.440691948125;7473.738419155331;6942.548734332303;6965.65171741416;7074.575525468488;7091.680874360666;7155.391791697712;20831.270905518235;24461.26616201499;25123.86942587588;25198.874005629856;25355.619665705028;2313.3175713164655;2338.1699496678602;2578.187870820704;2765.2810269329916;3041.0844546918133;12616.55842045524;14843.257837108209;15261.847381526153;15456.227188640523;16109.355625774955;1842.4748946550303;1902.391234804863;1906.8379187769056;1922.4713203868907;2000.0699674651357;109444.11148479678;110703.9999999992;111065.44467277692;111371.44314278458;112308.87691123148;17921.014344211195;18131.909340453214;18331.725024124647;18337.083145842655;18359.449216523524;26225.606615900775;26546.203613891616;26639.200823975312;26691.33271668185;26724.331891702474;8233.917660823436;10355.964403559583;10358.964103589731;10383.428911409945;10465.895341046644;8840.292776577859;8855.070217627184;8864.0692727264;8918.821623567623;8969.103089690978;7203.057624460934;7262.128544574685;7886.802829929183;8191.1808819118805;8292.419530632798;2748.7800975921878;3197.713634751164;3286.6877646623534;3297.7856439331367;3345.514900339437;858.6994551906907;865.2774932930947;906.309732349164;912.0879120879121;987.7975015121883;15129.546113616609;16252.593685157966;18238.90880545589;18616;18936.71594926077;906.5829718329642;907.2787134228304;913.2785099771106;927.6363745294407;939.9765005874908;10445.164386849186;10555.466687994825;10601.204909631808;10947.397893115796;11104.500297486633;503131;511572;515424;622571;732635;110538;112485;113649.43175284236;118046;118987.40506297586;1092.3282181458505;1132.2527132092944;1135.914806389524;1144.5936692474218;1155.630198336541;17717.911410442866;17949.434557377786;17952.012639304965;18027;18330.72503912469;34062;35516.82241588776;46089.76955115203;46239.30641040454;46274;44081.77959110184;52748.193418668816;61436.69281653563;65268.673656631414;67873;6128.849761297261;7243.927560724325;7626.161122276434;7729.574873382018;7780.260875216845;10281.897181028393;10744.946275268574;10767.246292759432;10859.457027148454;11418.942905285421;8941.642334306554;10382.560098377027;10388.37669739818;10481.37111773296;10653.360798352123;7822.295993360625;10236;10337.0696637303;10394.272400931863;10675.733106672085;9266.44401335895;9742.928277889285;10044.698659040241;10371.776933839636;10734.946325268324;7443.44174186949;7626.313631773167;7669.7315593953945;7775.766726998199;7803.258690424401;9215.861762073708;10627;10727.302725322828;10749.240802509023;10816.891831081903 05:15:28 INFO - PROCESS | 6855 | |3;mootools.html;1378.5864240727778;1484.7995520604718;1503.5263891874063;1732.7574139620456;1946.4355336952285;7870.212978702134;8066.516009039455;8414.410991230608;8559.743207703763;8617.095205003478;8404.495730256189;8510.404271700969;8612.440191387572;8634.481931084123;8635;2163.242864997246;2224.744154422238;2464.790492808109;2479.8636075015866;2484.627305904111;2247.8651280923195;2350.106959355451;2407.687000689908;2408.3256688127353;2413.734489206186;2428.138011006094;2449.473363226906;2465.617829236462;2470.147799009339;2503.399184195798;2468.0127948820436;2475.121331927158;2484.714257860351;2494.4138127540105;2495.4510007798253;2463.408781892333;2474.096954611554;2484.167803785734;2486.552420564298;2492.950140997188;8621.525816080113;8766.474011559327;8777.253933415603;8781.253593444564;8783.736487905373;5376.838694839122;5486.341639003305;5507.091329930557;5528.308961379827;5528.391876893538;3538.398472259722;3608.6030536640947;3666.7433279670436;3677.5403074615674;3681.1901381695984;1016.8576399304103;1031.9638812641522;1043.243648354944;1050.217587897014;1066.4028144239173;11860.644180674593;11875.52497900083;11882.524699012029;11885.40572971348;11896.762064758743;4803;4850.442199147073;4932;4950;4951.752412379366;8504.192101750325;10205.183585313158;10205.438700871524;10208.489575521342;10244.897551024544;5425.348958124971;5433.212184233264;5456.863578410572;5477.04151773438;5487.6981766003255;4880.194767863334;4907.803687852517;4956.157453232959;4960.982998485302;5077.8730531737;3634.200475895299;3722.050877026341;3907.27715372657;3951.130751234724;3990.182012687392;1282.4870051979096;1292.528227197085;1297.8053292006086;1315.151727135992;1332.3404914567352;1272.1349482352089;1300.811382349573;1326.310318634324;1326.476041963419;1360.177092858826;6728.461723062143;7973.920260797434;8014.879776803353;8093.473924194908;8133.674653013932;1162.1806626328587;1170.6839153428698;1180.5808937827119;1182.6878452625097;1202.8632941870023;6216.2540495140875;6226.128342032119;6278.215223097113;6286.277078135981;6295.527835412271;10412.5834966602;10772.892271077346;10913.672589822318;11186;11201.215914886043;10364.585416583403;10578.206634502289;10651.360918344924;10752.301100428447;10926.781464370668;8214.219649133323;8255.298299644597;8272.958635206785;8318.792030199173;8461.40770146084;7781.727639532589;7843.607819609111;7895.01312335958;7923.286904178652;7928.7621371358955;9238.584263708284;9584.9041509584;9649.324547281623;9742.659006934724;9753.122219000325;9688.660896868576;10005.449700266556;10049.598016079275;10058.54736536843;10060.446675432922;7463.888041679271;7474.289942455458;7520.548767073993;7537.660805263667;7576.28025337592;7212.74755383559;8090.393220508367;8168.183181681784;8187.71343002992;8198.549079800669;6561.5236571772875;7597.430192735677;7677.347425468898;7827.060752709711;7834.255745704149;7445.4415918805225;7469.887951680837;7565.924340756742;7645.120811106794;7697.307242347992;7433.8141546461775;7692.115406728074;7746.225377462209;7748.961255193688;7749.070111586646;6944.201416837129;7013.088298521159;7016.298370163147;7023.438124949889;7076.363127318566;6361.745530178926;6761.898571521529;7151.928480715334;7169.5698258104685;7189.029481020205 05:15:28 INFO - PROCESS | 6855 | |4;prototype.html;319.50476761020417;328.3334830294502;333.0939843625339;337.30346833788224;340.46546921333515;5267.762950667219;6295.874082518359;6464.385883341081;6479.287278399373;6504.121943537627;5172.45689202633;5362.570994320455;6211;6259.186305780254;6369.713362898669;3904.2777086239134;4738.147133515966;4782.545658162469;4795.544423279783;4801.127560251487;4521.706089104214;4646.883827904313;4684.250519916814;4783.71297722136;4797.0405918816205;4633.768311584424;4731.769739867642;4734.029523947583;4740.454847692507;4763.428388593356;4720.315554244616;4740.857774266778;4746.810127594892;4764.523547645208;4770.61835053195;3680.0799800049986;3769.4345848122725;4085.611866872642;4094.1402305515876;4095.1400205956784;5862.970685146547;6061.727222275008;6102.847428814271;6130.96934515329;6159.076138579204;5473.825181394821;5486.3690675572425;5490.835274941758;5495.917561236584;5496.477834605706;4943.703377797307;6871.931280687229;6875.346842049998;6880.8967865482055;6911.205211400703;4315.719478233905;4455.264881294583;4458.8439404620685;4468.709533880287;4481.619062379702;7147.106611673541;7270.7091716331815;7282.417406607458;7298.270172982712;7298.708051677927;4551.47658019332;4555.681102322806;4556.703814252063;4564.794584243717;4569.428821397325;4626.83806066786;4629.888826681639;4645.6980296280635;4645.723595438279;4646.163690535736;5266.183741520071;5466.34403871538;5472.315960504937;5472.425395333433;5486.835394938158;5656.377798442168;6883.931160688429;6937;6953.061336719579;6953.930460695429;1580.257279078831;1605.1813575076794;1605.5504458751568;1605.8394160583848;1608.6300150965344;949.3259785552335;983.2036050798876;1014.852846337277;1024.3085917005992;1048.6067724603274;6440.774572889926;6443.452306553995;6454.838629034311;6482.222133344029;6485.319041500669;6890.069840571559;7061.435085193172;7087.114110736158;7166.032585600981;7220.205777364486;6198.88329663408;6422.710978006001;6435.742570297136;6439.67801609927;6460.903086453707;3726.1802403471193;3763.6048214937587;3766.37854753968;3767.3407153747985;3773.8490460381827;7458.881167824869;7517.962410187914;7581.97643318156;7604.8479030419085;7624.390048796083;7201.567905925556;7450.552966822008;7500.324970752658;7510.586917719578;7519.210482899326;7514.511556748794;7520.6239688015385;7522.962385188039;7524.2851929066655;7528.962355188299;7202.315780000891;7256.673449694882;7269.382102521134;7282.271772822675;7294.796358600772;5791.420857914343;6886.311368863074;7166.605836679033;7173.605451700207;7177.138743350832;7576.24237576238;7576.28025337592;7577.696892124253;7579.166291707797;7583.658735356812;4702.0360826031265;4747.881302967454;4753.239481682914;4760.0241950399395;4761.571458568746;6865.622390768555;7119.964400177966;7146.571205727673;7151.356377926011;7152.962820391118;6912;6914.377706006484;6925;6935.3411425914455;6936.20233673134;6051.940910340585;6902.171739391305;6902.585844849325;6913.098897803145;6914.0320355151325;5511.9527289814805;6312.747490100344;6739.898901516383;6763.729450821912;6767;5588.552915766648;5716.371199168005;6901.447884169354;6901.654917254017;6907.34380233877;6212.81361559154;6538.378854008862;6769.898451523132;6782.1861376635115;6792.490563207878 05:15:28 INFO - PROCESS | 6855 | |5;yui.html;647.562895045844;739.5636574421092;754.3814072460581;771.2249189564487;777.7472321495516;14442.422303107876;14548.563543093698;14647;15273.236338183102;15447.613809654764;13949.651258718537;14044.087134336261;14052.859471405283;14065;14077.577672669837;716.9784906452788;872.5462759365142;888.524639317965;889.2130464538865;889.8932128144631;720.9387202087829;728.9562626242416;866.6143566113083;879.8504254276788;880.9119088091172;899.6536333511613;919.2278486071698;922.423485321674;923.9907600924006;924.191332583989;743.8252010777463;754.6264599023464;906.5014242166782;913.3834661603457;918.2195134135965;561.9859503512404;675.5473832532215;684.1721516964479;685.3112621815094;687.3470203306829;14912.701745965129;15013.924930375279;15039.398424063025;15060.171690557016;15073.321700523393;12421.689457763538;12518.37408129599;12679.302638354888;12718.936405318007;12730;9944.602215911355;10017.248706347053;10019.649312274036;10021.59913603455;10194.082532572103;3459.5848498180126;3497.24809166028;3498.3003399320237;3498.8250587470525;3505.2989402119424;75400;75922.62038689827;77732.27937022234;78019;78326.34226090732;9543.188828949616;9615.375000624937;9677.467739274267;9762.17021553176;10313.12338451225;21396.358109256747;21424.892875535523;21434.678479822815;21515;21556.353309400743;6317.399847014526;7394.519356241827;7511.549307041595;7579.393648508106;7769.572673503011;4202;4208.516020657602;4234.87295381139;4284.057507348379;4448.666350023761;3470.3753324401346;3514.8594056237466;3516.0506663200795;3522.806245656462;3526.770759900598;627.4760574919993;644.7292137302344;651.3876955661663;661.507177153024;666.5733930284622;427.2224551316636;559.4433538629008;601.9578629495893;616.9568130230931;631.422248642487;7549.886751698729;8694.826103477895;9148.725538233864;9304.209142222986;9390.5304734763;493.8370337788521;521.7521677203298;590.1737567405667;590.2415396215843;626.9028300613412;4230.386593943861;4434.157510073141;4450.554944505524;4472.9261096488935;4496.752678602708;83302.5834870834;85038.57480712557;85117;85122;86293;70865;75133;75356;75411.96704263646;76555.8516622251;65052;65791.67104164448;66540;67160.32839671736;67468;8894.73315800527;8978.37151399422;9029.683961061332;9090.54547272647;9158.862617060882;43607;44393.33409998917;45202.54797451983;45332;47486.762566186946;62139.689301553204;63142.684286578275;63352.36647633649;63941;66348.6682566584;11412.31526108436;11445.542178312775;11581.942090289494;11606.30362178272;11672.474738636613;11731.706707332043;12238.082143839425;12374.071944604011;12669;12828.807567886675;11255.324680518868;11569.36368499707;11716.70708232301;12235.69410764738;12254.326012069421;11314.83027754568;11583.586445119503;11754.941225293818;11928.761424771283;12024.278543287432;11315.114645765278;11370.31778093317;11452.312861228353;11693.824592631288;12242.143049986771;9108.635654574007;9217.493037882981;9303.76740581491;9483.762905927131;9546.618135274512;8679.652813887375;9046.321525885453;9616.423014619146;10063.597456101674;10092.545835437277 05:15:28 INFO - PROCESS | 6855 | __end_tp_report 05:15:28 INFO - PROCESS | 6855 | __start_cc_report 05:15:28 INFO - PROCESS | 6855 | _x_x_mozilla_cycle_collect,1774 05:15:28 INFO - PROCESS | 6855 | __end_cc_report 05:15:28 INFO - PROCESS | 6855 | __startTimestamp1454678128158__endTimestamp 05:15:28 INFO - PROCESS | 6855 | 05:15:28 INFO - PROCESS | 6855 | ------- Summary: start ------- 05:15:28 INFO - PROCESS | 6855 | Number of tests: 6 05:15:28 INFO - PROCESS | 6855 | 05:15:28 INFO - PROCESS | 6855 | [#0] dojo.html Cycles:165 Average:5732.29 Median:5920.00 stddev:638.78 (10.8%) stddev-sans-first:613.90 05:15:28 INFO - PROCESS | 6855 | Values: 3396.6 3443.7 3468.3 3472.8 3517.5 5670.4 5737.8 5761.3 5764.3 5771.9 5648.4 5710.6 5717.9 5727.8 5749.3 5128.5 5135.7 5157.3 5177.9 5222.7 5224.3 5227.7 5231.3 5232.5 5237.9 5228.4 5233.3 5237.0 5294.8 5302.3 5286.0 5286.8 5292.5 5300.5 5305.2 5040.3 5215.7 5239.3 5259.8 5275.2 5748.7 5760.6 5822.9 5829.2 5853.6 6112.4 6149.5 6201.6 6231.6 6236.6 5679.7 5991.6 6048.1 6190.4 6280.6 5850.7 5859.8 5866.5 5871.6 5917.0 6171.2 6237.4 6299.5 6301.5 6307.7 5816.3 6111.0 6137.2 6171.0 6200.4 6259.2 6293.0 6293.1 6298.3 6307.8 6116.9 6209.3 6256.0 6267.4 6283.5 6056.1 6139.7 6189.2 6196.2 6259.1 4291.2 4937.8 4948.0 4948.5 4987.5 3600.8 4444.4 4446.2 4460.2 4487.4 5590.6 5649.9 5657.1 5667.3 5680.7 6135.9 6211.0 6238.3 6245.2 6264.0 5684.6 5711.4 5719.9 5731.6 5747.2 5071.3 5393.8 5394.5 5401.0 5424.3 6186.2 6266.1 6284.3 6295.4 6398.1 6240.5 6242.1 6262.4 6284.7 6286.3 6319.7 6338.5 6361.2 6362.6 6386.7 5961.0 6072.8 6092.9 6209.2 6226.9 5208.5 5835.2 5975.9 6180.5 6296.9 6127.0 6171.8 6181.3 6183.4 6195.8 5955.3 6111.4 6113.8 6163.4 6176.4 5926.7 5931.3 5941.2 5980.1 5987.5 6054.0 6084.9 6110.2 6110.6 6165.5 5822.9 5857.4 5870.5 5920.0 5927.1 05:15:28 INFO - PROCESS | 6855 | 05:15:28 INFO - PROCESS | 6855 | [#1] ext.html Cycles:180 Average:64700.83 Median:364485.68 stddev:141972.06 (39.0%) stddev-sans-first:142288.32 05:15:28 INFO - PROCESS | 6855 | Values: 429.8 461.0 537.3 569.6 660.8 26186.6 29466.9 29541.9 29545.0 29585.1 30515.0 30876.4 31014.7 38663.0 38836.8 9513.3 9665.9 9695.1 9697.5 9716.5 9468.4 9585.7 9596.5 9606.9 9613.6 9544.1 9620.3 9624.4 9635.0 9635.1 9503.5 9592.2 9594.0 9699.5 9700.9 9515.5 9671.2 9683.6 9691.8 9697.2 38856.4 38936.0 39186.8 39209.4 39212.6 3106.7 3141.2 3223.3 3474.9 3569.6 27513.6 28127.6 28239.4 28388.3 29184.1 2720.1 2730.3 2770.7 2808.2 2890.1 363365.0 364072.0 364266.0 364358.0 364613.4 61259.0 61657.4 61825.0 61991.0 62004.0 64359.4 64549.0 64654.0 64728.0 64849.0 14959.7 16381.9 16561.6 16568.7 16592.7 11176.7 11270.6 11274.8 11280.3 11286.8 16659.8 16716.6 19309.9 19353.1 19744.1 8540.4 8749.6 8760.7 8765.6 8796.8 857.5 875.6 970.3 1096.2 1150.5 26783.3 31504.4 31735.5 31843.5 32349.4 852.8 1018.2 1075.6 1148.9 1199.2 14652.0 14653.8 14913.8 14931.0 14956.7 668988.0 674417.0 677329.0 678595.0 679116.0 49313.8 50153.0 56262.7 57390.4 58242.7 1405.3 1420.1 1445.5 1448.2 1449.3 25375.3 26939.7 28669.7 29367.3 29867.0 50034.5 50659.0 50678.7 50682.5 50743.7 496914.0 503775.0 504628.5 506181.0 506983.0 32154.7 32482.4 32512.3 32559.8 41462.6 42008.4 42880.6 44117.9 44146.8 44272.3 28580.0 29626.7 35717.5 36897.4 37367.4 29404.9 35384.2 35760.8 36695.0 36871.6 29796.9 35843.5 36035.8 36485.0 36618.8 31362.7 32203.4 32660.2 32662.0 32728.3 23736.0 24130.8 24318.4 24734.8 24838.5 05:15:28 INFO - PROCESS | 6855 | 05:15:28 INFO - PROCESS | 6855 | [#2] jquery.html Cycles:180 Average:33564.50 Median:26707.83 stddev:96820.08 (362.5%) stddev-sans-first:97059.59 05:15:28 INFO - PROCESS | 6855 | Values: 364.4 371.0 372.3 373.8 377.5 14487.6 15042.0 18628.0 18646.3 19254.6 19590.8 19768.9 19947.4 20978.9 20980.0 4652.1 6421.0 6738.0 6750.7 6752.4 4802.4 4857.8 7293.4 7559.3 7573.9 6506.7 6683.7 7295.6 7429.5 7547.4 7167.6 7434.5 7442.0 7457.4 7473.7 6942.5 6965.7 7074.6 7091.7 7155.4 20831.3 24461.3 25123.9 25198.9 25355.6 2313.3 2338.2 2578.2 2765.3 3041.1 12616.6 14843.3 15261.8 15456.2 16109.4 1842.5 1902.4 1906.8 1922.5 2000.1 109444.1 110704.0 111065.4 111371.4 112308.9 17921.0 18131.9 18331.7 18337.1 18359.4 26225.6 26546.2 26639.2 26691.3 26724.3 8233.9 10356.0 10359.0 10383.4 10465.9 8840.3 8855.1 8864.1 8918.8 8969.1 7203.1 7262.1 7886.8 8191.2 8292.4 2748.8 3197.7 3286.7 3297.8 3345.5 858.7 865.3 906.3 912.1 987.8 15129.5 16252.6 18238.9 18616.0 18936.7 906.6 907.3 913.3 927.6 940.0 10445.2 10555.5 10601.2 10947.4 11104.5 503131.0 511572.0 515424.0 622571.0 732635.0 110538.0 112485.0 113649.4 118046.0 118987.4 1092.3 1132.3 1135.9 1144.6 1155.6 17717.9 17949.4 17952.0 18027.0 18330.7 34062.0 35516.8 46089.8 46239.3 46274.0 44081.8 52748.2 61436.7 65268.7 67873.0 6128.8 7243.9 7626.2 7729.6 7780.3 10281.9 10744.9 10767.2 10859.5 11418.9 8941.6 10382.6 10388.4 10481.4 10653.4 7822.3 10236.0 10337.1 10394.3 10675.7 9266.4 9742.9 10044.7 10371.8 10734.9 7443.4 7626.3 7669.7 7775.8 7803.3 9215.9 10627.0 10727.3 10749.2 10816.9 05:15:28 INFO - PROCESS | 6855 | 05:15:28 INFO - PROCESS | 6855 | [#3] mootools.html Cycles:180 Average:6048.79 Median:4958.57 stddev:3173.08 (64.0%) stddev-sans-first:3162.56 05:15:28 INFO - PROCESS | 6855 | Values: 1378.6 1484.8 1503.5 1732.8 1946.4 7870.2 8066.5 8414.4 8559.7 8617.1 8404.5 8510.4 8612.4 8634.5 8635.0 2163.2 2224.7 2464.8 2479.9 2484.6 2247.9 2350.1 2407.7 2408.3 2413.7 2428.1 2449.5 2465.6 2470.1 2503.4 2468.0 2475.1 2484.7 2494.4 2495.5 2463.4 2474.1 2484.2 2486.6 2493.0 8621.5 8766.5 8777.3 8781.3 8783.7 5376.8 5486.3 5507.1 5528.3 5528.4 3538.4 3608.6 3666.7 3677.5 3681.2 1016.9 1032.0 1043.2 1050.2 1066.4 11860.6 11875.5 11882.5 11885.4 11896.8 4803.0 4850.4 4932.0 4950.0 4951.8 8504.2 10205.2 10205.4 10208.5 10244.9 5425.3 5433.2 5456.9 5477.0 5487.7 4880.2 4907.8 4956.2 4961.0 5077.9 3634.2 3722.1 3907.3 3951.1 3990.2 1282.5 1292.5 1297.8 1315.2 1332.3 1272.1 1300.8 1326.3 1326.5 1360.2 6728.5 7973.9 8014.9 8093.5 8133.7 1162.2 1170.7 1180.6 1182.7 1202.9 6216.3 6226.1 6278.2 6286.3 6295.5 10412.6 10772.9 10913.7 11186.0 11201.2 10364.6 10578.2 10651.4 10752.3 10926.8 8214.2 8255.3 8273.0 8318.8 8461.4 7781.7 7843.6 7895.0 7923.3 7928.8 9238.6 9584.9 9649.3 9742.7 9753.1 9688.7 10005.4 10049.6 10058.5 10060.4 7463.9 7474.3 7520.5 7537.7 7576.3 7212.7 8090.4 8168.2 8187.7 8198.5 6561.5 7597.4 7677.3 7827.1 7834.3 7445.4 7469.9 7565.9 7645.1 7697.3 7433.8 7692.1 7746.2 7749.0 7749.1 6944.2 7013.1 7016.3 7023.4 7076.4 6361.7 6761.9 7151.9 7169.6 7189.0 05:15:28 INFO - PROCESS | 6855 | 05:15:28 INFO - PROCESS | 6855 | [#4] prototype.html Cycles:180 Average:5599.98 Median:6236.00 stddev:1806.06 (29.0%) stddev-sans-first:1767.11 05:15:28 INFO - PROCESS | 6855 | Values: 319.5 328.3 333.1 337.3 340.5 5267.8 6295.9 6464.4 6479.3 6504.1 5172.5 5362.6 6211.0 6259.2 6369.7 3904.3 4738.1 4782.5 4795.5 4801.1 4521.7 4646.9 4684.3 4783.7 4797.0 4633.8 4731.8 4734.0 4740.5 4763.4 4720.3 4740.9 4746.8 4764.5 4770.6 3680.1 3769.4 4085.6 4094.1 4095.1 5863.0 6061.7 6102.8 6131.0 6159.1 5473.8 5486.4 5490.8 5495.9 5496.5 4943.7 6871.9 6875.3 6880.9 6911.2 4315.7 4455.3 4458.8 4468.7 4481.6 7147.1 7270.7 7282.4 7298.3 7298.7 4551.5 4555.7 4556.7 4564.8 4569.4 4626.8 4629.9 4645.7 4645.7 4646.2 5266.2 5466.3 5472.3 5472.4 5486.8 5656.4 6883.9 6937.0 6953.1 6953.9 1580.3 1605.2 1605.6 1605.8 1608.6 949.3 983.2 1014.9 1024.3 1048.6 6440.8 6443.5 6454.8 6482.2 6485.3 6890.1 7061.4 7087.1 7166.0 7220.2 6198.9 6422.7 6435.7 6439.7 6460.9 3726.2 3763.6 3766.4 3767.3 3773.8 7458.9 7518.0 7582.0 7604.8 7624.4 7201.6 7450.6 7500.3 7510.6 7519.2 7514.5 7520.6 7523.0 7524.3 7529.0 7202.3 7256.7 7269.4 7282.3 7294.8 5791.4 6886.3 7166.6 7173.6 7177.1 7576.2 7576.3 7577.7 7579.2 7583.7 4702.0 4747.9 4753.2 4760.0 4761.6 6865.6 7120.0 7146.6 7151.4 7153.0 6912.0 6914.4 6925.0 6935.3 6936.2 6051.9 6902.2 6902.6 6913.1 6914.0 5512.0 6312.7 6739.9 6763.7 6767.0 5588.6 5716.4 6901.4 6901.7 6907.3 6212.8 6538.4 6769.9 6782.2 6792.5 05:15:28 INFO - PROCESS | 6855 | 05:15:28 INFO - PROCESS | 6855 | [#5] yui.html Cycles:180 Average:17647.10 Median:31378.32 stddev:24031.47 (76.6%) stddev-sans-first:24064.98 05:15:28 INFO - PROCESS | 6855 | Values: 647.6 739.6 754.4 771.2 777.7 14442.4 14548.6 14647.0 15273.2 15447.6 13949.7 14044.1 14052.9 14065.0 14077.6 717.0 872.5 888.5 889.2 889.9 720.9 729.0 866.6 879.9 880.9 899.7 919.2 922.4 924.0 924.2 743.8 754.6 906.5 913.4 918.2 562.0 675.5 684.2 685.3 687.3 14912.7 15013.9 15039.4 15060.2 15073.3 12421.7 12518.4 12679.3 12718.9 12730.0 9944.6 10017.2 10019.6 10021.6 10194.1 3459.6 3497.2 3498.3 3498.8 3505.3 75400.0 75922.6 77732.3 78019.0 78326.3 9543.2 9615.4 9677.5 9762.2 10313.1 21396.4 21424.9 21434.7 21515.0 21556.4 6317.4 7394.5 7511.5 7579.4 7769.6 4202.0 4208.5 4234.9 4284.1 4448.7 3470.4 3514.9 3516.1 3522.8 3526.8 627.5 644.7 651.4 661.5 666.6 427.2 559.4 602.0 617.0 631.4 7549.9 8694.8 9148.7 9304.2 9390.5 493.8 521.8 590.2 590.2 626.9 4230.4 4434.2 4450.6 4472.9 4496.8 83302.6 85038.6 85117.0 85122.0 86293.0 70865.0 75133.0 75356.0 75412.0 76555.9 65052.0 65791.7 66540.0 67160.3 67468.0 8894.7 8978.4 9029.7 9090.5 9158.9 43607.0 44393.3 45202.5 45332.0 47486.8 62139.7 63142.7 63352.4 63941.0 66348.7 11412.3 11445.5 11581.9 11606.3 11672.5 11731.7 12238.1 12374.1 12669.0 12828.8 11255.3 11569.4 11716.7 12235.7 12254.3 11314.8 11583.6 11754.9 11928.8 12024.3 11315.1 11370.3 11452.3 11693.8 12242.1 9108.6 9217.5 9303.8 9483.8 9546.6 8679.7 9046.3 9616.4 10063.6 10092.5 05:15:28 INFO - PROCESS | 6855 | -------- Summary: end -------- 05:15:28 INFO - PROCESS | 6855 | 05:15:28 INFO - TEST-INFO | 6855: exit 0 05:15:28 INFO - TEST-OK | dromaeo_css | took 1115265ms 05:15:28 INFO - TEST-START | kraken 05:15:28 INFO - operating with platform_type : mac_ 05:15:28 INFO - Initialising browser for kraken test... 05:15:28 INFO - TEST-INFO | started process 6858 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/tmpnANDrO/profile http://localhost:65208/getInfo.html) 05:15:28 INFO - PROCESS | 6858 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 05:15:31 INFO - PROCESS | 6858 | __metrics Screen width/height:1600/1200 05:15:31 INFO - PROCESS | 6858 | colorDepth:24 05:15:31 INFO - PROCESS | 6858 | Browser inner width/height: 1024/689 05:15:31 INFO - PROCESS | 6858 | __metrics 05:15:31 INFO - PROCESS | 6858 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:15:31 INFO - PROCESS | 6858 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:15:31 INFO - TEST-INFO | 6858: exit 0 05:15:31 INFO - Browser initialized. 05:15:31 INFO - Running cycle 1/1 for kraken test... 05:15:31 INFO - TEST-INFO | started process 6860 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/tmpnANDrO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:15:43 INFO - PROCESS | 6860 | RSS: Main: 244400128 05:15:43 INFO - PROCESS | 6860 | 05:15:46 INFO - PROCESS | 6860 | Cycle 1(1): loaded http://localhost:65208/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:65208/tests/kraken/driver.html?testName=audio-beat-detection) 05:15:47 INFO - PROCESS | 6860 | RSS: Main: 291475456 05:15:47 INFO - PROCESS | 6860 | 05:15:49 INFO - PROCESS | 6860 | Cycle 1(1): loaded http://localhost:65208/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:65208/tests/kraken/driver.html?testName=audio-dft) 05:15:50 INFO - PROCESS | 6860 | RSS: Main: 303304704 05:15:50 INFO - PROCESS | 6860 | 05:15:53 INFO - PROCESS | 6860 | Cycle 1(1): loaded http://localhost:65208/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:65208/tests/kraken/driver.html?testName=audio-fft) 05:15:54 INFO - PROCESS | 6860 | RSS: Main: 287801344 05:15:54 INFO - PROCESS | 6860 | 05:15:56 INFO - PROCESS | 6860 | Cycle 1(1): loaded http://localhost:65208/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:65208/tests/kraken/driver.html?testName=audio-oscillator) 05:15:56 INFO - PROCESS | 6860 | RSS: Main: 289533952 05:15:56 INFO - PROCESS | 6860 | 05:15:58 INFO - PROCESS | 6860 | Cycle 1(1): loaded http://localhost:65208/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:65208/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:15:59 INFO - PROCESS | 6860 | RSS: Main: 290590720 05:15:59 INFO - PROCESS | 6860 | 05:16:02 INFO - PROCESS | 6860 | Cycle 1(1): loaded http://localhost:65208/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:65208/tests/kraken/driver.html?testName=imaging-darkroom) 05:16:02 INFO - PROCESS | 6860 | RSS: Main: 292188160 05:16:02 INFO - PROCESS | 6860 | 05:16:05 INFO - PROCESS | 6860 | Cycle 1(1): loaded http://localhost:65208/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:65208/tests/kraken/driver.html?testName=imaging-desaturate) 05:16:06 INFO - PROCESS | 6860 | RSS: Main: 290668544 05:16:06 INFO - PROCESS | 6860 | 05:16:08 INFO - PROCESS | 6860 | Cycle 1(1): loaded http://localhost:65208/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:65208/tests/kraken/driver.html?testName=json-parse-financial) 05:16:09 INFO - PROCESS | 6860 | RSS: Main: 292696064 05:16:09 INFO - PROCESS | 6860 | 05:16:10 INFO - PROCESS | 6860 | Cycle 1(1): loaded http://localhost:65208/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:65208/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:16:11 INFO - PROCESS | 6860 | RSS: Main: 325218304 05:16:11 INFO - PROCESS | 6860 | 05:16:13 INFO - PROCESS | 6860 | Cycle 1(1): loaded http://localhost:65208/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:65208/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:16:13 INFO - PROCESS | 6860 | RSS: Main: 326041600 05:16:13 INFO - PROCESS | 6860 | 05:16:16 INFO - PROCESS | 6860 | Cycle 1(1): loaded http://localhost:65208/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:65208/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:16:16 INFO - PROCESS | 6860 | RSS: Main: 334274560 05:16:16 INFO - PROCESS | 6860 | 05:16:19 INFO - PROCESS | 6860 | Cycle 1(1): loaded http://localhost:65208/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:65208/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:16:19 INFO - PROCESS | 6860 | RSS: Main: 336199680 05:16:19 INFO - PROCESS | 6860 | 05:16:22 INFO - PROCESS | 6860 | Cycle 1(1): loaded http://localhost:65208/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:65208/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:16:22 INFO - PROCESS | 6860 | RSS: Main: 336093184 05:16:22 INFO - PROCESS | 6860 | 05:16:24 INFO - PROCESS | 6860 | Cycle 1(1): loaded http://localhost:65208/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:65208/tests/kraken/driver.html?testName=ai-astar) 05:16:24 INFO - PROCESS | 6860 | RSS: Main: 395776000 05:16:24 INFO - PROCESS | 6860 | 05:16:24 INFO - PROCESS | 6860 | __start_tp_report 05:16:24 INFO - PROCESS | 6860 | _x_x_mozilla_page_load 05:16:24 INFO - PROCESS | 6860 | _x_x_mozilla_page_load_details 05:16:24 INFO - PROCESS | 6860 | |i|pagename|runs| 05:16:24 INFO - PROCESS | 6860 | |0;ai-astar;110;108;114;111;110;110;118;159;164;111 05:16:24 INFO - PROCESS | 6860 | |1;audio-beat-detection;159;120;147;160;119;143;142;119;159;118 05:16:24 INFO - PROCESS | 6860 | |2;audio-dft;185;186;186;185;185;188;186;183;181;183 05:16:24 INFO - PROCESS | 6860 | |3;audio-fft;73;76;98;79;57;57;59;82;93;82 05:16:24 INFO - PROCESS | 6860 | |4;audio-oscillator;92;96;130;79;79;83;112;77;78;114 05:16:24 INFO - PROCESS | 6860 | |5;imaging-gaussian-blur;85;90;84;89;84;89;83;90;84;90 05:16:24 INFO - PROCESS | 6860 | |6;imaging-darkroom;92;93;94;93;94;101;142;93;93;93 05:16:24 INFO - PROCESS | 6860 | |7;imaging-desaturate;85;85;85;86;85;86;83;87;86;84 05:16:24 INFO - PROCESS | 6860 | |8;json-parse-financial;57;56;52;56;54;53;56;66;53;52 05:16:24 INFO - PROCESS | 6860 | |9;json-stringify-tinderbox;65;66;67;78;75;71;70;69;71;76 05:16:24 INFO - PROCESS | 6860 | |10;stanford-crypto-aes;82;84;82;83;81;83;82;82;84;84 05:16:24 INFO - PROCESS | 6860 | |11;stanford-crypto-ccm;132;128;131;112;126;122;124;125;119;141 05:16:24 INFO - PROCESS | 6860 | |12;stanford-crypto-pbkdf2;137;127;137;137;137;125;141;169;118;160 05:16:24 INFO - PROCESS | 6860 | |13;stanford-crypto-sha256-iterative;67;67;66;66;66;68;70;89;97;96 05:16:24 INFO - PROCESS | 6860 | __end_tp_report 05:16:24 INFO - PROCESS | 6860 | __start_cc_report 05:16:24 INFO - PROCESS | 6860 | _x_x_mozilla_cycle_collect,1208 05:16:24 INFO - PROCESS | 6860 | __end_cc_report 05:16:24 INFO - PROCESS | 6860 | __startTimestamp1454678184970__endTimestamp 05:16:24 INFO - PROCESS | 6860 | 05:16:24 INFO - PROCESS | 6860 | ------- Summary: start ------- 05:16:24 INFO - PROCESS | 6860 | Number of tests: 14 05:16:24 INFO - PROCESS | 6860 | 05:16:24 INFO - PROCESS | 6860 | [#0] ai-astar Cycles:10 Average:121.50 Median:112.50 stddev:21.29 (18.9%) stddev-sans-first:22.17 05:16:24 INFO - PROCESS | 6860 | Values: 110.0 108.0 114.0 111.0 110.0 110.0 118.0 159.0 164.0 111.0 05:16:24 INFO - PROCESS | 6860 | 05:16:24 INFO - PROCESS | 6860 | [#1] audio-beat-detection Cycles:10 Average:138.60 Median:145.00 stddev:18.04 (12.4%) stddev-sans-first:17.56 05:16:24 INFO - PROCESS | 6860 | Values: 159.0 120.0 147.0 160.0 119.0 143.0 142.0 119.0 159.0 118.0 05:16:24 INFO - PROCESS | 6860 | 05:16:24 INFO - PROCESS | 6860 | [#2] audio-dft Cycles:10 Average:184.80 Median:185.50 stddev:1.99 (1.1%) stddev-sans-first:2.11 05:16:24 INFO - PROCESS | 6860 | Values: 185.0 186.0 186.0 185.0 185.0 188.0 186.0 183.0 181.0 183.0 05:16:24 INFO - PROCESS | 6860 | 05:16:24 INFO - PROCESS | 6860 | [#3] audio-fft Cycles:10 Average:75.60 Median:80.50 stddev:14.42 (17.9%) stddev-sans-first:15.27 05:16:24 INFO - PROCESS | 6860 | Values: 73.0 76.0 98.0 79.0 57.0 57.0 59.0 82.0 93.0 82.0 05:16:24 INFO - PROCESS | 6860 | 05:16:24 INFO - PROCESS | 6860 | [#4] audio-oscillator Cycles:10 Average:94.00 Median:79.00 stddev:18.69 (23.7%) stddev-sans-first:19.81 05:16:24 INFO - PROCESS | 6860 | Values: 92.0 96.0 130.0 79.0 79.0 83.0 112.0 77.0 78.0 114.0 05:16:24 INFO - PROCESS | 6860 | 05:16:24 INFO - PROCESS | 6860 | [#5] imaging-gaussian-blur Cycles:10 Average:86.80 Median:89.00 stddev:3.01 (3.4%) stddev-sans-first:3.12 05:16:24 INFO - PROCESS | 6860 | Values: 85.0 90.0 84.0 89.0 84.0 89.0 83.0 90.0 84.0 90.0 05:16:24 INFO - PROCESS | 6860 | 05:16:24 INFO - PROCESS | 6860 | [#6] imaging-darkroom Cycles:10 Average:98.80 Median:93.00 stddev:15.39 (16.5%) stddev-sans-first:16.13 05:16:24 INFO - PROCESS | 6860 | Values: 92.0 93.0 94.0 93.0 94.0 101.0 142.0 93.0 93.0 93.0 05:16:24 INFO - PROCESS | 6860 | 05:16:24 INFO - PROCESS | 6860 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:85.50 stddev:1.14 (1.3%) stddev-sans-first:1.20 05:16:24 INFO - PROCESS | 6860 | Values: 85.0 85.0 85.0 86.0 85.0 86.0 83.0 87.0 86.0 84.0 05:16:24 INFO - PROCESS | 6860 | 05:16:24 INFO - PROCESS | 6860 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:56.00 stddev:4.12 (7.4%) stddev-sans-first:4.33 05:16:24 INFO - PROCESS | 6860 | Values: 57.0 56.0 52.0 56.0 54.0 53.0 56.0 66.0 53.0 52.0 05:16:24 INFO - PROCESS | 6860 | 05:16:24 INFO - PROCESS | 6860 | [#9] json-stringify-tinderbox Cycles:10 Average:70.80 Median:71.00 stddev:4.37 (6.2%) stddev-sans-first:4.10 05:16:24 INFO - PROCESS | 6860 | Values: 65.0 66.0 67.0 78.0 75.0 71.0 70.0 69.0 71.0 76.0 05:16:24 INFO - PROCESS | 6860 | 05:16:24 INFO - PROCESS | 6860 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:83.00 stddev:1.06 (1.3%) stddev-sans-first:1.09 05:16:24 INFO - PROCESS | 6860 | Values: 82.0 84.0 82.0 83.0 81.0 83.0 82.0 82.0 84.0 84.0 05:16:24 INFO - PROCESS | 6860 | 05:16:24 INFO - PROCESS | 6860 | [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:127.00 stddev:7.86 (6.2%) stddev-sans-first:8.03 05:16:24 INFO - PROCESS | 6860 | Values: 132.0 128.0 131.0 112.0 126.0 122.0 124.0 125.0 119.0 141.0 05:16:24 INFO - PROCESS | 6860 | 05:16:24 INFO - PROCESS | 6860 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.80 Median:137.00 stddev:15.43 (11.3%) stddev-sans-first:16.35 05:16:24 INFO - PROCESS | 6860 | Values: 137.0 127.0 137.0 137.0 137.0 125.0 141.0 169.0 118.0 160.0 05:16:24 INFO - PROCESS | 6860 | 05:16:24 INFO - PROCESS | 6860 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.20 Median:69.00 stddev:13.19 (19.1%) stddev-sans-first:13.65 05:16:24 INFO - PROCESS | 6860 | Values: 67.0 67.0 66.0 66.0 66.0 68.0 70.0 89.0 97.0 96.0 05:16:24 INFO - PROCESS | 6860 | -------- Summary: end -------- 05:16:24 INFO - PROCESS | 6860 | 05:16:25 INFO - TEST-INFO | 6860: exit 0 05:16:25 INFO - TEST-OK | kraken | took 56975ms 05:16:25 INFO - SUITE-END | took 1172s 05:16:26 INFO - Completed test suite (00:19:32) 05:16:26 INFO - Working with test: dromaeo_css 05:16:26 INFO - Generating results file: dromaeo_css 05:16:26 INFO - Working with test: kraken 05:16:26 INFO - Generating results file: kraken 05:16:26 INFO - javascript benchmark 05:16:26 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:16:26 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 05:16:26 INFO - process_Request line: dromaeo_css 7558.83 graph.html#tests=[[72,64,59]] 05:16:26 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:16:26 INFO - process_Request line: kraken 1434.30 graph.html#tests=[[232,64,59]] 05:16:26 INFO - RETURN: dromaeo_css: 7558.83 05:16:26 INFO - RETURN: kraken: 1434.30 05:16:26 INFO - javascript benchmark 05:16:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3396.5754280714905, 3443.6728510791468, 3468.323676883009, 3472.843722032509, 3517.4547945068507, 5670.432956704328, 5737.770489180428, 5761.337446193684, 5764.250647415835, 5771.913421298684, 5648.378678345389, 5710.600257981943, 5717.914231286523, 5727.799527016556, 5749.281339832521, 5128.512791284822, 5135.717535535544, 5157.277981082651, 5177.948220517803, 5222.686638801684, 5224.320838291036, 5227.73861306935, 5231.293775340338, 5232.502912223333, 5237.947620523784, 5228.398734145584, 5233.345831771028, 5237.031149237384, 5294.814681486148, 5302.3106996090455, 5286.022085914118, 5286.788528458857, 5292.52367286946, 5300.469953004707, 5305.230741542493, 5040.294358789773, 5215.739213039333, 5239.318888544503, 5259.842204733826, 5275.235090911835, 5748.683822389767, 5760.596758226926, 5822.854428639275, 5829.242198514208, 5853.619514731571, 6112.381899552462, 6149.477294429978, 6201.565890387675, 6231.626102433823, 6236.625802451822, 5679.716014199274, 5991.610545314541, 6048.053434547144, 6190.350013248634, 6280.591761535486, 5850.707464626752, 5859.824205273849, 5866.501347385435, 5871.55963302754, 5917.0, 6171.166892469549, 6237.376262373817, 6299.5275354348605, 6301.495880329563, 6307.653079080695, 5816.302043754777, 6111.014442317784, 6137.171481849893, 6171.0, 6200.3799620037635, 6259.2488901332135, 6292.968535157295, 6293.056041593706, 6298.307186209513, 6307.810765676945, 6116.908246376308, 6209.316975132731, 6255.96872015637, 6267.435930766253, 6283.465905398092, 6056.091586262096, 6139.706800529493, 6189.226346706661, 6196.1635179250225, 6259.0924315973925, 4291.249031419489, 4937.7777999990085, 4947.960928205045, 4948.529889660476, 4987.451380348159, 3600.801955892451, 4444.355568442623, 4446.177457170434, 4460.174867649495, 4487.394201782783, 5590.552755779528, 5649.915251271234, 5657.094864821691, 5667.319921609434, 5680.744366503517, 6135.875804921915, 6211.0, 6238.251409830849, 6245.156903817927, 6263.96868015657, 5684.573656975744, 5711.428857114255, 5719.914201286984, 5731.627444216196, 5747.195392645033, 5071.318522936221, 5393.8112166074, 5394.460553944574, 5400.972995134999, 5424.294841670558, 6186.19579454677, 6266.091416744638, 6284.340144284875, 6295.370462953668, 6398.136251606066, 6240.500759939103, 6242.063690446469, 6262.373762623702, 6284.748610055546, 6286.308506064421, 6319.6840157991, 6338.492920566436, 6361.2048493938255, 6362.618242905441, 6386.680665966776, 5961.0, 6072.817815465543, 6092.939070609415, 6209.161763161916, 6226.906596400967, 5208.479152084761, 5835.183074369676, 5975.877192982387, 6180.4746596538, 6296.905546416716, 6127.0, 6171.84570385744, 6181.289151747426, 6183.443490085914, 6195.783147589993, 5955.315138758925, 6111.40942266768, 6113.780377411107, 6163.414475624809, 6176.35148309421, 5926.733297001559, 5931.258592675916, 5941.168236446987, 5980.132880732356, 5987.461128498456, 6054.006533531684, 6084.90872636902, 6110.175126358063, 6110.61618780752, 6165.537584681257, 5822.854428639149, 5857.414258574108, 5870.530357571299, 5920.0, 5927.051671732502], "unit": "score", "name": "dojo.html", "value": 5691.94870653754}, {"lowerIsBetter": false, "replicates": [429.8452557079449, 460.99078018439633, 537.2961420539092, 569.6183557016799, 660.8248814064273, 26186.607200892002, 29466.852665736697, 29541.85229073854, 29544.965926192588, 29585.112446626583, 30515.0, 30876.38247235054, 31014.689853101463, 38663.0, 38836.80581597088, 9513.28650351223, 9665.855012174823, 9695.127438530531, 9697.466639334834, 9716.465594392306, 9468.431894086343, 9585.66450174244, 9596.520173991308, 9606.855897161548, 9613.615455381776, 9544.093311135432, 9620.27847911406, 9624.422534647909, 9635.0, 9635.132838044574, 9503.477308748015, 9592.184664303508, 9593.952030239805, 9699.51502424883, 9700.902990970071, 9515.524223788783, 9671.226301895831, 9683.612655493771, 9691.806163876683, 9697.224222062217, 38856.41715374272, 38936.0, 39186.80406597977, 39209.41185882214, 39212.60787392118, 3106.673799251091, 3141.167590588496, 3223.3069889973767, 3474.934089242192, 3569.5894972078286, 27513.587296190373, 28127.578086328722, 28239.43521129566, 28388.29029274264, 29184.124476265744, 2720.1295585412677, 2730.30377253801, 2770.7367800058964, 2808.213700163937, 2890.089621769136, 363365.0, 364072.0, 364266.0, 364358.0, 364613.3538664606, 61259.0, 61657.383426165165, 61825.0, 61990.9999999991, 62004.0, 64359.356406435334, 64549.0, 64654.0, 64728.0, 64849.0, 14959.700805983819, 16381.918090409472, 16561.585960351087, 16568.6686266274, 16592.668146637, 11176.658800943938, 11270.605528806453, 11274.774504509864, 11280.2667826591, 11286.830697539543, 16659.833401665826, 16716.563451602946, 19309.903450482656, 19353.12910919012, 19744.11151498186, 8540.359473039547, 8749.56252187388, 8760.693375731818, 8765.561721913879, 8796.824063518694, 857.4812238595684, 875.6322344615277, 970.3498655900563, 1096.2326371539955, 1150.4995327032768, 26783.330416739736, 31504.369912601618, 31735.52396714051, 31843.52234716481, 32349.35301293961, 852.8464876322322, 1018.2007124407305, 1075.639660713654, 1148.8506494155706, 1199.2264989081993, 14652.047616904867, 14653.780193297109, 14913.776293355608, 14931.0, 14956.700865982619, 668988.0, 674417.0, 677329.0, 678595.0, 679116.0, 49313.75343123333, 50153.0, 56262.718686406304, 57390.426095738505, 58242.7087864558, 1405.2622373253919, 1420.1479112532604, 1445.5085271007908, 1448.2251995182526, 1449.3405500497458, 25375.261636599516, 26939.730602694508, 28669.713302866705, 29367.26581835386, 29867.0, 50034.49965500298, 50659.0, 50678.74660626673, 50682.49317506778, 50743.74628126836, 496914.0, 503775.0, 504628.47685761336, 506181.0, 506983.0, 32154.67845321517, 32482.350352992336, 32512.349753004335, 32559.837200813843, 41462.58537414708, 42008.36987445252, 42880.57119428766, 44117.89705257266, 44146.77926610475, 44272.335914960655, 28580.0, 29626.703732962393, 35717.46423803593, 36897.44653830249, 37367.439488408236, 29404.85297573584, 35384.155157800065, 35760.821195893855, 36695.0, 36871.63128368789, 29796.85101574478, 35843.462348065324, 36035.819820900724, 36485.0, 36618.8169059153, 31362.686373135977, 32203.355932880742, 32660.183495411853, 32662.0, 32728.34543309168, 23736.0, 24130.82629496791, 24318.392040199138, 24734.752652473246, 24838.50322993566], "unit": "score", "name": "ext.html", "value": 19210.36852975987}, {"lowerIsBetter": false, "replicates": [364.42420974859715, 370.96475834795694, 372.3149405094627, 373.8411175250518, 377.5054678371332, 14487.565373038798, 15042.0, 18628.0, 18646.254149834007, 19254.614907701856, 19590.804091959075, 19768.901155494237, 19947.40157795265, 20978.89510552449, 20980.0, 4652.13935421948, 6420.967895160517, 6737.966310168442, 6750.729970801162, 6752.392284694377, 4802.4237091548885, 4857.805687772485, 7293.416526677879, 7559.319661230488, 7573.924260757404, 6506.674666266667, 6683.696679147568, 7295.635218239094, 7429.479936404454, 7547.43394245431, 7167.641617919109, 7434.479586428952, 7442.03253577037, 7457.440691948125, 7473.738419155331, 6942.548734332303, 6965.65171741416, 7074.575525468488, 7091.680874360666, 7155.391791697712, 20831.270905518235, 24461.26616201499, 25123.86942587588, 25198.874005629856, 25355.619665705028, 2313.3175713164655, 2338.1699496678602, 2578.187870820704, 2765.2810269329916, 3041.0844546918133, 12616.55842045524, 14843.257837108209, 15261.847381526153, 15456.227188640523, 16109.355625774955, 1842.4748946550303, 1902.391234804863, 1906.8379187769056, 1922.4713203868907, 2000.0699674651357, 109444.11148479678, 110703.9999999992, 111065.44467277692, 111371.44314278458, 112308.87691123148, 17921.014344211195, 18131.909340453214, 18331.725024124647, 18337.083145842655, 18359.449216523524, 26225.606615900775, 26546.203613891616, 26639.200823975312, 26691.33271668185, 26724.331891702474, 8233.917660823436, 10355.964403559583, 10358.964103589731, 10383.428911409945, 10465.895341046644, 8840.292776577859, 8855.070217627184, 8864.0692727264, 8918.821623567623, 8969.103089690978, 7203.057624460934, 7262.128544574685, 7886.802829929183, 8191.1808819118805, 8292.419530632798, 2748.7800975921878, 3197.713634751164, 3286.6877646623534, 3297.7856439331367, 3345.514900339437, 858.6994551906907, 865.2774932930947, 906.309732349164, 912.0879120879121, 987.7975015121883, 15129.546113616609, 16252.593685157966, 18238.90880545589, 18616.0, 18936.71594926077, 906.5829718329642, 907.2787134228304, 913.2785099771106, 927.6363745294407, 939.9765005874908, 10445.164386849186, 10555.466687994825, 10601.204909631808, 10947.397893115796, 11104.500297486633, 503131.0, 511572.0, 515424.0, 622571.0, 732635.0, 110538.0, 112485.0, 113649.43175284236, 118046.0, 118987.40506297586, 1092.3282181458505, 1132.2527132092944, 1135.914806389524, 1144.5936692474218, 1155.630198336541, 17717.911410442866, 17949.434557377786, 17952.012639304965, 18027.0, 18330.72503912469, 34062.0, 35516.82241588776, 46089.76955115203, 46239.30641040454, 46274.0, 44081.77959110184, 52748.193418668816, 61436.69281653563, 65268.673656631414, 67873.0, 6128.849761297261, 7243.927560724325, 7626.161122276434, 7729.574873382018, 7780.260875216845, 10281.897181028393, 10744.946275268574, 10767.246292759432, 10859.457027148454, 11418.942905285421, 8941.642334306554, 10382.560098377027, 10388.37669739818, 10481.37111773296, 10653.360798352123, 7822.295993360625, 10236.0, 10337.0696637303, 10394.272400931863, 10675.733106672085, 9266.44401335895, 9742.928277889285, 10044.698659040241, 10371.776933839636, 10734.946325268324, 7443.44174186949, 7626.313631773167, 7669.7315593953945, 7775.766726998199, 7803.258690424401, 9215.861762073708, 10627.0, 10727.302725322828, 10749.240802509023, 10816.891831081903], "unit": "score", "name": "jquery.html", "value": 10078.133892433323}, {"lowerIsBetter": false, "replicates": [1378.5864240727778, 1484.7995520604718, 1503.5263891874063, 1732.7574139620456, 1946.4355336952285, 7870.212978702134, 8066.516009039455, 8414.410991230608, 8559.743207703763, 8617.095205003478, 8404.495730256189, 8510.404271700969, 8612.440191387572, 8634.481931084123, 8635.0, 2163.242864997246, 2224.744154422238, 2464.790492808109, 2479.8636075015866, 2484.627305904111, 2247.8651280923195, 2350.106959355451, 2407.687000689908, 2408.3256688127353, 2413.734489206186, 2428.138011006094, 2449.473363226906, 2465.617829236462, 2470.147799009339, 2503.399184195798, 2468.0127948820436, 2475.121331927158, 2484.714257860351, 2494.4138127540105, 2495.4510007798253, 2463.408781892333, 2474.096954611554, 2484.167803785734, 2486.552420564298, 2492.950140997188, 8621.525816080113, 8766.474011559327, 8777.253933415603, 8781.253593444564, 8783.736487905373, 5376.838694839122, 5486.341639003305, 5507.091329930557, 5528.308961379827, 5528.391876893538, 3538.398472259722, 3608.6030536640947, 3666.7433279670436, 3677.5403074615674, 3681.1901381695984, 1016.8576399304103, 1031.9638812641522, 1043.243648354944, 1050.217587897014, 1066.4028144239173, 11860.644180674593, 11875.52497900083, 11882.524699012029, 11885.40572971348, 11896.762064758743, 4803.0, 4850.442199147073, 4932.0, 4950.0, 4951.752412379366, 8504.192101750325, 10205.183585313158, 10205.438700871524, 10208.489575521342, 10244.897551024544, 5425.348958124971, 5433.212184233264, 5456.863578410572, 5477.04151773438, 5487.6981766003255, 4880.194767863334, 4907.803687852517, 4956.157453232959, 4960.982998485302, 5077.8730531737, 3634.200475895299, 3722.050877026341, 3907.27715372657, 3951.130751234724, 3990.182012687392, 1282.4870051979096, 1292.528227197085, 1297.8053292006086, 1315.151727135992, 1332.3404914567352, 1272.1349482352089, 1300.811382349573, 1326.310318634324, 1326.476041963419, 1360.177092858826, 6728.461723062143, 7973.920260797434, 8014.879776803353, 8093.473924194908, 8133.674653013932, 1162.1806626328587, 1170.6839153428698, 1180.5808937827119, 1182.6878452625097, 1202.8632941870023, 6216.2540495140875, 6226.128342032119, 6278.215223097113, 6286.277078135981, 6295.527835412271, 10412.5834966602, 10772.892271077346, 10913.672589822318, 11186.0, 11201.215914886043, 10364.585416583403, 10578.206634502289, 10651.360918344924, 10752.301100428447, 10926.781464370668, 8214.219649133323, 8255.298299644597, 8272.958635206785, 8318.792030199173, 8461.40770146084, 7781.727639532589, 7843.607819609111, 7895.01312335958, 7923.286904178652, 7928.7621371358955, 9238.584263708284, 9584.9041509584, 9649.324547281623, 9742.659006934724, 9753.122219000325, 9688.660896868576, 10005.449700266556, 10049.598016079275, 10058.54736536843, 10060.446675432922, 7463.888041679271, 7474.289942455458, 7520.548767073993, 7537.660805263667, 7576.28025337592, 7212.74755383559, 8090.393220508367, 8168.183181681784, 8187.71343002992, 8198.549079800669, 6561.5236571772875, 7597.430192735677, 7677.347425468898, 7827.060752709711, 7834.255745704149, 7445.4415918805225, 7469.887951680837, 7565.924340756742, 7645.120811106794, 7697.307242347992, 7433.8141546461775, 7692.115406728074, 7746.225377462209, 7748.961255193688, 7749.070111586646, 6944.201416837129, 7013.088298521159, 7016.298370163147, 7023.438124949889, 7076.363127318566, 6361.745530178926, 6761.898571521529, 7151.928480715334, 7169.5698258104685, 7189.029481020205], "unit": "score", "name": "mootools.html", "value": 4942.445600078982}, {"lowerIsBetter": false, "replicates": [319.50476761020417, 328.3334830294502, 333.0939843625339, 337.30346833788224, 340.46546921333515, 5267.762950667219, 6295.874082518359, 6464.385883341081, 6479.287278399373, 6504.121943537627, 5172.45689202633, 5362.570994320455, 6211.0, 6259.186305780254, 6369.713362898669, 3904.2777086239134, 4738.147133515966, 4782.545658162469, 4795.544423279783, 4801.127560251487, 4521.706089104214, 4646.883827904313, 4684.250519916814, 4783.71297722136, 4797.0405918816205, 4633.768311584424, 4731.769739867642, 4734.029523947583, 4740.454847692507, 4763.428388593356, 4720.315554244616, 4740.857774266778, 4746.810127594892, 4764.523547645208, 4770.61835053195, 3680.0799800049986, 3769.4345848122725, 4085.611866872642, 4094.1402305515876, 4095.1400205956784, 5862.970685146547, 6061.727222275008, 6102.847428814271, 6130.96934515329, 6159.076138579204, 5473.825181394821, 5486.3690675572425, 5490.835274941758, 5495.917561236584, 5496.477834605706, 4943.703377797307, 6871.931280687229, 6875.346842049998, 6880.8967865482055, 6911.205211400703, 4315.719478233905, 4455.264881294583, 4458.8439404620685, 4468.709533880287, 4481.619062379702, 7147.106611673541, 7270.7091716331815, 7282.417406607458, 7298.270172982712, 7298.708051677927, 4551.47658019332, 4555.681102322806, 4556.703814252063, 4564.794584243717, 4569.428821397325, 4626.83806066786, 4629.888826681639, 4645.6980296280635, 4645.723595438279, 4646.163690535736, 5266.183741520071, 5466.34403871538, 5472.315960504937, 5472.425395333433, 5486.835394938158, 5656.377798442168, 6883.931160688429, 6937.0, 6953.061336719579, 6953.930460695429, 1580.257279078831, 1605.1813575076794, 1605.5504458751568, 1605.8394160583848, 1608.6300150965344, 949.3259785552335, 983.2036050798876, 1014.852846337277, 1024.3085917005992, 1048.6067724603274, 6440.774572889926, 6443.452306553995, 6454.838629034311, 6482.222133344029, 6485.319041500669, 6890.069840571559, 7061.435085193172, 7087.114110736158, 7166.032585600981, 7220.205777364486, 6198.88329663408, 6422.710978006001, 6435.742570297136, 6439.67801609927, 6460.903086453707, 3726.1802403471193, 3763.6048214937587, 3766.37854753968, 3767.3407153747985, 3773.8490460381827, 7458.881167824869, 7517.962410187914, 7581.97643318156, 7604.8479030419085, 7624.390048796083, 7201.567905925556, 7450.552966822008, 7500.324970752658, 7510.586917719578, 7519.210482899326, 7514.511556748794, 7520.6239688015385, 7522.962385188039, 7524.2851929066655, 7528.962355188299, 7202.315780000891, 7256.673449694882, 7269.382102521134, 7282.271772822675, 7294.796358600772, 5791.420857914343, 6886.311368863074, 7166.605836679033, 7173.605451700207, 7177.138743350832, 7576.24237576238, 7576.28025337592, 7577.696892124253, 7579.166291707797, 7583.658735356812, 4702.0360826031265, 4747.881302967454, 4753.239481682914, 4760.0241950399395, 4761.571458568746, 6865.622390768555, 7119.964400177966, 7146.571205727673, 7151.356377926011, 7152.962820391118, 6912.0, 6914.377706006484, 6925.0, 6935.3411425914455, 6936.20233673134, 6051.940910340585, 6902.171739391305, 6902.585844849325, 6913.098897803145, 6914.0320355151325, 5511.9527289814805, 6312.747490100344, 6739.898901516383, 6763.729450821912, 6767.0, 5588.552915766648, 5716.371199168005, 6901.447884169354, 6901.654917254017, 6907.34380233877, 6212.81361559154, 6538.378854008862, 6769.898451523132, 6782.1861376635115, 6792.490563207878], "unit": "score", "name": "prototype.html", "value": 5002.762455376956}, {"lowerIsBetter": false, "replicates": [647.562895045844, 739.5636574421092, 754.3814072460581, 771.2249189564487, 777.7472321495516, 14442.422303107876, 14548.563543093698, 14647.0, 15273.236338183102, 15447.613809654764, 13949.651258718537, 14044.087134336261, 14052.859471405283, 14065.0, 14077.577672669837, 716.9784906452788, 872.5462759365142, 888.524639317965, 889.2130464538865, 889.8932128144631, 720.9387202087829, 728.9562626242416, 866.6143566113083, 879.8504254276788, 880.9119088091172, 899.6536333511613, 919.2278486071698, 922.423485321674, 923.9907600924006, 924.191332583989, 743.8252010777463, 754.6264599023464, 906.5014242166782, 913.3834661603457, 918.2195134135965, 561.9859503512404, 675.5473832532215, 684.1721516964479, 685.3112621815094, 687.3470203306829, 14912.701745965129, 15013.924930375279, 15039.398424063025, 15060.171690557016, 15073.321700523393, 12421.689457763538, 12518.37408129599, 12679.302638354888, 12718.936405318007, 12730.0, 9944.602215911355, 10017.248706347053, 10019.649312274036, 10021.59913603455, 10194.082532572103, 3459.5848498180126, 3497.24809166028, 3498.3003399320237, 3498.8250587470525, 3505.2989402119424, 75400.0, 75922.62038689827, 77732.27937022234, 78019.0, 78326.34226090732, 9543.188828949616, 9615.375000624937, 9677.467739274267, 9762.17021553176, 10313.12338451225, 21396.358109256747, 21424.892875535523, 21434.678479822815, 21515.0, 21556.353309400743, 6317.399847014526, 7394.519356241827, 7511.549307041595, 7579.393648508106, 7769.572673503011, 4202.0, 4208.516020657602, 4234.87295381139, 4284.057507348379, 4448.666350023761, 3470.3753324401346, 3514.8594056237466, 3516.0506663200795, 3522.806245656462, 3526.770759900598, 627.4760574919993, 644.7292137302344, 651.3876955661663, 661.507177153024, 666.5733930284622, 427.2224551316636, 559.4433538629008, 601.9578629495893, 616.9568130230931, 631.422248642487, 7549.886751698729, 8694.826103477895, 9148.725538233864, 9304.209142222986, 9390.5304734763, 493.8370337788521, 521.7521677203298, 590.1737567405667, 590.2415396215843, 626.9028300613412, 4230.386593943861, 4434.157510073141, 4450.554944505524, 4472.9261096488935, 4496.752678602708, 83302.5834870834, 85038.57480712557, 85117.0, 85122.0, 86293.0, 70865.0, 75133.0, 75356.0, 75411.96704263646, 76555.8516622251, 65052.0, 65791.67104164448, 66540.0, 67160.32839671736, 67468.0, 8894.73315800527, 8978.37151399422, 9029.683961061332, 9090.54547272647, 9158.862617060882, 43607.0, 44393.33409998917, 45202.54797451983, 45332.0, 47486.762566186946, 62139.689301553204, 63142.684286578275, 63352.36647633649, 63941.0, 66348.6682566584, 11412.31526108436, 11445.542178312775, 11581.942090289494, 11606.30362178272, 11672.474738636613, 11731.706707332043, 12238.082143839425, 12374.071944604011, 12669.0, 12828.807567886675, 11255.324680518868, 11569.36368499707, 11716.70708232301, 12235.69410764738, 12254.326012069421, 11314.83027754568, 11583.586445119503, 11754.941225293818, 11928.761424771283, 12024.278543287432, 11315.114645765278, 11370.31778093317, 11452.312861228353, 11693.824592631288, 12242.143049986771, 9108.635654574007, 9217.493037882981, 9303.76740581491, 9483.762905927131, 9546.618135274512, 8679.652813887375, 9046.321525885453, 9616.423014619146, 10063.597456101674, 10092.545835437277], "unit": "score", "name": "yui.html", "value": 6844.838723038149}], "name": "dromaeo_css", "value": 7558.829183298122}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 108.0, 114.0, 111.0, 110.0, 110.0, 118.0, 159.0, 164.0, 111.0], "unit": "score", "name": "ai-astar", "value": 121.5}, {"lowerIsBetter": true, "replicates": [159.0, 120.0, 147.0, 160.0, 119.0, 143.0, 142.0, 119.0, 159.0, 118.0], "unit": "score", "name": "audio-beat-detection", "value": 138.6}, {"lowerIsBetter": true, "replicates": [185.0, 186.0, 186.0, 185.0, 185.0, 188.0, 186.0, 183.0, 181.0, 183.0], "unit": "score", "name": "audio-dft", "value": 184.8}, {"lowerIsBetter": true, "replicates": [73.0, 76.0, 98.0, 79.0, 57.0, 57.0, 59.0, 82.0, 93.0, 82.0], "unit": "score", "name": "audio-fft", "value": 75.6}, {"lowerIsBetter": true, "replicates": [92.0, 96.0, 130.0, 79.0, 79.0, 83.0, 112.0, 77.0, 78.0, 114.0], "unit": "score", "name": "audio-oscillator", "value": 94.0}, {"lowerIsBetter": true, "replicates": [85.0, 90.0, 84.0, 89.0, 84.0, 89.0, 83.0, 90.0, 84.0, 90.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 86.8}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 94.0, 93.0, 94.0, 101.0, 142.0, 93.0, 93.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 98.8}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 85.0, 86.0, 85.0, 86.0, 83.0, 87.0, 86.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 85.2}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 52.0, 56.0, 54.0, 53.0, 56.0, 66.0, 53.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 55.5}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 67.0, 78.0, 75.0, 71.0, 70.0, 69.0, 71.0, 76.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.8}, {"lowerIsBetter": true, "replicates": [82.0, 84.0, 82.0, 83.0, 81.0, 83.0, 82.0, 82.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.7}, {"lowerIsBetter": true, "replicates": [132.0, 128.0, 131.0, 112.0, 126.0, 122.0, 124.0, 125.0, 119.0, 141.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.0}, {"lowerIsBetter": true, "replicates": [137.0, 127.0, 137.0, 137.0, 137.0, 125.0, 141.0, 169.0, 118.0, 160.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.8}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 66.0, 66.0, 66.0, 68.0, 70.0, 89.0, 97.0, 96.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 75.2}], "name": "kraken", "value": 1434.3}]} 05:16:26 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1434.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7558.83"}}} 05:16:26 INFO - Return code: 0 05:16:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:16:26 INFO - # TBPL SUCCESS # 05:16:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:16:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:16:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:16:26 INFO - 2016-02-05 05:16:26.786 screenresolution[6864:117049] starting screenresolution argv=screenresolution get 05:16:26 INFO - 2016-02-05 05:16:26.788 screenresolution[6864:117049] Display 0: 1600x1200x32@60 05:16:26 INFO - 2016-02-05 05:16:26.794 screenresolution[6865:117052] starting screenresolution argv=screenresolution list 05:16:26 INFO - Available Modes on Display 0 05:16:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:16:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:16:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:16:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:16:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:16:27 INFO - Intel Iris: 05:16:27 INFO - Chipset Model: Intel Iris 05:16:27 INFO - Type: GPU 05:16:27 INFO - Bus: Built-In 05:16:27 INFO - VRAM (Dynamic, Max): 1536 MB 05:16:27 INFO - Vendor: Intel (0x8086) 05:16:27 INFO - Device ID: 0x0a2e 05:16:27 INFO - Revision ID: 0x0009 05:16:27 INFO - Displays: 05:16:27 INFO - Display: 05:16:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:16:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:16:27 INFO - Display Serial Number: 1600x1200 60 05:16:27 INFO - Main Display: Yes 05:16:27 INFO - Mirror: Off 05:16:27 INFO - Online: Yes 05:16:27 INFO - Rotation: Supported 05:16:27 INFO - Return code: 0 05:16:27 INFO - Running post-action listener: _resource_record_post_action 05:16:27 INFO - Running post-run listener: _resource_record_post_run 05:16:28 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 0; Write bytes: 707420672; Read time: 0; Write time: 1808 05:16:28 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 399280640; Write bytes: 392967680; Read time: 30206; Write time: 704 05:16:28 INFO - run-tests - Wall time: 1176s; CPU: 53.0%; Read bytes: 0; Write bytes: 298716160; Read time: 0; Write time: 1068 05:16:28 INFO - Running post-run listener: _upload_blobber_files 05:16:28 INFO - Blob upload gear active. 05:16:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:16:28 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:16:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:16:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:16:28 INFO - (blobuploader) - INFO - Open directory for files ... 05:16:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:16:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:16:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:16:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:16:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:16:29 INFO - (blobuploader) - INFO - Done attempting. 05:16:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:16:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:16:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:16:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:16:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:16:30 INFO - (blobuploader) - INFO - Done attempting. 05:16:30 INFO - (blobuploader) - INFO - Iteration through files over. 05:16:30 INFO - Return code: 0 05:16:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:16:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:16:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/39d751d7a1f685f4afce9879959674780f4dd4bed7efcc3b490a68433256cea9f68bb1080d3378c4409e596d505f70035104a06f772541b6b9d9550f2b4bb62f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0fb47f9c1f6fae4690087551957728370faf3a7ca7bbd508fd4b2753632289ad357cc4ece8764fc702a444614c0b8c8317d30c460fd2ff4a6546534d39652c9"} 05:16:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:16:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:16:30 INFO - Contents: 05:16:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/39d751d7a1f685f4afce9879959674780f4dd4bed7efcc3b490a68433256cea9f68bb1080d3378c4409e596d505f70035104a06f772541b6b9d9550f2b4bb62f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0fb47f9c1f6fae4690087551957728370faf3a7ca7bbd508fd4b2753632289ad357cc4ece8764fc702a444614c0b8c8317d30c460fd2ff4a6546534d39652c9"} 05:16:30 INFO - Running post-run listener: copy_logs_to_upload_dir 05:16:30 INFO - Copying logs to upload dir... 05:16:30 INFO - mkdir: /builds/slave/test/build/upload/logs 05:16:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.844319 ========= master_lag: 1.59 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-02-05 05:16:32.075733) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 7 secs) (at 2016-02-05 05:16:32.079944) ========= 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.4sxm4UcnHf/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.vIRSkljFCA/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/39d751d7a1f685f4afce9879959674780f4dd4bed7efcc3b490a68433256cea9f68bb1080d3378c4409e596d505f70035104a06f772541b6b9d9550f2b4bb62f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0fb47f9c1f6fae4690087551957728370faf3a7ca7bbd508fd4b2753632289ad357cc4ece8764fc702a444614c0b8c8317d30c460fd2ff4a6546534d39652c9"} build_url:https://queue.taskcluster.net/v1/task/a4faPleuRCWCJf3q-BupRQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011557 build_url: 'https://queue.taskcluster.net/v1/task/a4faPleuRCWCJf3q-BupRQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/39d751d7a1f685f4afce9879959674780f4dd4bed7efcc3b490a68433256cea9f68bb1080d3378c4409e596d505f70035104a06f772541b6b9d9550f2b4bb62f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0fb47f9c1f6fae4690087551957728370faf3a7ca7bbd508fd4b2753632289ad357cc4ece8764fc702a444614c0b8c8317d30c460fd2ff4a6546534d39652c9"}' ========= master_lag: 7.27 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 7 secs) (at 2016-02-05 05:16:39.363650) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-05 05:16:39.363993) ========= 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.4sxm4UcnHf/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.vIRSkljFCA/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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.005518 ========= master_lag: 0.10 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-05 05:16:39.470351) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-05 05:16:39.470628) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-05 05:16:39.585124) ========= ========= Total master_lag: 9.13 =========