builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0139 starttime: 1460491909.31 results: success (0) buildid: 20160412121248 builduid: cbcff516372349eb8759463f130dd3cc revision: 4cf4428ef3945efd64b92e50be56ecc608a2b7b5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-12 13:11:49.305958) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-12 13:11:49.306387) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-12 13:11:49.306731) ========= 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.BCisJWNLtS/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.y1SPfZAJ5V/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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.005546 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-12 13:11:49.329392) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-12 13:11:49.332712) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-12 13:11:49.349344) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 13:11:49.349697) ========= 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.BCisJWNLtS/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.y1SPfZAJ5V/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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.005315 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 13:11:49.397431) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-12 13:11:49.400750) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-12 13:11:49.401118) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 13:11:49.401396) ========= 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.BCisJWNLtS/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.y1SPfZAJ5V/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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-04-12 13:11:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.12M=0.001s 2016-04-12 13:11:49 (8.12 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.168740 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 13:11:49.586935) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 13:11:49.587244) ========= 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.BCisJWNLtS/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.y1SPfZAJ5V/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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.020909 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 13:11:49.635413) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-12 13:11:49.638777) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4cf4428ef3945efd64b92e50be56ecc608a2b7b5 --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 4cf4428ef3945efd64b92e50be56ecc608a2b7b5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BCisJWNLtS/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.y1SPfZAJ5V/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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-04-12 13:11:49,715 truncating revision to first 12 chars 2016-04-12 13:11:49,715 Setting DEBUG logging. 2016-04-12 13:11:49,715 attempt 1/10 2016-04-12 13:11:49,716 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4cf4428ef394?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-12 13:11:50,660 unpacking tar archive at: fx-team-4cf4428ef394/testing/mozharness/ program finished with exit code 0 elapsedTime=1.189254 ========= master_lag: 0.10 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-12 13:11:50.926788) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-12 13:11:50.927134) ========= echo 4cf4428ef3945efd64b92e50be56ecc608a2b7b5 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'4cf4428ef3945efd64b92e50be56ecc608a2b7b5'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BCisJWNLtS/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.y1SPfZAJ5V/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 4cf4428ef3945efd64b92e50be56ecc608a2b7b5 program finished with exit code 0 elapsedTime=0.005272 script_repo_revision: '4cf4428ef3945efd64b92e50be56ecc608a2b7b5' ========= master_lag: 0.02 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-12 13:11:50.952465) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-12 13:11:50.952773) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-12 13:11:50.991923) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-04-12 13:11:50.992271) ========= /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.BCisJWNLtS/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.y1SPfZAJ5V/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 13:11:51 INFO - MultiFileLogger online at 20160412 13:11:51 in /builds/slave/test 13:11:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 13:11:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:11:51 INFO - {'append_to_log': False, 13:11:51 INFO - 'base_work_dir': '/builds/slave/test', 13:11:51 INFO - 'blob_upload_branch': 'Fx-Team', 13:11:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:11:51 INFO - 'branch': 'Fx-Team', 13:11:51 INFO - 'buildbot_json_path': 'buildprops.json', 13:11:51 INFO - 'config_files': ('talos/mac_config.py',), 13:11:51 INFO - 'default_actions': ('clobber', 13:11:51 INFO - 'read-buildbot-config', 13:11:51 INFO - 'download-and-extract', 13:11:51 INFO - 'populate-webroot', 13:11:51 INFO - 'create-virtualenv', 13:11:51 INFO - 'install', 13:11:51 INFO - 'run-tests'), 13:11:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:11:51 INFO - 'download_minidump_stackwalk': True, 13:11:51 INFO - 'download_symbols': 'ondemand', 13:11:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:11:51 INFO - 'tooltool.py': '/tools/tooltool.py', 13:11:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:11:51 INFO - '/tools/misc-python/virtualenv.py')}, 13:11:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:11:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:11:51 INFO - 'installer_path': 'installer.exe', 13:11:51 INFO - 'log_level': 'info', 13:11:51 INFO - 'log_name': 'talos', 13:11:51 INFO - 'log_to_console': True, 13:11:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:11:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:11:51 INFO - 'opt_config_files': (), 13:11:51 INFO - 'pip_index': False, 13:11:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:11:51 INFO - 'cmd': ('bash', 13:11:51 INFO - '-c', 13:11:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:11:51 INFO - 'enabled': True, 13:11:51 INFO - 'halt_on_failure': False, 13:11:51 INFO - 'name': 'check_screen_resolution'},), 13:11:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:11:51 INFO - 'cmd': ('bash', 13:11:51 INFO - '-c', 13:11:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:11:51 INFO - 'enabled': True, 13:11:51 INFO - 'halt_on_failure': False, 13:11:51 INFO - 'name': 'check_screen_resolution'},), 13:11:51 INFO - 'run_cmd_checks_enabled': True, 13:11:51 INFO - 'sps_profile': False, 13:11:51 INFO - 'sps_profile_interval': 0, 13:11:51 INFO - 'suite': 'dromaeojs', 13:11:51 INFO - 'system_bits': '32', 13:11:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:11:51 INFO - 'title': 't-yosemite-r7-0139', 13:11:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:11:51 INFO - 'use_talos_json': True, 13:11:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:11:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:11:51 INFO - 'work_dir': 'build'} 13:11:51 INFO - ##### 13:11:51 INFO - ##### Running clobber step. 13:11:51 INFO - ##### 13:11:51 INFO - Running pre-action listener: _resource_record_pre_action 13:11:51 INFO - Running main action method: clobber 13:11:51 INFO - rmtree: /builds/slave/test/build 13:11:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:11:52 INFO - Running post-action listener: _resource_record_post_action 13:11:52 INFO - ##### 13:11:52 INFO - ##### Running read-buildbot-config step. 13:11:52 INFO - ##### 13:11:52 INFO - Running pre-action listener: _resource_record_pre_action 13:11:52 INFO - Running main action method: read_buildbot_config 13:11:52 INFO - Using buildbot properties: 13:11:52 INFO - { 13:11:52 INFO - "project": "", 13:11:52 INFO - "product": "firefox", 13:11:52 INFO - "script_repo_revision": "production", 13:11:52 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 13:11:52 INFO - "repository": "", 13:11:52 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 13:11:52 INFO - "buildid": "20160412121248", 13:11:52 INFO - "pgo_build": "False", 13:11:52 INFO - "basedir": "/builds/slave/test", 13:11:52 INFO - "buildnumber": 707, 13:11:52 INFO - "slavename": "t-yosemite-r7-0139", 13:11:52 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 13:11:52 INFO - "platform": "yosemite_r7", 13:11:52 INFO - "scheduler": "tests-fx-team-macosx64-talos", 13:11:52 INFO - "branch": "fx-team", 13:11:52 INFO - "repo_path": "integration/fx-team", 13:11:52 INFO - "revision": "4cf4428ef3945efd64b92e50be56ecc608a2b7b5", 13:11:52 INFO - "stage_platform": "macosx64", 13:11:52 INFO - "builduid": "cbcff516372349eb8759463f130dd3cc", 13:11:52 INFO - "slavebuilddir": "test" 13:11:52 INFO - } 13:11:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/fM9UUN2aTjePuPdqcuqu6A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 13:11:52 INFO - Running post-action listener: _resource_record_post_action 13:11:52 INFO - ##### 13:11:52 INFO - ##### Running download-and-extract step. 13:11:52 INFO - ##### 13:11:52 INFO - Running pre-action listener: _resource_record_pre_action 13:11:52 INFO - Running main action method: download_and_extract 13:11:52 INFO - mkdir: /builds/slave/test/build/tests 13:11:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:52 INFO - https://queue.taskcluster.net/v1/task/fM9UUN2aTjePuPdqcuqu6A/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 13:11:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fM9UUN2aTjePuPdqcuqu6A/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 13:11:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fM9UUN2aTjePuPdqcuqu6A/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 13:11:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fM9UUN2aTjePuPdqcuqu6A/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 13:11:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fM9UUN2aTjePuPdqcuqu6A/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 13:11:53 INFO - Downloaded 1199 bytes. 13:11:53 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 13:11:53 INFO - Using the following test package requirements: 13:11:53 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 13:11:53 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 13:11:53 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 13:11:53 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 13:11:53 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 13:11:53 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 13:11:53 INFO - u'jsshell-mac.zip'], 13:11:53 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 13:11:53 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 13:11:53 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 13:11:53 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 13:11:53 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 13:11:53 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 13:11:53 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 13:11:53 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 13:11:53 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 13:11:53 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 13:11:53 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 13:11:53 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:53 INFO - https://queue.taskcluster.net/v1/task/fM9UUN2aTjePuPdqcuqu6A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:11:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fM9UUN2aTjePuPdqcuqu6A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 13:11:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fM9UUN2aTjePuPdqcuqu6A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 13:11:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fM9UUN2aTjePuPdqcuqu6A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 13:11:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fM9UUN2aTjePuPdqcuqu6A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:11:55 INFO - Downloaded 18021291 bytes. 13:11:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:11:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 13:11:58 INFO - Return code: 0 13:11:58 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 13:11:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:58 INFO - https://queue.taskcluster.net/v1/task/fM9UUN2aTjePuPdqcuqu6A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:11:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fM9UUN2aTjePuPdqcuqu6A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 13:11:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fM9UUN2aTjePuPdqcuqu6A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 13:11:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fM9UUN2aTjePuPdqcuqu6A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 13:11:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fM9UUN2aTjePuPdqcuqu6A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:11:59 INFO - Downloaded 18021291 bytes. 13:11:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:11:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 13:12:02 INFO - Return code: 0 13:12:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:12:02 INFO - https://queue.taskcluster.net/v1/task/fM9UUN2aTjePuPdqcuqu6A/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 13:12:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fM9UUN2aTjePuPdqcuqu6A/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 13:12:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fM9UUN2aTjePuPdqcuqu6A/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 13:12:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fM9UUN2aTjePuPdqcuqu6A/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 13:12:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fM9UUN2aTjePuPdqcuqu6A/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 13:12:04 INFO - Downloaded 10841076 bytes. 13:12:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:12:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 13:12:04 INFO - Return code: 0 13:12:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:12:04 INFO - https://queue.taskcluster.net/v1/task/fM9UUN2aTjePuPdqcuqu6A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 13:12:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fM9UUN2aTjePuPdqcuqu6A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 13:12:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fM9UUN2aTjePuPdqcuqu6A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 13:12:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fM9UUN2aTjePuPdqcuqu6A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 13:12:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fM9UUN2aTjePuPdqcuqu6A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 13:12:07 INFO - Downloaded 108924819 bytes. 13:12:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fM9UUN2aTjePuPdqcuqu6A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 13:12:07 INFO - mkdir: /builds/slave/test/properties 13:12:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:12:07 INFO - Writing to file /builds/slave/test/properties/build_url 13:12:07 INFO - Contents: 13:12:07 INFO - build_url:https://queue.taskcluster.net/v1/task/fM9UUN2aTjePuPdqcuqu6A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 13:12:09 INFO - Running post-action listener: _resource_record_post_action 13:12:09 INFO - Running post-action listener: set_extra_try_arguments 13:12:09 INFO - ##### 13:12:09 INFO - ##### Running populate-webroot step. 13:12:09 INFO - ##### 13:12:09 INFO - Running pre-action listener: _resource_record_pre_action 13:12:09 INFO - Running main action method: populate_webroot 13:12:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:12:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:12:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:12:09 INFO - '--tppagecycles', 13:12:09 INFO - '7'], 13:12:09 INFO - 'tests': ['tsvgm']}}, 13:12:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:12:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:12:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:12:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:12:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:12:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:12:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:12:09 INFO - 'talos_options': ['--disable-e10s'], 13:12:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:12:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:12:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:12:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:12:09 INFO - 'talos_options': ['--disable-e10s'], 13:12:09 INFO - 'tests': ['damp', 'tps']}, 13:12:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:12:09 INFO - 'tests': ['damp', 'tps']}, 13:12:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:12:09 INFO - 'tests': ['dromaeo_dom']}, 13:12:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:12:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:12:09 INFO - 'tests': ['a11yr', 13:12:09 INFO - 'ts_paint', 13:12:09 INFO - 'tpaint', 13:12:09 INFO - 'sessionrestore', 13:12:09 INFO - 'sessionrestore_no_auto_restore', 13:12:09 INFO - 'tabpaint']}, 13:12:09 INFO - 'other-e10s': {'tests': ['a11yr', 13:12:09 INFO - 'ts_paint', 13:12:09 INFO - 'tpaint', 13:12:09 INFO - 'sessionrestore', 13:12:09 INFO - 'sessionrestore_no_auto_restore', 13:12:09 INFO - 'tabpaint']}, 13:12:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:12:09 INFO - 'ts_paint', 13:12:09 INFO - 'tpaint', 13:12:09 INFO - 'sessionrestore', 13:12:09 INFO - 'sessionrestore_no_auto_restore', 13:12:09 INFO - 'tabpaint']}, 13:12:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:12:09 INFO - 'ts_paint', 13:12:09 INFO - 'tpaint', 13:12:09 INFO - 'sessionrestore', 13:12:09 INFO - 'sessionrestore_no_auto_restore', 13:12:09 INFO - 'tabpaint']}, 13:12:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:12:09 INFO - 'tests': ['a11yr', 13:12:09 INFO - 'ts_paint', 13:12:09 INFO - 'tpaint', 13:12:09 INFO - 'sessionrestore', 13:12:09 INFO - 'sessionrestore_no_auto_restore', 13:12:09 INFO - 'tabpaint']}, 13:12:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:12:09 INFO - 'tests': ['a11yr', 13:12:09 INFO - 'ts_paint', 13:12:09 INFO - 'tpaint', 13:12:09 INFO - 'sessionrestore', 13:12:09 INFO - 'sessionrestore_no_auto_restore', 13:12:09 INFO - 'tabpaint']}, 13:12:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:12:09 INFO - 'tests': ['tsvgx', 13:12:09 INFO - 'tsvgr_opacity', 13:12:09 INFO - 'tart', 13:12:09 INFO - 'tscrollx', 13:12:09 INFO - 'cart']}, 13:12:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:12:09 INFO - 'tsvgr_opacity', 13:12:09 INFO - 'tart', 13:12:09 INFO - 'tscrollx', 13:12:09 INFO - 'cart']}, 13:12:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:12:09 INFO - 'talos_options': ['--disable-e10s'], 13:12:09 INFO - 'tests': ['tp5o']}, 13:12:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:12:09 INFO - 'tests': ['tp5o']}, 13:12:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:12:09 INFO - 'talos_options': ['--disable-e10s', 13:12:09 INFO - '--xperf_path', 13:12:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:12:09 INFO - 'tests': ['tp5n']}, 13:12:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:12:09 INFO - 'talos_options': ['--xperf_path', 13:12:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:12:09 INFO - 'tests': ['tp5n']}}, 13:12:09 INFO - 'talos.zip': {'path': '', 13:12:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:12:09 INFO - Running post-action listener: _resource_record_post_action 13:12:09 INFO - ##### 13:12:09 INFO - ##### Running create-virtualenv step. 13:12:09 INFO - ##### 13:12:09 INFO - Running pre-action listener: _resource_record_pre_action 13:12:09 INFO - Running main action method: create_virtualenv 13:12:09 INFO - Creating virtualenv /builds/slave/test/build/venv 13:12:09 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:12:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:12:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:12:09 INFO - Using real prefix '/tools/python27' 13:12:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:12:09 INFO - Installing distribute.............................................................................................................................................................................................done. 13:12:12 INFO - Installing pip.................done. 13:12:12 INFO - Return code: 0 13:12:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:12: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')]} 13:12:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:12:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12: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')]} 13:12:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:12:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105618a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105628420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa63b453b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054b7e00>, '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 0x1052e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054b2b20>, '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.BCisJWNLtS/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.y1SPfZAJ5V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:12: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', 'pip>=1.5'] in /builds/slave/test/build 13:12: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 pip>=1.5 13:12:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BCisJWNLtS/Render', 13:12:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:12:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:12:12 INFO - 'HOME': '/Users/cltbld', 13:12:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:12:12 INFO - 'LOGNAME': 'cltbld', 13:12:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:12 INFO - 'MOZ_NO_REMOTE': '1', 13:12:12 INFO - 'NO_EM_RESTART': '1', 13:12:12 INFO - 'PAGER': '/bin/cat', 13:12:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:12:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:12 INFO - 'PWD': '/builds/slave/test', 13:12:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:12:12 INFO - 'SHELL': '/bin/bash', 13:12:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.y1SPfZAJ5V/Listeners', 13:12:12 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 13:12:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:12:12 INFO - 'USER': 'cltbld', 13:12:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:12:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:12:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:12 INFO - 'XPC_FLAGS': '0x0', 13:12:12 INFO - 'XPC_SERVICE_NAME': '0', 13:12:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:12:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:12:12 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:12:12 INFO - Cleaning up... 13:12:12 INFO - Return code: 0 13:12:12 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:12: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')]} 13:12:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:12:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12: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')]} 13:12:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:12:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12: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', '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 0x105618a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105628420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa63b453b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054b7e00>, '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 0x1052e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054b2b20>, '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.BCisJWNLtS/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.y1SPfZAJ5V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:12: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', 'psutil>=0.7.1'] in /builds/slave/test/build 13:12: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 psutil>=0.7.1 13:12:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BCisJWNLtS/Render', 13:12:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:12:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:12:12 INFO - 'HOME': '/Users/cltbld', 13:12:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:12:12 INFO - 'LOGNAME': 'cltbld', 13:12:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:12 INFO - 'MOZ_NO_REMOTE': '1', 13:12:12 INFO - 'NO_EM_RESTART': '1', 13:12:12 INFO - 'PAGER': '/bin/cat', 13:12:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:12:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:12 INFO - 'PWD': '/builds/slave/test', 13:12:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:12:12 INFO - 'SHELL': '/bin/bash', 13:12:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.y1SPfZAJ5V/Listeners', 13:12:12 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 13:12:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:12:12 INFO - 'USER': 'cltbld', 13:12:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:12:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:12:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:12 INFO - 'XPC_FLAGS': '0x0', 13:12:12 INFO - 'XPC_SERVICE_NAME': '0', 13:12:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:12:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:12:13 INFO - Downloading/unpacking psutil>=0.7.1 13:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:12:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:12:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:12:16 INFO - Installing collected packages: psutil 13:12:16 INFO - Running setup.py install for psutil 13:12:16 INFO - building 'psutil._psutil_osx' extension 13:12:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 13:12:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 13:12:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 13:12:16 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 13:12:16 INFO - building 'psutil._psutil_posix' extension 13:12:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 13:12:16 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:12:16 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:12:16 INFO - ^ 13:12:16 INFO - 1 warning generated. 13:12:16 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 13:12:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:12:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:12:16 INFO - Successfully installed psutil 13:12:16 INFO - Cleaning up... 13:12:16 INFO - Return code: 0 13:12:16 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:12:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:12:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:12:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:12:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:16 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 0x105618a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105628420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa63b453b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054b7e00>, '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 0x1052e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054b2b20>, '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.BCisJWNLtS/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.y1SPfZAJ5V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:12:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 13:12:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 13:12:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BCisJWNLtS/Render', 13:12:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:12:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:12:16 INFO - 'HOME': '/Users/cltbld', 13:12:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:12:16 INFO - 'LOGNAME': 'cltbld', 13:12:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:16 INFO - 'MOZ_NO_REMOTE': '1', 13:12:16 INFO - 'NO_EM_RESTART': '1', 13:12:16 INFO - 'PAGER': '/bin/cat', 13:12:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:12:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:16 INFO - 'PWD': '/builds/slave/test', 13:12:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:12:16 INFO - 'SHELL': '/bin/bash', 13:12:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.y1SPfZAJ5V/Listeners', 13:12:16 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 13:12:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:12:16 INFO - 'USER': 'cltbld', 13:12:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:12:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:12:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:16 INFO - 'XPC_FLAGS': '0x0', 13:12:16 INFO - 'XPC_SERVICE_NAME': '0', 13:12:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:12:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:12:17 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:19 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:12:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:12:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:12:19 INFO - Installing collected packages: mozsystemmonitor 13:12:19 INFO - Running setup.py install for mozsystemmonitor 13:12:19 INFO - Successfully installed mozsystemmonitor 13:12:19 INFO - Cleaning up... 13:12:19 INFO - Return code: 0 13:12:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:12:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:12:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:12:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:12:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:19 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 0x105618a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105628420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa63b453b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054b7e00>, '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 0x1052e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054b2b20>, '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.BCisJWNLtS/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.y1SPfZAJ5V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:12:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:12:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:12:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BCisJWNLtS/Render', 13:12:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:12:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:12:19 INFO - 'HOME': '/Users/cltbld', 13:12:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:12:19 INFO - 'LOGNAME': 'cltbld', 13:12:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:19 INFO - 'MOZ_NO_REMOTE': '1', 13:12:19 INFO - 'NO_EM_RESTART': '1', 13:12:19 INFO - 'PAGER': '/bin/cat', 13:12:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:12:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:19 INFO - 'PWD': '/builds/slave/test', 13:12:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:12:19 INFO - 'SHELL': '/bin/bash', 13:12:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.y1SPfZAJ5V/Listeners', 13:12:19 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 13:12:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:12:19 INFO - 'USER': 'cltbld', 13:12:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:12:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:12:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:19 INFO - 'XPC_FLAGS': '0x0', 13:12:19 INFO - 'XPC_SERVICE_NAME': '0', 13:12:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:12:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:12:20 INFO - Downloading/unpacking blobuploader==1.2.4 13:12:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:22 INFO - Downloading blobuploader-1.2.4.tar.gz 13:12:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:12:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:12:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:12:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:12:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:23 INFO - Downloading docopt-0.6.1.tar.gz 13:12:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:12:23 INFO - Installing collected packages: blobuploader, requests, docopt 13:12:23 INFO - Running setup.py install for blobuploader 13:12:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:12:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:12:23 INFO - Running setup.py install for requests 13:12:24 INFO - Running setup.py install for docopt 13:12:24 INFO - Successfully installed blobuploader requests docopt 13:12:24 INFO - Cleaning up... 13:12:24 INFO - Return code: 0 13:12:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:12:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:12:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:12:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:12:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:12:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:24 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 0x105618a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105628420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa63b453b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054b7e00>, '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 0x1052e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054b2b20>, '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.BCisJWNLtS/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.y1SPfZAJ5V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:12:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:12:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:12:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BCisJWNLtS/Render', 13:12:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:12:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:12:24 INFO - 'HOME': '/Users/cltbld', 13:12:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:12:24 INFO - 'LOGNAME': 'cltbld', 13:12:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:24 INFO - 'MOZ_NO_REMOTE': '1', 13:12:24 INFO - 'NO_EM_RESTART': '1', 13:12:24 INFO - 'PAGER': '/bin/cat', 13:12:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:12:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:24 INFO - 'PWD': '/builds/slave/test', 13:12:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:12:24 INFO - 'SHELL': '/bin/bash', 13:12:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.y1SPfZAJ5V/Listeners', 13:12:24 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 13:12:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:12:24 INFO - 'USER': 'cltbld', 13:12:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:12:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:12:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:24 INFO - 'XPC_FLAGS': '0x0', 13:12:24 INFO - 'XPC_SERVICE_NAME': '0', 13:12:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:12:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:12:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:12:24 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-E8TyIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:12:25 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-ld9zYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:12:25 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-zParbf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:12:25 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-mjrWG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:12:25 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-faKZtk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:12:25 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-1owfOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:12:25 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-8cV_Iv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:12:25 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-UYkMkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:12:25 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-16b8JF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:12:25 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-PveS8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:12:25 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-Ebmlpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:12:26 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-9bZnW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:12:26 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-B3DYvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:12:26 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-ZMwz6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:12:26 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-UqI1fW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:12:26 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-qI4brQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:12:26 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-JS7MW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:12:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:12:26 INFO - Running setup.py install for manifestparser 13:12:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:12:26 INFO - Running setup.py install for mozcrash 13:12:26 INFO - Running setup.py install for mozdebug 13:12:27 INFO - Running setup.py install for mozdevice 13:12:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:12:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:12:27 INFO - Running setup.py install for mozfile 13:12:27 INFO - Running setup.py install for mozhttpd 13:12:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:12:27 INFO - Running setup.py install for mozinfo 13:12:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:12:27 INFO - Running setup.py install for mozInstall 13:12:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:12:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:12:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:12:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:12:27 INFO - Running setup.py install for mozleak 13:12:28 INFO - Running setup.py install for mozlog 13:12:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:12:28 INFO - Running setup.py install for moznetwork 13:12:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:12:28 INFO - Running setup.py install for mozprocess 13:12:28 INFO - Running setup.py install for mozprofile 13:12:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:12:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:12:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:12:28 INFO - Running setup.py install for mozrunner 13:12:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:12:28 INFO - Running setup.py install for mozscreenshot 13:12:28 INFO - Running setup.py install for moztest 13:12:29 INFO - Running setup.py install for mozversion 13:12:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:12:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:12:29 INFO - Cleaning up... 13:12:29 INFO - Return code: 0 13:12:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:12: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')]} 13:12:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:12:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12: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')]} 13:12:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:12:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:29 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 0x105618a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105628420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa63b453b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054b7e00>, '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 0x1052e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054b2b20>, '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.BCisJWNLtS/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.y1SPfZAJ5V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:12:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:12:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:12:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BCisJWNLtS/Render', 13:12:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:12:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:12:29 INFO - 'HOME': '/Users/cltbld', 13:12:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:12:29 INFO - 'LOGNAME': 'cltbld', 13:12:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:29 INFO - 'MOZ_NO_REMOTE': '1', 13:12:29 INFO - 'NO_EM_RESTART': '1', 13:12:29 INFO - 'PAGER': '/bin/cat', 13:12:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:12:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:29 INFO - 'PWD': '/builds/slave/test', 13:12:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:12:29 INFO - 'SHELL': '/bin/bash', 13:12:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.y1SPfZAJ5V/Listeners', 13:12:29 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 13:12:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:12:29 INFO - 'USER': 'cltbld', 13:12:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:12:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:12:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:29 INFO - 'XPC_FLAGS': '0x0', 13:12:29 INFO - 'XPC_SERVICE_NAME': '0', 13:12:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:12:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:12:29 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-uxmKsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:12:29 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:12:29 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-89ZlzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:12:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:12:29 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-FUWMSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:12:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:12:29 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-NhOcFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:12:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:12:29 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-61SFrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:12:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:12:30 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-08SOHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:12:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:12:30 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-7IvZU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:12:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:12:30 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-yk7_z_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:12:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:12:30 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-U6qp2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:12:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:12:30 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-3aYOwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:12:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:12:30 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-4WZTjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:12:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:12:30 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-ETch15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:12:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:12:30 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-IKj0Wv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:12:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:12:30 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-uoAZI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:12:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:12:31 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-l6wGnS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:12:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:12:31 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-MXud2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:12:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:12:31 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-C31bkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:12:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:12:31 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:12:31 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:12:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:12:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:12:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:12:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:33 INFO - Downloading blessings-1.6.tar.gz 13:12:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:12:33 INFO - Installing collected packages: blessings 13:12:33 INFO - Running setup.py install for blessings 13:12:33 INFO - Successfully installed blessings 13:12:33 INFO - Cleaning up... 13:12:34 INFO - Return code: 0 13:12:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:12:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:12:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:12:34 INFO - Reading from file tmpfile_stdout 13:12:34 INFO - Current package versions: 13:12:34 INFO - blessings == 1.6 13:12:34 INFO - blobuploader == 1.2.4 13:12:34 INFO - docopt == 0.6.1 13:12:34 INFO - manifestparser == 1.1 13:12:34 INFO - mozInstall == 1.12 13:12:34 INFO - mozcrash == 0.17 13:12:34 INFO - mozdebug == 0.1 13:12:34 INFO - mozdevice == 0.48 13:12:34 INFO - mozfile == 1.2 13:12:34 INFO - mozhttpd == 0.7 13:12:34 INFO - mozinfo == 0.9 13:12:34 INFO - mozleak == 0.1 13:12:34 INFO - mozlog == 3.1 13:12:34 INFO - moznetwork == 0.27 13:12:34 INFO - mozprocess == 0.22 13:12:34 INFO - mozprofile == 0.28 13:12:34 INFO - mozrunner == 6.11 13:12:34 INFO - mozscreenshot == 0.1 13:12:34 INFO - mozsystemmonitor == 0.0 13:12:34 INFO - moztest == 0.7 13:12:34 INFO - mozversion == 1.4 13:12:34 INFO - psutil == 3.1.1 13:12:34 INFO - requests == 1.2.3 13:12:34 INFO - wsgiref == 0.1.2 13:12:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:12:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:12:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:12:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:12:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:34 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 0x105618a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105628420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa63b453b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054b7e00>, '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 0x1052e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054b2b20>, '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.BCisJWNLtS/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.y1SPfZAJ5V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:12:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:12:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:12:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BCisJWNLtS/Render', 13:12:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:12:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:12:34 INFO - 'HOME': '/Users/cltbld', 13:12:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:12:34 INFO - 'LOGNAME': 'cltbld', 13:12:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:34 INFO - 'MOZ_NO_REMOTE': '1', 13:12:34 INFO - 'NO_EM_RESTART': '1', 13:12:34 INFO - 'PAGER': '/bin/cat', 13:12:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:12:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:34 INFO - 'PWD': '/builds/slave/test', 13:12:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:12:34 INFO - 'SHELL': '/bin/bash', 13:12:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.y1SPfZAJ5V/Listeners', 13:12:34 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 13:12:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:12:34 INFO - 'USER': 'cltbld', 13:12:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:12:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:12:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:34 INFO - 'XPC_FLAGS': '0x0', 13:12:34 INFO - 'XPC_SERVICE_NAME': '0', 13:12:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:12:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:12:34 INFO - Cleaning up... 13:12:34 INFO - Return code: 0 13:12:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:12:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:12:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:12:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:12:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105618a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105628420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa63b453b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054b7e00>, '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 0x1052e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054b2b20>, '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.BCisJWNLtS/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.y1SPfZAJ5V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:12:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:12:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:12:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BCisJWNLtS/Render', 13:12:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:12:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:12:34 INFO - 'HOME': '/Users/cltbld', 13:12:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:12:34 INFO - 'LOGNAME': 'cltbld', 13:12:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:34 INFO - 'MOZ_NO_REMOTE': '1', 13:12:34 INFO - 'NO_EM_RESTART': '1', 13:12:34 INFO - 'PAGER': '/bin/cat', 13:12:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:12:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:34 INFO - 'PWD': '/builds/slave/test', 13:12:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:12:34 INFO - 'SHELL': '/bin/bash', 13:12:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.y1SPfZAJ5V/Listeners', 13:12:34 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 13:12:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:12:34 INFO - 'USER': 'cltbld', 13:12:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:12:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:12:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:34 INFO - 'XPC_FLAGS': '0x0', 13:12:34 INFO - 'XPC_SERVICE_NAME': '0', 13:12:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:12:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:12:34 INFO - Downloading/unpacking jsonschema 13:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:12:37 INFO - Downloading/unpacking functools32 (from jsonschema) 13:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:37 INFO - Downloading functools32-3.2.3-2.tar.gz 13:12:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:12:37 INFO - warning: no files found matching '*.txt' 13:12:37 INFO - no previously-included directories found matching 'build' 13:12:37 INFO - no previously-included directories found matching 'dist' 13:12:37 INFO - no previously-included directories found matching '.git*' 13:12:37 INFO - Installing collected packages: jsonschema, functools32 13:12:37 INFO - Running setup.py install for functools32 13:12:37 INFO - warning: no files found matching '*.txt' 13:12:37 INFO - no previously-included directories found matching 'build' 13:12:37 INFO - no previously-included directories found matching 'dist' 13:12:37 INFO - no previously-included directories found matching '.git*' 13:12:38 INFO - Successfully installed jsonschema functools32 13:12:38 INFO - Cleaning up... 13:12:38 INFO - Return code: 0 13:12:38 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:12:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:12:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:12:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:12:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105618a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105628420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa63b453b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054b7e00>, '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 0x1052e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054b2b20>, '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.BCisJWNLtS/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.y1SPfZAJ5V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:12:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 13:12:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 13:12:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BCisJWNLtS/Render', 13:12:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:12:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:12:38 INFO - 'HOME': '/Users/cltbld', 13:12:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:12:38 INFO - 'LOGNAME': 'cltbld', 13:12:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:38 INFO - 'MOZ_NO_REMOTE': '1', 13:12:38 INFO - 'NO_EM_RESTART': '1', 13:12:38 INFO - 'PAGER': '/bin/cat', 13:12:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:12:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:38 INFO - 'PWD': '/builds/slave/test', 13:12:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:12:38 INFO - 'SHELL': '/bin/bash', 13:12:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.y1SPfZAJ5V/Listeners', 13:12:38 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 13:12:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:12:38 INFO - 'USER': 'cltbld', 13:12:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:12:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:12:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:38 INFO - 'XPC_FLAGS': '0x0', 13:12:38 INFO - 'XPC_SERVICE_NAME': '0', 13:12:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:12:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:12:38 INFO - Downloading/unpacking flake8 13:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:12:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:12:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:12:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:12:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:12:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:12:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:12:41 INFO - no previously-included directories found matching 'docs/_build' 13:12:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:12:42 INFO - Running setup.py install for pep8 13:12:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:12:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:12:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:12:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:12:42 INFO - no previously-included directories found matching 'docs/_build' 13:12:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:12:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:12:42 INFO - Cleaning up... 13:12:42 INFO - Return code: 0 13:12:42 INFO - Running post-action listener: _resource_record_post_action 13:12:42 INFO - Running post-action listener: _start_resource_monitoring 13:12:42 INFO - Starting resource monitoring. 13:12:42 INFO - ##### 13:12:42 INFO - ##### Running install step. 13:12:42 INFO - ##### 13:12:42 INFO - Running pre-action listener: _resource_record_pre_action 13:12:42 INFO - Running main action method: install 13:12:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:12:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:12:42 INFO - Reading from file tmpfile_stdout 13:12:42 INFO - Detecting whether we're running mozinstall >=1.0... 13:12:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:12:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:12:42 INFO - Reading from file tmpfile_stdout 13:12:42 INFO - Output received: 13:12:42 INFO - Usage: mozinstall [options] installer 13:12:42 INFO - Options: 13:12:42 INFO - -h, --help show this help message and exit 13:12:42 INFO - -d DEST, --destination=DEST 13:12:42 INFO - Directory to install application into. [default: 13:12:42 INFO - "/builds/slave/test"] 13:12:42 INFO - --app=APP Application being installed. [default: firefox] 13:12:42 INFO - mkdir: /builds/slave/test/build/application 13:12:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:12:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 13:13:15 INFO - Reading from file tmpfile_stdout 13:13:15 INFO - Output received: 13:13:15 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:13:15 INFO - Running post-action listener: _resource_record_post_action 13:13:15 INFO - ##### 13:13:15 INFO - ##### Running run-tests step. 13:13:15 INFO - ##### 13:13:15 INFO - Running pre-action listener: _resource_record_pre_action 13:13:15 INFO - Running main action method: run_tests 13:13:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:13:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:13:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:13:15 INFO - 2016-04-12 13:13:15.724 screenresolution[1909:19714] starting screenresolution argv=screenresolution get 13:13:15 INFO - 2016-04-12 13:13:15.727 screenresolution[1909:19714] Display 0: 1600x1200x32@60 13:13:15 INFO - 2016-04-12 13:13:15.733 screenresolution[1910:19717] starting screenresolution argv=screenresolution list 13:13:15 INFO - Available Modes on Display 0 13:13:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:13:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:13:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:13:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:13:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:13:15 INFO - Intel Iris: 13:13:15 INFO - Chipset Model: Intel Iris 13:13:15 INFO - Type: GPU 13:13:15 INFO - Bus: Built-In 13:13:15 INFO - VRAM (Dynamic, Max): 1536 MB 13:13:15 INFO - Vendor: Intel (0x8086) 13:13:15 INFO - Device ID: 0x0a2e 13:13:15 INFO - Revision ID: 0x0009 13:13:15 INFO - Displays: 13:13:15 INFO - Display: 13:13:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:13:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:13:15 INFO - Display Serial Number: 1600x1200 60 13:13:15 INFO - Main Display: Yes 13:13:15 INFO - Mirror: Off 13:13:15 INFO - Online: Yes 13:13:15 INFO - Rotation: Supported 13:13:15 INFO - Return code: 0 13:13:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:13:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:13:15 INFO - Python 2.7.3 13:13:15 INFO - Return code: 0 13:13:15 INFO - grabbing minidump binary from tooltool 13:13:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:13:15 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 0x1054b7e00>, '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 0x1052e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054b2b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:13:15 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:13:15 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 13:13:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:13:16 INFO - Return code: 0 13:13:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:13:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:13:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:13:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:13:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:13:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:13:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:13:17 INFO - Return code: 0 13:13:17 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/fM9UUN2aTjePuPdqcuqu6A/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0139', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:13:17 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/fM9UUN2aTjePuPdqcuqu6A/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0139 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:13:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BCisJWNLtS/Render', 13:13:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:13:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:13:17 INFO - 'HOME': '/Users/cltbld', 13:13:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:13:17 INFO - 'LOGNAME': 'cltbld', 13:13:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:13:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:13:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:17 INFO - 'MOZ_NO_REMOTE': '1', 13:13:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:13:17 INFO - 'NO_EM_RESTART': '1', 13:13:17 INFO - 'PAGER': '/bin/cat', 13:13:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:13:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:13:17 INFO - 'PWD': '/builds/slave/test', 13:13:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:13:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:13:17 INFO - 'SHELL': '/bin/bash', 13:13:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.y1SPfZAJ5V/Listeners', 13:13:17 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 13:13:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:13:17 INFO - 'USER': 'cltbld', 13:13:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:13:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:13:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:17 INFO - 'XPC_FLAGS': '0x0', 13:13:17 INFO - 'XPC_SERVICE_NAME': '0', 13:13:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:13:17 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/fM9UUN2aTjePuPdqcuqu6A/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0139', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:13:17 INFO - mozversion application_buildid: 20160412121248 13:13:17 INFO - mozversion application_changeset: 4cf4428ef3945efd64b92e50be56ecc608a2b7b5 13:13:17 INFO - mozversion application_display_name: Nightly 13:13:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:13:17 INFO - mozversion application_name: Firefox 13:13:17 INFO - mozversion application_remotingname: firefox 13:13:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:13:17 INFO - mozversion application_vendor: Mozilla 13:13:17 INFO - mozversion application_version: 48.0a1 13:13:17 INFO - mozversion platform_buildid: 20160412121248 13:13:17 INFO - mozversion platform_changeset: 4cf4428ef3945efd64b92e50be56ecc608a2b7b5 13:13:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:13:17 INFO - mozversion platform_version: 48.0a1 13:13:17 INFO - using testdate: 1460491997 13:13:17 INFO - actual date: 1460491997 13:13:17 INFO - starting webserver on 'localhost:56723' 13:13:17 INFO - SUITE-START | Running 2 tests 13:13:17 INFO - TEST-START | dromaeo_css 13:13:17 INFO - operating with platform_type : mac_ 13:13:17 INFO - Initialising browser for dromaeo_css test... 13:13:17 INFO - TEST-INFO | started process 1928 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/tmpXGVls4/profile http://localhost:56723/getInfo.html) 13:13:19 INFO - PROCESS | 1928 | __metrics Screen width/height:1600/1200 13:13:19 INFO - PROCESS | 1928 | colorDepth:24 13:13:19 INFO - PROCESS | 1928 | Browser inner width/height: 1024/689 13:13:19 INFO - PROCESS | 1928 | __metrics 13:13:19 INFO - PROCESS | 1928 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:13:19 ERROR - PROCESS | 1928 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:13:20 INFO - TEST-INFO | 1928: exit 0 13:13:20 INFO - Browser initialized. 13:13:20 INFO - Running cycle 1/1 for dromaeo_css test... 13:13:20 INFO - TEST-INFO | started process 1930 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/tmpXGVls4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:13:32 INFO - PROCESS | 1930 | RSS: Main: 237527040 13:13:32 INFO - PROCESS | 1930 | 13:14:23 INFO - PROCESS | 1930 | 1460492063732 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 13:16:33 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:56723/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56723/tests/dromaeo/cssquery-ext.html) 13:16:35 INFO - PROCESS | 1930 | RSS: Main: 369172480 13:16:35 INFO - PROCESS | 1930 | 13:19:38 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:56723/tests/dromaeo/cssquery-ext.html (next: http://localhost:56723/tests/dromaeo/cssquery-jquery.html) 13:19:39 INFO - PROCESS | 1930 | RSS: Main: 374886400 13:19:39 INFO - PROCESS | 1930 | 13:22:41 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:56723/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56723/tests/dromaeo/cssquery-mootools.html) 13:22:41 INFO - PROCESS | 1930 | RSS: Main: 373157888 13:22:41 INFO - PROCESS | 1930 | 13:25:44 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:56723/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56723/tests/dromaeo/cssquery-prototype.html) 13:25:44 INFO - PROCESS | 1930 | RSS: Main: 333688832 13:25:44 INFO - PROCESS | 1930 | 13:28:47 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:56723/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56723/tests/dromaeo/cssquery-yui.html) 13:28:48 INFO - PROCESS | 1930 | RSS: Main: 339382272 13:28:48 INFO - PROCESS | 1930 | 13:31:51 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:56723/tests/dromaeo/cssquery-yui.html (next: http://localhost:56723/tests/dromaeo/cssquery-dojo.html) 13:31:51 INFO - PROCESS | 1930 | RSS: Main: 381296640 13:31:51 INFO - PROCESS | 1930 | 13:31:51 INFO - PROCESS | 1930 | __start_tp_report 13:31:51 INFO - PROCESS | 1930 | _x_x_mozilla_page_load 13:31:51 INFO - PROCESS | 1930 | _x_x_mozilla_page_load_details 13:31:51 INFO - PROCESS | 1930 | |i|pagename|runs| 13:31:51 INFO - PROCESS | 1930 | |0;dojo.html;2921.211272956302;3331.283773988592;3397.558317418736;3412.8634854605816;3443.7589368744198;5463.016657001738;5522.392536820957;5580.162975553669;5598.412166722496;5610.719464026798;5516.7517461714215;5581.972090139544;5583.3858275589655;5608.887822243552;5611.438856114387;5042.47054059324;5060.6963582185;5157.6131790115705;5162.380514338284;5226.372835259775;5090.160123579623;5165.948340516585;5168.664036837612;5181.948180518203;5188.092083885305;5128.384593848725;5174.353205849269;5197.116490196676;5207.323048003773;5215.269862219292;5193.662411943212;5209.7134657593815;5218;5228.189630607262;5274.367075950872;5016.523430274118;5064.493550644943;5132.5124113209185;5132.820351287687;5161.096808058574;5056.544910958031;5467.890642187134;5498.147787092967;5517.420670829585;5573.024720673907;6164.8767024659255;6175.907361389583;6198.907016394758;6206.379362063757;6221.440070393686;5945.346011938684;6211.534134939898;6246.718897649616;6254.21822272216;6270.87458250837;5640.887182256373;5671.801486947978;5688.11834165705;5759;5772.942270577324;6239.313675495692;6244.531660125418;6251.531135164881;6271.529635277372;6285.2457705075685;5127.846164615067;5890.911636325459;6013.9699301503215;6021.548383871227;6023.427774361428;6105;6107.037103281127;6192.783252586138;6202.751889924352;6210.627362358183;6120.326764055951;6142.447179753844;6146.815595532141;6159.168512250879;6163.19878415812;5267.57859371257;5962.3739507351975;6173.382661733791;6204.565680402328;6205.565610407319;4870.902581948412;4894.241392584155;4899.436564795023;4962.826301079445;4972.577330926912;4338.978305108454;4359.585839345257;4396.912061758747;4404.471463424409;4416.757078360657;5451.127819548853;5606.92690756647;5611.0741727615305;5618.185363122325;5683.630564013326;5415.539679127318;6136.12084543884;6188.551180316468;6229.314775374705;6262.499000079983;4797.688150270221;5605.66366018032;5606.439356064442;5625;5644.181593668895;5223.973880130575;5338.9466105339225;5339.5728341732565;5370.382406023279;5406.540444062299;6228.626282423069;6234.251889773256;6283.591566548068;6308.495320374267;6319.46284565817;6186.628802271878;6211.316755156839;6229.781957631461;6236.095766113979;6242.344553821783;6160.414760597736;6288.339724329063;6288.371162883675;6291.905621415774;6320.462760665395;6017.157597936205;6062.211912451353;6077.118817771487;6098.237720284965;6105.755769769159;6012.428819262163;6127.325994140552;6135.723892424762;6144.631322120687;6161.907571386343;5810.73851676684;5919.733611987384;5927.288725352812;5931.555133365101;5932.614380065282;5937.970310148422;5941;5946.28644562638;5953.642781433128;6001.879962400815;5776.56675749312;5779.219805326227;5792.797252096157;5803.216565763568;5808.7095645218415;5679.346875109415;5926.466618004228;5953.28560572734;5965.463108320272;5989.071693887455;5886.705664716661;5897.675627840338;5902.852428689317;5905.734241959036;5911.290645122613 13:31:51 INFO - PROCESS | 1930 | |1;ext.html;505.9974700126499;519.9159751917252;545.0924211188371;553.872609299861;565.3526711914857;29064.709352906466;29532.261693457647;29546;29588.260293492647;29600;30353.241168970788;39567.802160989224;40561.58034468794;40601.59398406015;40690;9506.667266645669;9521.47631880248;9536.666216682417;9555.569999350046;9560.56977436017;8347.040090389592;9300.627974880997;9419.0110038446;9440.244780417584;9442.527873606326;8140.674373025102;11383.658490245305;11675.591354302602;11681.474333655005;11681.883181168207;11289.548418063268;11379.943100284529;11380.260283081656;11381.487833047533;11388.71528211793;8365.163483651648;11091.059064663652;11199;11337.773244535145;11448.198626096177;38397.62433259346;38895.8331250063;38976.80511597452;39057;39243.8037809812;3183.060997005889;3199.96800031999;3223.774335796495;3231.466807976681;3295.8681652733862;27391.863040684868;27953.720462795314;28033.57949630757;28051.15846524587;28267.434651307063;2745.0666773297175;2758.2001219646277;2771.182501162162;2786.150224181624;2844;408570;472970;473297;475911;476432;62197;62683.37316626866;62683.6865815668;62763.372366276664;62936.68531657404;67948;68064.3193568058;68076.97884531735;68217.65891170512;68224;16409.83590164107;16933;16963;16988.830111698724;17002.809803313896;11618.825717614243;11898.405079745979;11916.46375913086;11929.463174157183;11947.462364193632;15042.946993710335;17386.3045478182;18108.36620718295;18667.81332186688;18674.626507469773;5485;6227;6334.873302534015;6386.489080873519;6411.198600174978;923.266003527184;987.3138168972639;1004.9095581397563;1076.321917192164;1146.8853114688632;28237.15288541347;28563.57154642682;29111.56332655012;29464.410711785644;29782.10653680393;1048.1667074675652;1063.9255252132432;1066.461436974323;1093.316677076827;1133.1274918312854;15325.386984520717;15326.616834579225;15645.452409165851;15799.447019354267;15957.680846383008;607502;750599;751796;754951;757066;59686.70156649189;59721;60492.39507604868;60589.697051515344;60797.696011520544;1298.7792075347213;1310.9147905385928;1322.7288405876773;1353.5871559174152;1471.1173296022514;25979.610305845807;29743.958961436245;29837;30763;31806.36387272195;54424.095156669326;59220.11169832542;61116.08325875204;61153;61255;483008;489444;491620;494142;494599;23339.649905251776;23919.16282930089;26533;27093.72906270912;27162.32094197661;35079.12302192466;47547;48626.5137348622;49288.014239714284;50303.74848125882;35712.642873570934;36368.636313636525;37463.43804842984;37518.43722344113;38422;36313;36326.818365908;36898.8155059223;37135.07162320964;37181;35701.64298356983;36251.09372265609;36459.27081458409;36784.89645310645;37292.813535932146;31893.7242510297;32487.675123248464;32553.186170345933;32840.50739238961;32874.83562582172;20139.993000350216;20304;23997.640035399134;24343.14798982027;24906.626400604368 13:31:51 INFO - PROCESS | 1930 | |2;jquery.html;390.52551150352326;395.70717668925005;396.4825902197631;397.40786228519516;408.6240658594093;19265.518362040955;20276.89861550692;20299.594008119828;20422.387328380137;21088.789112108876;20206.88862112587;20267.89866050668;20888.89555552224;20895.791042089575;20936.16255349788;5742.425757424245;5785.421457854223;5983.491403230709;5992.651653377999;6001.099835024737;5911.615744976562;5942.078977758454;6002.669853158074;6002.849928751794;6039.577229593908;5748.195252664609;5892.2929248490245;5926.051831706928;5928.940710592882;5929.703514824263;5672.858178545528;5901.940980590182;5903.5572332074835;5905.763769449239;6042.9395706042815;5894.646321220741;5926.1110833374905;5934.525237980951;5939.020061689816;5949.405059494016;13137.40881660318;13649.249291288976;13886.791698124536;13910.261217347832;13942.790858137136;2005.7994200579972;2080.1055546115163;2164.2641501889434;2411.2645643078854;2525.0783464035494;9635.470049147294;10040.447775372351;10090.49547522621;10187.54156062979;10253.025962533547;1718.2267979409316;1759.2523177649448;1768.1512873820639;1774.6450709857952;1791.9820801792075;78171;78398.6080069596;110322.9999999992;117605.23592146125;118564;11515.193936424537;11680.70798230051;11743.588974386026;11745.706357341134;11924.046076313874;13596.048276620542;14169.504067357593;14172.433102675777;14182.574522764333;15380.846191538165;7508;8251.546164960864;8566.3146948244;8619.78450538729;8712.39013269065;8461.534615596202;8514.063453020286;8516.914830851736;8584.914150858536;8599.828003439896;4627.467841198305;4628.467726211461;4648.907021859543;4659.603933665677;4697.694649847749;1722.371334462912;1940.98059019408;1991.9402417927486;1993.9561949002389;1998.8400927926023;881.8192270584515;902.264654306751;920.8940971788196;954.5942974235921;1006.9748256293504;19547.456309905676;20411.79588204099;20431.182752690023;20543.58912821735;20578.485537861372;965.5558443116105;973.7468258252906;973.7468258252906;981.0777868803302;986.3687240166299;9887.555060022316;10722.927707229215;10744.946275268574;10832.795992262258;10871.130309575216;545649;636361;638579;656082;667426;133401;139636;143543;144847;145546;814.3241109878786;1032.4166845732138;1032.7418145463485;1055.5988724284723;1060.2207377577474;17860.285588576313;17871.642567148843;17893.463196104138;18009;18117.45647630573;50025.999999998545;50106.99572017224;50414.49585504098;50514.49485505098;50563.24155137602;75586.48827023318;76578.8513172314;76919.61540192264;76991.61504192444;78287.21712782799;6807.795766127024;7426.368758655575;7637.427192960661;7677.155512893689;8411.411201215857;9416.387934784218;12367.14204449046;12635.873641263837;13025.869741302466;13036.608901732963;11043.447827608748;11242.887571124184;11253;11551.364674942959;11562.76874462523;10825.729356766144;10904.400257985886;10911.236213464981;11130.944345278222;11160.888391115985;10858.987040756312;11433.142514311627;11450.599229026944;11763.529458821551;11928.821067684165;8229.670813167406;8242.793930151794;8316.83366332682;8324.458910170819;8673.566321684017;9810.85283720759;11184.608538701106;11566.595169169039;11601.651950441501;11750.647480575597 13:31:51 INFO - PROCESS | 1930 | |3;mootools.html;1402.6703724624706;1493.8655521003107;1579.6524764551802;1796.6586348593767;1949.7465329507163;7866.803329916755;8581.39930204886;8838.779030524223;8842.248408885236;8846.248068914134;8591.742247732578;8603.526806025666;8701.434406763572;8708.25979791717;8732.432391894523;2131.1581925139562;2402.759724027601;2436.4639779248537;2466.5313590417854;2472.2706801493514;2487.9751202488014;2505.498900219954;2507.8244522883406;2508.7114981777054;2508.8996440142373;2428.9514209715885;2464.938376540592;2468.5309791139625;2474.158786012755;2480.590702534089;1799.199356286453;2371.893264803088;2433.9634905476432;2444.4866578018637;2467.2351571012864;2451.399407145243;2475.344033831036;2475.4677744285063;2484.751524847519;2485.9931727650333;8570.057293697688;8658.134186581354;8661.263792577638;8665.956670216672;8671.913280867173;5201.609879259071;5341.759620817073;5348.51863332298;5354.973225133849;5373.382061062989;3383.3571621392102;3494.9301013979834;3619.8371073301764;3624.8187590620364;3629.201575653352;1057.9206559508068;1061.458656085402;1063.8457423673524;1074.1138560687464;1079.9082078023378;11628.592999244986;11638.709032274177;11645.94177029118;11662.416879156093;11665.358405287705;4729.881752956204;4746.551503140414;4800.687955282895;4914.238293064581;4948.975255123702;9826.557804898797;9893.406395616286;9904.15814655748;9910.405375677483;9948.403095814274;5364.14173732201;5396.244525766396;5406.567474602022;5433.212184233343;5434.3207099112615;3983.581723918947;4315.741055536678;4382.05785756064;4904.558589726942;4916.778744956486;3964.0882597002274;4002.939955900664;4033.4353190553347;4083.5099788025627;4091.3658382950093;1265.4368805881295;1333.759923213831;1357.850636429992;1358.9116707413987;1373.8969577281744;1128.8758236593967;1306.5231190615357;1337.7926421404504;1360.9523666671619;1363.9727205455836;7695.076590809139;7731.226877312224;8104.716334928367;8143.592820358958;8195.590220489072;1118.8042092633757;1163.755611321632;1172.8709841917382;1185.5139392848891;1208.7582483503334;6050.273967123973;6214.596051256744;6420.06908998202;6441.066045423388;6450.032495125675;10306.948465257627;10757.031867131996;10861.83707244392;10881.782364352668;10906.236563440483;10128.03783640553;10574.52414641343;10642.93570642945;10800.351978881292;10860.076893463985;7999.720009799629;8122.390820688472;8168.387370947203;8171.142030086755;8198.180181981874;8078.3133433658795;8243.505389676639;8304.377171712267;8313.875291870505;8323.126071762377;9687.564059617192;9741.074597913186;10057.24570657189;10057.69826905194;10156;8704.738857834274;9075.319351048565;10098.646547370807;10144.289899707244;10337.534810933375;6961.965190174017;7140.821479463055;7156.248593897566;7365.484416091036;7653.234676532302;8116.959415202886;8162.347012239125;8176.83646327082;8196.344292456708;8226.383021273308;6978.965105174441;7133.357997780225;7464.626768661654;7476.177620461854;7591.316781489692;6401.231852177769;7168.354848063699;7244.710211591688;7481.551106933383;7503.062117235346;7780.1052878919645;7801.29788319054;7892.644830982735;7894.131645519104;7913.169117242606;6989.33601307875;7078.610676412847;7084.752033678797;7092.219855815959;7129.714811407485;7081.681324340314;7205.495615307088;7208.675609597476;7214.89177662346;7226.132864056347 13:31:51 INFO - PROCESS | 1930 | |4;prototype.html;320.3432962427025;322.71923426618844;327.96720327967193;330.1515106177125;335.9546461227735;5697.715114244287;5734.569907256951;5753.338366087901;5780.5664575156825;5842.328132264791;5702.45826646469;5717.542596592273;5721.742521586528;5744;5765.913511297334;3835.7698538087666;3847.2882516734353;4026.758394496325;4049.75701457912;4450.243458612027;4009.5389030261454;4379.4963579188325;4397.978010109945;4415.2494076007;4422.159789639974;4324.481062272516;4359.324304732756;4363.869083927487;4395.208862404766;4399.802008909591;3988.9800550997206;4132.132252227036;4171.91656166875;4193.769342686151;4408.801603927799;3808;3813.4089216171537;3821.503204583414;3826.521684789401;3845.788481633509;4925.9901720147645;5472.5621950243885;5490.725463726798;5511.559075273968;5515.944840551583;4839.298301746262;5040;5057.4689657585795;5077.898442031175;5103.413107492649;5998;6038.486728628071;6062.939370606282;6067.878642427171;6070.423309785563;4247.277962746341;4248.277792775236;4254.723442976197;4258.5954334338185;4265.53079161292;5781.814727980796;5855.677937713424;6015.706623076016;6096.298925623566;6446.419822216023;3746.269477451871;4247.893802654897;4257.595528424795;4264.296391095497;4271.594198551133;4307.6769242306955;4355.80398882051;4365.607095361433;4373.343998400202;4398.956010439919;4926.524687307369;4959.801607935714;5025.522575355335;5052.1663925451885;5059.800365696463;5644.379118296984;5688.862227554423;6054;6103.786367477117;6107.633541987495;1486.576325747157;1514.681916797463;1517.347540557571;1519.688463864905;1519.8980738964383;964.0504103458088;1001.5743309093606;1003.2174903575223;1015.6343716262139;1017.4709151241314;5346.8395948121615;5415.025295446857;5501.972490137524;5610.49505544503;5762.654240745569;5443.9384320058;5604.747786349624;6299.370062993664;6326.240851097806;6359.745610175633;5397.541208997279;5462.535684466785;5657.688827114548;5674.9217648647455;5725.942740572541;2709.525832979221;2847.8718457669456;3114.2214446388402;3275.901722948315;3317.3696997570382;5514.779408823682;6315.652639104802;6391.744330226739;6544.149260596092;6596.241432235259;6258.748250349949;6461.806145815539;6469.997150441689;6479.870402591921;6525.608463492205;5769.9711501442225;6529.408825146151;6533.901991470132;6558.048673251665;6569.343065693583;5956;6264.404881536247;6280.780172693934;6289.842753931189;6293.433590976834;5496.708273555631;5620.74706638194;5639.601111133323;5732.111522713986;6219.973704338733;6158.476529495043;6272.8118156455375;6440.710168042356;6501.122348482894;6653.933460665331;4260.701750877409;4327.567243275647;4337.7831108443825;4352.717073390219;4360.738355698668;5488.725563721718;5573.665580065209;6077.939220607737;6335.176427064452;6347.746090156526;5819.127130930225;6084.75262571163;6108.877822443437;6119.694015299307;6150.323464419;6038.003729384603;6064.848378790565;6090.9390906090375;6097.817065488042;6105.84735381619;5785.3636100028125;5892.440218179266;5941.465268125889;5947.078202878561;5994.460498555151;5185.170372740495;6035.305939816802;6062.695830772328;6088.6042407243385;6092.69536523181;4858.3441235432765;5945.959457095078;5970.701464926823;5982.252218472691;5995.910061348996 13:31:51 INFO - PROCESS | 1930 | |5;yui.html;750.5271678842329;754.9849003019943;758.2152472191283;768.2970082374624;821.4906757810156;13724.17654940703;15170.620734481643;15187.772183417257;15204.011739236941;15230.238488075607;13933.233672148028;14019.649508762286;14022.368993395296;14025.78961315581;14049.64875878101;735.4888352594922;758.0486489455725;897.5108565831638;924.1036194890962;950.3110245072302;929.4794914847707;940.1068984464786;942.0955882352949;942.3121121581249;945.2815859946421;996.8006398720285;1003.2124782046095;1005.005045005443;1005.5977608956402;1005.8189525885338;776.3207193705508;953.6471505542925;987.629638885418;992.007992007992;997.2171845101597;734.9595772232525;735.8234023834294;738.2469880721634;738.2469880721687;739.486057190253;14871.182084985321;14966.850331496655;14975.026623269561;15010.949233553656;15015.849841501664;12451.564195253213;12488.625341239778;12603.621891343275;12646.683832904158;12700.42848071839;8970.327225458052;9814.90185098147;10047.849282260771;10095.545700443497;10221.02887771931;3490.685838274542;3513.896177189855;3552.3960926642535;3618.6924111450558;3648.452732090181;74319;75149;76472;76957.61521192415;77150;9045.909540904639;9351.766205844908;9470.479123648127;9637.614495420245;9764.414135151914;21560.24539141154;21617;21640.56718865614;21651.56696866054;21669.241576544744;7352.485326027234;7424.814379640552;7526.09686837583;7631.3513351365755;7669.9616501917135;4060.1879624075304;4115.8765237042935;4122.835086596562;4231.78841057952;4359.869203923888;3491.633378495272;3605.3330133925306;3608.963910360863;3610.205754734007;3611.0611241076986;576.469647923911;616.2825205262673;632.5477283742055;640.7821340744076;664.1432552007952;503.32805704385055;565.4006752842;579.9281522459838;583.1777194156305;607.6445279511536;7590.1650818409935;7802.609869506502;7876.842463150705;8128.187181281943;8362.58187090643;574.6381076847814;583.6031498581006;593.9584229104007;619;627.7332133843098;3749.5500539935383;3810.942835857464;3812.066043819282;3986.4418981342637;4014.538328092307;82421;84385.57807210925;84817;85633;86238;74548.15436996687;74856.25143748602;75098;75299.24700752922;75520.62239688876;50374.74812625913;61928;66427.66786166039;67504.6624766873;68072.31927680758;7405;7450.327826381649;7561.3194812467145;7565;7616.771496855104;41312.1737565241;42079.789601053024;42309.1538169241;42483;43164.784176078916;57464.71267643635;58100.70949645225;58810.41189588049;60658.48353791014;61004.694976524836;8518.990186530926;10196.898031019595;10225.43760093202;10225.84661230097;10294.742631434274;9066.50134242623;10652.680419587425;10714.089302409382;10783.6225732099;10878.836817447585;8971.775705607412;10228.59085636596;10233.48832558384;11342;11470.541178352772;11063.778724425627;11109.666709998713;11125.944370278097;11160.944195278971;11411.372374519482;10898.945505272422;10950.288231265262;10962.890371096188;11226.270292430965;11295.943520282346;9408.43549387039;9472.905270947202;9514.476703781358;9633.401120232664;9725.708228753148;9273.86089208649;9541.904580954102;9610.27922905799;9948.078404093989;10051.396916185053 13:31:51 INFO - PROCESS | 1930 | __end_tp_report 13:31:51 INFO - PROCESS | 1930 | __start_cc_report 13:31:51 INFO - PROCESS | 1930 | _x_x_mozilla_cycle_collect,1291 13:31:51 INFO - PROCESS | 1930 | __end_cc_report 13:31:51 INFO - PROCESS | 1930 | __startTimestamp1460493111704__endTimestamp 13:31:51 INFO - PROCESS | 1930 | 13:31:51 INFO - PROCESS | 1930 | ------- Summary: start ------- 13:31:51 INFO - PROCESS | 1930 | Number of tests: 6 13:31:51 INFO - PROCESS | 1930 | 13:31:51 INFO - PROCESS | 1930 | [#0] dojo.html Cycles:165 Average:5643.57 Median:5803.22 stddev:634.90 (10.9%) stddev-sans-first:599.85 13:31:51 INFO - PROCESS | 1930 | Values: 2921.2 3331.3 3397.6 3412.9 3443.8 5463.0 5522.4 5580.2 5598.4 5610.7 5516.8 5582.0 5583.4 5608.9 5611.4 5042.5 5060.7 5157.6 5162.4 5226.4 5090.2 5165.9 5168.7 5181.9 5188.1 5128.4 5174.4 5197.1 5207.3 5215.3 5193.7 5209.7 5218.0 5228.2 5274.4 5016.5 5064.5 5132.5 5132.8 5161.1 5056.5 5467.9 5498.1 5517.4 5573.0 6164.9 6175.9 6198.9 6206.4 6221.4 5945.3 6211.5 6246.7 6254.2 6270.9 5640.9 5671.8 5688.1 5759.0 5772.9 6239.3 6244.5 6251.5 6271.5 6285.2 5127.8 5890.9 6014.0 6021.5 6023.4 6105.0 6107.0 6192.8 6202.8 6210.6 6120.3 6142.4 6146.8 6159.2 6163.2 5267.6 5962.4 6173.4 6204.6 6205.6 4870.9 4894.2 4899.4 4962.8 4972.6 4339.0 4359.6 4396.9 4404.5 4416.8 5451.1 5606.9 5611.1 5618.2 5683.6 5415.5 6136.1 6188.6 6229.3 6262.5 4797.7 5605.7 5606.4 5625.0 5644.2 5224.0 5338.9 5339.6 5370.4 5406.5 6228.6 6234.3 6283.6 6308.5 6319.5 6186.6 6211.3 6229.8 6236.1 6242.3 6160.4 6288.3 6288.4 6291.9 6320.5 6017.2 6062.2 6077.1 6098.2 6105.8 6012.4 6127.3 6135.7 6144.6 6161.9 5810.7 5919.7 5927.3 5931.6 5932.6 5938.0 5941.0 5946.3 5953.6 6001.9 5776.6 5779.2 5792.8 5803.2 5808.7 5679.3 5926.5 5953.3 5965.5 5989.1 5886.7 5897.7 5902.9 5905.7 5911.3 13:31:51 INFO - PROCESS | 1930 | 13:31:51 INFO - PROCESS | 1930 | [#1] ext.html Cycles:180 Average:69093.09 Median:18085.35 stddev:153428.20 (848.4%) stddev-sans-first:153772.18 13:31:51 INFO - PROCESS | 1930 | Values: 506.0 519.9 545.1 553.9 565.4 29064.7 29532.3 29546.0 29588.3 29600.0 30353.2 39567.8 40561.6 40601.6 40690.0 9506.7 9521.5 9536.7 9555.6 9560.6 8347.0 9300.6 9419.0 9440.2 9442.5 8140.7 11383.7 11675.6 11681.5 11681.9 11289.5 11379.9 11380.3 11381.5 11388.7 8365.2 11091.1 11199.0 11337.8 11448.2 38397.6 38895.8 38976.8 39057.0 39243.8 3183.1 3200.0 3223.8 3231.5 3295.9 27391.9 27953.7 28033.6 28051.2 28267.4 2745.1 2758.2 2771.2 2786.2 2844.0 408570.0 472970.0 473297.0 475911.0 476432.0 62197.0 62683.4 62683.7 62763.4 62936.7 67948.0 68064.3 68077.0 68217.7 68224.0 16409.8 16933.0 16963.0 16988.8 17002.8 11618.8 11898.4 11916.5 11929.5 11947.5 15042.9 17386.3 18108.4 18667.8 18674.6 5485.0 6227.0 6334.9 6386.5 6411.2 923.3 987.3 1004.9 1076.3 1146.9 28237.2 28563.6 29111.6 29464.4 29782.1 1048.2 1063.9 1066.5 1093.3 1133.1 15325.4 15326.6 15645.5 15799.4 15957.7 607502.0 750599.0 751796.0 754951.0 757066.0 59686.7 59721.0 60492.4 60589.7 60797.7 1298.8 1310.9 1322.7 1353.6 1471.1 25979.6 29744.0 29837.0 30763.0 31806.4 54424.1 59220.1 61116.1 61153.0 61255.0 483008.0 489444.0 491620.0 494142.0 494599.0 23339.6 23919.2 26533.0 27093.7 27162.3 35079.1 47547.0 48626.5 49288.0 50303.7 35712.6 36368.6 37463.4 37518.4 38422.0 36313.0 36326.8 36898.8 37135.1 37181.0 35701.6 36251.1 36459.3 36784.9 37292.8 31893.7 32487.7 32553.2 32840.5 32874.8 20140.0 20304.0 23997.6 24343.1 24906.6 13:31:51 INFO - PROCESS | 1930 | 13:31:51 INFO - PROCESS | 1930 | [#2] jquery.html Cycles:180 Average:35303.77 Median:11626.53 stddev:105010.89 (903.2%) stddev-sans-first:105272.75 13:31:51 INFO - PROCESS | 1930 | Values: 390.5 395.7 396.5 397.4 408.6 19265.5 20276.9 20299.6 20422.4 21088.8 20206.9 20267.9 20888.9 20895.8 20936.2 5742.4 5785.4 5983.5 5992.7 6001.1 5911.6 5942.1 6002.7 6002.8 6039.6 5748.2 5892.3 5926.1 5928.9 5929.7 5672.9 5901.9 5903.6 5905.8 6042.9 5894.6 5926.1 5934.5 5939.0 5949.4 13137.4 13649.2 13886.8 13910.3 13942.8 2005.8 2080.1 2164.3 2411.3 2525.1 9635.5 10040.4 10090.5 10187.5 10253.0 1718.2 1759.3 1768.2 1774.6 1792.0 78171.0 78398.6 110323.0 117605.2 118564.0 11515.2 11680.7 11743.6 11745.7 11924.0 13596.0 14169.5 14172.4 14182.6 15380.8 7508.0 8251.5 8566.3 8619.8 8712.4 8461.5 8514.1 8516.9 8584.9 8599.8 4627.5 4628.5 4648.9 4659.6 4697.7 1722.4 1941.0 1991.9 1994.0 1998.8 881.8 902.3 920.9 954.6 1007.0 19547.5 20411.8 20431.2 20543.6 20578.5 965.6 973.7 973.7 981.1 986.4 9887.6 10722.9 10744.9 10832.8 10871.1 545649.0 636361.0 638579.0 656082.0 667426.0 133401.0 139636.0 143543.0 144847.0 145546.0 814.3 1032.4 1032.7 1055.6 1060.2 17860.3 17871.6 17893.5 18009.0 18117.5 50026.0 50107.0 50414.5 50514.5 50563.2 75586.5 76578.9 76919.6 76991.6 78287.2 6807.8 7426.4 7637.4 7677.2 8411.4 9416.4 12367.1 12635.9 13025.9 13036.6 11043.4 11242.9 11253.0 11551.4 11562.8 10825.7 10904.4 10911.2 11130.9 11160.9 10859.0 11433.1 11450.6 11763.5 11928.8 8229.7 8242.8 8316.8 8324.5 8673.6 9810.9 11184.6 11566.6 11601.7 11750.6 13:31:51 INFO - PROCESS | 1930 | 13:31:51 INFO - PROCESS | 1930 | [#3] mootools.html Cycles:180 Average:6039.24 Median:5075.29 stddev:3169.53 (62.5%) stddev-sans-first:3159.26 13:31:51 INFO - PROCESS | 1930 | Values: 1402.7 1493.9 1579.7 1796.7 1949.7 7866.8 8581.4 8838.8 8842.2 8846.2 8591.7 8603.5 8701.4 8708.3 8732.4 2131.2 2402.8 2436.5 2466.5 2472.3 2488.0 2505.5 2507.8 2508.7 2508.9 2429.0 2464.9 2468.5 2474.2 2480.6 1799.2 2371.9 2434.0 2444.5 2467.2 2451.4 2475.3 2475.5 2484.8 2486.0 8570.1 8658.1 8661.3 8666.0 8671.9 5201.6 5341.8 5348.5 5355.0 5373.4 3383.4 3494.9 3619.8 3624.8 3629.2 1057.9 1061.5 1063.8 1074.1 1079.9 11628.6 11638.7 11645.9 11662.4 11665.4 4729.9 4746.6 4800.7 4914.2 4949.0 9826.6 9893.4 9904.2 9910.4 9948.4 5364.1 5396.2 5406.6 5433.2 5434.3 3983.6 4315.7 4382.1 4904.6 4916.8 3964.1 4002.9 4033.4 4083.5 4091.4 1265.4 1333.8 1357.9 1358.9 1373.9 1128.9 1306.5 1337.8 1361.0 1364.0 7695.1 7731.2 8104.7 8143.6 8195.6 1118.8 1163.8 1172.9 1185.5 1208.8 6050.3 6214.6 6420.1 6441.1 6450.0 10306.9 10757.0 10861.8 10881.8 10906.2 10128.0 10574.5 10642.9 10800.4 10860.1 7999.7 8122.4 8168.4 8171.1 8198.2 8078.3 8243.5 8304.4 8313.9 8323.1 9687.6 9741.1 10057.2 10057.7 10156.0 8704.7 9075.3 10098.6 10144.3 10337.5 6962.0 7140.8 7156.2 7365.5 7653.2 8117.0 8162.3 8176.8 8196.3 8226.4 6979.0 7133.4 7464.6 7476.2 7591.3 6401.2 7168.4 7244.7 7481.6 7503.1 7780.1 7801.3 7892.6 7894.1 7913.2 6989.3 7078.6 7084.8 7092.2 7129.7 7081.7 7205.5 7208.7 7214.9 7226.1 13:31:51 INFO - PROCESS | 1930 | 13:31:51 INFO - PROCESS | 1930 | [#4] prototype.html Cycles:180 Average:4968.98 Median:5589.21 stddev:1514.14 (27.1%) stddev-sans-first:1477.64 13:31:51 INFO - PROCESS | 1930 | Values: 320.3 322.7 328.0 330.2 336.0 5697.7 5734.6 5753.3 5780.6 5842.3 5702.5 5717.5 5721.7 5744.0 5765.9 3835.8 3847.3 4026.8 4049.8 4450.2 4009.5 4379.5 4398.0 4415.2 4422.2 4324.5 4359.3 4363.9 4395.2 4399.8 3989.0 4132.1 4171.9 4193.8 4408.8 3808.0 3813.4 3821.5 3826.5 3845.8 4926.0 5472.6 5490.7 5511.6 5515.9 4839.3 5040.0 5057.5 5077.9 5103.4 5998.0 6038.5 6062.9 6067.9 6070.4 4247.3 4248.3 4254.7 4258.6 4265.5 5781.8 5855.7 6015.7 6096.3 6446.4 3746.3 4247.9 4257.6 4264.3 4271.6 4307.7 4355.8 4365.6 4373.3 4399.0 4926.5 4959.8 5025.5 5052.2 5059.8 5644.4 5688.9 6054.0 6103.8 6107.6 1486.6 1514.7 1517.3 1519.7 1519.9 964.1 1001.6 1003.2 1015.6 1017.5 5346.8 5415.0 5502.0 5610.5 5762.7 5443.9 5604.7 6299.4 6326.2 6359.7 5397.5 5462.5 5657.7 5674.9 5725.9 2709.5 2847.9 3114.2 3275.9 3317.4 5514.8 6315.7 6391.7 6544.1 6596.2 6258.7 6461.8 6470.0 6479.9 6525.6 5770.0 6529.4 6533.9 6558.0 6569.3 5956.0 6264.4 6280.8 6289.8 6293.4 5496.7 5620.7 5639.6 5732.1 6220.0 6158.5 6272.8 6440.7 6501.1 6653.9 4260.7 4327.6 4337.8 4352.7 4360.7 5488.7 5573.7 6077.9 6335.2 6347.7 5819.1 6084.8 6108.9 6119.7 6150.3 6038.0 6064.8 6090.9 6097.8 6105.8 5785.4 5892.4 5941.5 5947.1 5994.5 5185.2 6035.3 6062.7 6088.6 6092.7 4858.3 5946.0 5970.7 5982.3 5995.9 13:31:51 INFO - PROCESS | 1930 | 13:31:51 INFO - PROCESS | 1930 | [#5] yui.html Cycles:180 Average:17082.13 Median:29702.19 stddev:23528.92 (79.2%) stddev-sans-first:23562.97 13:31:51 INFO - PROCESS | 1930 | Values: 750.5 755.0 758.2 768.3 821.5 13724.2 15170.6 15187.8 15204.0 15230.2 13933.2 14019.6 14022.4 14025.8 14049.6 735.5 758.0 897.5 924.1 950.3 929.5 940.1 942.1 942.3 945.3 996.8 1003.2 1005.0 1005.6 1005.8 776.3 953.6 987.6 992.0 997.2 735.0 735.8 738.2 738.2 739.5 14871.2 14966.9 14975.0 15010.9 15015.8 12451.6 12488.6 12603.6 12646.7 12700.4 8970.3 9814.9 10047.8 10095.5 10221.0 3490.7 3513.9 3552.4 3618.7 3648.5 74319.0 75149.0 76472.0 76957.6 77150.0 9045.9 9351.8 9470.5 9637.6 9764.4 21560.2 21617.0 21640.6 21651.6 21669.2 7352.5 7424.8 7526.1 7631.4 7670.0 4060.2 4115.9 4122.8 4231.8 4359.9 3491.6 3605.3 3609.0 3610.2 3611.1 576.5 616.3 632.5 640.8 664.1 503.3 565.4 579.9 583.2 607.6 7590.2 7802.6 7876.8 8128.2 8362.6 574.6 583.6 594.0 619.0 627.7 3749.6 3810.9 3812.1 3986.4 4014.5 82421.0 84385.6 84817.0 85633.0 86238.0 74548.2 74856.3 75098.0 75299.2 75520.6 50374.7 61928.0 66427.7 67504.7 68072.3 7405.0 7450.3 7561.3 7565.0 7616.8 41312.2 42079.8 42309.2 42483.0 43164.8 57464.7 58100.7 58810.4 60658.5 61004.7 8519.0 10196.9 10225.4 10225.8 10294.7 9066.5 10652.7 10714.1 10783.6 10878.8 8971.8 10228.6 10233.5 11342.0 11470.5 11063.8 11109.7 11125.9 11160.9 11411.4 10898.9 10950.3 10962.9 11226.3 11295.9 9408.4 9472.9 9514.5 9633.4 9725.7 9273.9 9541.9 9610.3 9948.1 10051.4 13:31:51 INFO - PROCESS | 1930 | -------- Summary: end -------- 13:31:51 INFO - PROCESS | 1930 | 13:31:52 INFO - TEST-INFO | 1930: exit 0 13:31:52 INFO - TEST-OK | dromaeo_css | took 1114800ms 13:31:52 INFO - TEST-START | kraken 13:31:52 INFO - operating with platform_type : mac_ 13:31:52 INFO - Initialising browser for kraken test... 13:31:52 INFO - TEST-INFO | started process 1934 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/tmplb9mnk/profile http://localhost:56723/getInfo.html) 13:31:54 INFO - PROCESS | 1934 | __metrics Screen width/height:1600/1200 13:31:54 INFO - PROCESS | 1934 | colorDepth:24 13:31:54 INFO - PROCESS | 1934 | Browser inner width/height: 1024/689 13:31:54 INFO - PROCESS | 1934 | __metrics 13:31:54 INFO - PROCESS | 1934 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:31:54 ERROR - PROCESS | 1934 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:31:55 INFO - TEST-INFO | 1934: exit 0 13:31:55 INFO - Browser initialized. 13:31:55 INFO - Running cycle 1/1 for kraken test... 13:31:55 INFO - TEST-INFO | started process 1936 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/tmplb9mnk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:32:07 INFO - PROCESS | 1936 | RSS: Main: 237867008 13:32:07 INFO - PROCESS | 1936 | 13:32:09 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:56723/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56723/tests/kraken/driver.html?testName=audio-beat-detection) 13:32:10 INFO - PROCESS | 1936 | RSS: Main: 287191040 13:32:10 INFO - PROCESS | 1936 | 13:32:13 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:56723/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56723/tests/kraken/driver.html?testName=audio-dft) 13:32:14 INFO - PROCESS | 1936 | RSS: Main: 299249664 13:32:14 INFO - PROCESS | 1936 | 13:32:17 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:56723/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56723/tests/kraken/driver.html?testName=audio-fft) 13:32:18 INFO - PROCESS | 1936 | RSS: Main: 387121152 13:32:18 INFO - PROCESS | 1936 | 13:32:20 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:56723/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56723/tests/kraken/driver.html?testName=audio-oscillator) 13:32:20 INFO - PROCESS | 1936 | RSS: Main: 286916608 13:32:20 INFO - PROCESS | 1936 | 13:32:23 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:56723/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56723/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:32:23 INFO - PROCESS | 1936 | RSS: Main: 290787328 13:32:23 INFO - PROCESS | 1936 | 13:32:26 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:56723/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56723/tests/kraken/driver.html?testName=imaging-darkroom) 13:32:27 INFO - PROCESS | 1936 | RSS: Main: 329187328 13:32:27 INFO - PROCESS | 1936 | 13:32:29 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:56723/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56723/tests/kraken/driver.html?testName=imaging-desaturate) 13:32:30 INFO - PROCESS | 1936 | RSS: Main: 330108928 13:32:30 INFO - PROCESS | 1936 | 13:32:33 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:56723/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56723/tests/kraken/driver.html?testName=json-parse-financial) 13:32:34 INFO - PROCESS | 1936 | RSS: Main: 329232384 13:32:34 INFO - PROCESS | 1936 | 13:32:35 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:56723/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56723/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:32:36 INFO - PROCESS | 1936 | RSS: Main: 320262144 13:32:36 INFO - PROCESS | 1936 | 13:32:38 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:56723/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56723/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:32:38 INFO - PROCESS | 1936 | RSS: Main: 327675904 13:32:38 INFO - PROCESS | 1936 | 13:32:40 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:56723/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56723/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:32:41 INFO - PROCESS | 1936 | RSS: Main: 330289152 13:32:41 INFO - PROCESS | 1936 | 13:32:44 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:56723/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56723/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:32:45 INFO - PROCESS | 1936 | RSS: Main: 335085568 13:32:45 INFO - PROCESS | 1936 | 13:32:48 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:56723/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56723/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:32:48 INFO - PROCESS | 1936 | RSS: Main: 332804096 13:32:48 INFO - PROCESS | 1936 | 13:32:50 INFO - PROCESS | 1936 | Cycle 1(1): loaded http://localhost:56723/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56723/tests/kraken/driver.html?testName=ai-astar) 13:32:50 INFO - PROCESS | 1936 | RSS: Main: 396685312 13:32:50 INFO - PROCESS | 1936 | 13:32:50 INFO - PROCESS | 1936 | __start_tp_report 13:32:50 INFO - PROCESS | 1936 | _x_x_mozilla_page_load 13:32:50 INFO - PROCESS | 1936 | _x_x_mozilla_page_load_details 13:32:50 INFO - PROCESS | 1936 | |i|pagename|runs| 13:32:50 INFO - PROCESS | 1936 | |0;ai-astar;114;110;113;156;160;114;118;114;112;113 13:32:50 INFO - PROCESS | 1936 | |1;audio-beat-detection;159;121;145;171;119;141;140;120;206;150 13:32:50 INFO - PROCESS | 1936 | |2;audio-dft;187;185;188;186;188;186;184;186;187;186 13:32:50 INFO - PROCESS | 1936 | |3;audio-fft;78;74;86;91;55;61;57;80;84;55 13:32:50 INFO - PROCESS | 1936 | |4;audio-oscillator;90;93;135;74;108;123;154;78;80;132 13:32:50 INFO - PROCESS | 1936 | |5;imaging-gaussian-blur;87;86;88;85;87;84;88;85;88;84 13:32:50 INFO - PROCESS | 1936 | |6;imaging-darkroom;94;94;94;94;93;93;95;94;92;94 13:32:50 INFO - PROCESS | 1936 | |7;imaging-desaturate;84;100;117;128;131;86;84;86;84;86 13:32:50 INFO - PROCESS | 1936 | |8;json-parse-financial;54;55;53;52;54;53;53;72;54;52 13:32:50 INFO - PROCESS | 1936 | |9;json-stringify-tinderbox;64;66;72;73;71;71;69;68;69;68 13:32:50 INFO - PROCESS | 1936 | |10;stanford-crypto-aes;86;85;85;86;84;86;85;83;86;87 13:32:50 INFO - PROCESS | 1936 | |11;stanford-crypto-ccm;145;145;145;141;140;142;141;144;186;147 13:32:50 INFO - PROCESS | 1936 | |12;stanford-crypto-pbkdf2;178;214;198;169;169;172;167;169;168;171 13:32:50 INFO - PROCESS | 1936 | |13;stanford-crypto-sha256-iterative;69;68;69;68;66;66;67;69;68;69 13:32:50 INFO - PROCESS | 1936 | __end_tp_report 13:32:50 INFO - PROCESS | 1936 | __start_cc_report 13:32:50 INFO - PROCESS | 1936 | _x_x_mozilla_cycle_collect,1925 13:32:50 INFO - PROCESS | 1936 | __end_cc_report 13:32:50 INFO - PROCESS | 1936 | __startTimestamp1460493170688__endTimestamp 13:32:50 INFO - PROCESS | 1936 | 13:32:50 INFO - PROCESS | 1936 | ------- Summary: start ------- 13:32:50 INFO - PROCESS | 1936 | Number of tests: 14 13:32:50 INFO - PROCESS | 1936 | 13:32:50 INFO - PROCESS | 1936 | [#0] ai-astar Cycles:10 Average:122.40 Median:114.00 stddev:18.89 (16.6%) stddev-sans-first:19.79 13:32:50 INFO - PROCESS | 1936 | Values: 114.0 110.0 113.0 156.0 160.0 114.0 118.0 114.0 112.0 113.0 13:32:50 INFO - PROCESS | 1936 | 13:32:50 INFO - PROCESS | 1936 | [#1] audio-beat-detection Cycles:10 Average:147.20 Median:147.50 stddev:26.85 (18.2%) stddev-sans-first:28.14 13:32:50 INFO - PROCESS | 1936 | Values: 159.0 121.0 145.0 171.0 119.0 141.0 140.0 120.0 206.0 150.0 13:32:50 INFO - PROCESS | 1936 | 13:32:50 INFO - PROCESS | 1936 | [#2] audio-dft Cycles:10 Average:186.30 Median:186.50 stddev:1.25 (0.7%) stddev-sans-first:1.30 13:32:50 INFO - PROCESS | 1936 | Values: 187.0 185.0 188.0 186.0 188.0 186.0 184.0 186.0 187.0 186.0 13:32:50 INFO - PROCESS | 1936 | 13:32:50 INFO - PROCESS | 1936 | [#3] audio-fft Cycles:10 Average:72.10 Median:79.00 stddev:13.86 (17.5%) stddev-sans-first:14.54 13:32:50 INFO - PROCESS | 1936 | Values: 78.0 74.0 86.0 91.0 55.0 61.0 57.0 80.0 84.0 55.0 13:32:50 INFO - PROCESS | 1936 | 13:32:50 INFO - PROCESS | 1936 | [#4] audio-oscillator Cycles:10 Average:106.70 Median:76.00 stddev:27.92 (36.7%) stddev-sans-first:28.96 13:32:50 INFO - PROCESS | 1936 | Values: 90.0 93.0 135.0 74.0 108.0 123.0 154.0 78.0 80.0 132.0 13:32:50 INFO - PROCESS | 1936 | 13:32:50 INFO - PROCESS | 1936 | [#5] imaging-gaussian-blur Cycles:10 Average:86.20 Median:87.00 stddev:1.62 (1.9%) stddev-sans-first:1.69 13:32:50 INFO - PROCESS | 1936 | Values: 87.0 86.0 88.0 85.0 87.0 84.0 88.0 85.0 88.0 84.0 13:32:50 INFO - PROCESS | 1936 | 13:32:50 INFO - PROCESS | 1936 | [#6] imaging-darkroom Cycles:10 Average:93.70 Median:94.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 13:32:50 INFO - PROCESS | 1936 | Values: 94.0 94.0 94.0 94.0 93.0 93.0 95.0 94.0 92.0 94.0 13:32:50 INFO - PROCESS | 1936 | 13:32:50 INFO - PROCESS | 1936 | [#7] imaging-desaturate Cycles:10 Average:98.60 Median:84.00 stddev:19.35 (23.0%) stddev-sans-first:19.79 13:32:50 INFO - PROCESS | 1936 | Values: 84.0 100.0 117.0 128.0 131.0 86.0 84.0 86.0 84.0 86.0 13:32:50 INFO - PROCESS | 1936 | 13:32:50 INFO - PROCESS | 1936 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:54.00 stddev:5.98 (11.1%) stddev-sans-first:6.32 13:32:50 INFO - PROCESS | 1936 | Values: 54.0 55.0 53.0 52.0 54.0 53.0 53.0 72.0 54.0 52.0 13:32:50 INFO - PROCESS | 1936 | 13:32:50 INFO - PROCESS | 1936 | [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:70.00 stddev:2.77 (4.0%) stddev-sans-first:2.24 13:32:50 INFO - PROCESS | 1936 | Values: 64.0 66.0 72.0 73.0 71.0 71.0 69.0 68.0 69.0 68.0 13:32:50 INFO - PROCESS | 1936 | 13:32:50 INFO - PROCESS | 1936 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:86.00 stddev:1.16 (1.3%) stddev-sans-first:1.20 13:32:50 INFO - PROCESS | 1936 | Values: 86.0 85.0 85.0 86.0 84.0 86.0 85.0 83.0 86.0 87.0 13:32:50 INFO - PROCESS | 1936 | 13:32:50 INFO - PROCESS | 1936 | [#11] stanford-crypto-ccm Cycles:10 Average:147.60 Median:145.00 stddev:13.68 (9.4%) stddev-sans-first:14.48 13:32:50 INFO - PROCESS | 1936 | Values: 145.0 145.0 145.0 141.0 140.0 142.0 141.0 144.0 186.0 147.0 13:32:50 INFO - PROCESS | 1936 | 13:32:50 INFO - PROCESS | 1936 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.50 Median:171.50 stddev:15.79 (9.2%) stddev-sans-first:16.74 13:32:50 INFO - PROCESS | 1936 | Values: 178.0 214.0 198.0 169.0 169.0 172.0 167.0 169.0 168.0 171.0 13:32:50 INFO - PROCESS | 1936 | 13:32:50 INFO - PROCESS | 1936 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.50 stddev:1.20 (1.7%) stddev-sans-first:1.20 13:32:50 INFO - PROCESS | 1936 | Values: 69.0 68.0 69.0 68.0 66.0 66.0 67.0 69.0 68.0 69.0 13:32:50 INFO - PROCESS | 1936 | -------- Summary: end -------- 13:32:50 INFO - PROCESS | 1936 | 13:32:51 INFO - TEST-INFO | 1936: exit 0 13:32:51 INFO - TEST-OK | kraken | took 59183ms 13:32:51 INFO - SUITE-END | took 1173s 13:32:51 INFO - Completed test suite (00:19:34) 13:32:51 INFO - javascript benchmark 13:32:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2921.211272956302, 3331.283773988592, 3397.558317418736, 3412.8634854605816, 3443.7589368744198, 5463.016657001738, 5522.392536820957, 5580.162975553669, 5598.412166722496, 5610.719464026798, 5516.7517461714215, 5581.972090139544, 5583.3858275589655, 5608.887822243552, 5611.438856114387, 5042.47054059324, 5060.6963582185, 5157.6131790115705, 5162.380514338284, 5226.372835259775, 5090.160123579623, 5165.948340516585, 5168.664036837612, 5181.948180518203, 5188.092083885305, 5128.384593848725, 5174.353205849269, 5197.116490196676, 5207.323048003773, 5215.269862219292, 5193.662411943212, 5209.7134657593815, 5218.0, 5228.189630607262, 5274.367075950872, 5016.523430274118, 5064.493550644943, 5132.5124113209185, 5132.820351287687, 5161.096808058574, 5056.544910958031, 5467.890642187134, 5498.147787092967, 5517.420670829585, 5573.024720673907, 6164.8767024659255, 6175.907361389583, 6198.907016394758, 6206.379362063757, 6221.440070393686, 5945.346011938684, 6211.534134939898, 6246.718897649616, 6254.21822272216, 6270.87458250837, 5640.887182256373, 5671.801486947978, 5688.11834165705, 5759.0, 5772.942270577324, 6239.313675495692, 6244.531660125418, 6251.531135164881, 6271.529635277372, 6285.2457705075685, 5127.846164615067, 5890.911636325459, 6013.9699301503215, 6021.548383871227, 6023.427774361428, 6105.0, 6107.037103281127, 6192.783252586138, 6202.751889924352, 6210.627362358183, 6120.326764055951, 6142.447179753844, 6146.815595532141, 6159.168512250879, 6163.19878415812, 5267.57859371257, 5962.3739507351975, 6173.382661733791, 6204.565680402328, 6205.565610407319, 4870.902581948412, 4894.241392584155, 4899.436564795023, 4962.826301079445, 4972.577330926912, 4338.978305108454, 4359.585839345257, 4396.912061758747, 4404.471463424409, 4416.757078360657, 5451.127819548853, 5606.92690756647, 5611.0741727615305, 5618.185363122325, 5683.630564013326, 5415.539679127318, 6136.12084543884, 6188.551180316468, 6229.314775374705, 6262.499000079983, 4797.688150270221, 5605.66366018032, 5606.439356064442, 5625.0, 5644.181593668895, 5223.973880130575, 5338.9466105339225, 5339.5728341732565, 5370.382406023279, 5406.540444062299, 6228.626282423069, 6234.251889773256, 6283.591566548068, 6308.495320374267, 6319.46284565817, 6186.628802271878, 6211.316755156839, 6229.781957631461, 6236.095766113979, 6242.344553821783, 6160.414760597736, 6288.339724329063, 6288.371162883675, 6291.905621415774, 6320.462760665395, 6017.157597936205, 6062.211912451353, 6077.118817771487, 6098.237720284965, 6105.755769769159, 6012.428819262163, 6127.325994140552, 6135.723892424762, 6144.631322120687, 6161.907571386343, 5810.73851676684, 5919.733611987384, 5927.288725352812, 5931.555133365101, 5932.614380065282, 5937.970310148422, 5941.0, 5946.28644562638, 5953.642781433128, 6001.879962400815, 5776.56675749312, 5779.219805326227, 5792.797252096157, 5803.216565763568, 5808.7095645218415, 5679.346875109415, 5926.466618004228, 5953.28560572734, 5965.463108320272, 5989.071693887455, 5886.705664716661, 5897.675627840338, 5902.852428689317, 5905.734241959036, 5911.290645122613], "value": 5603.305818605486, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [505.9974700126499, 519.9159751917252, 545.0924211188371, 553.872609299861, 565.3526711914857, 29064.709352906466, 29532.261693457647, 29546.0, 29588.260293492647, 29600.0, 30353.241168970788, 39567.802160989224, 40561.58034468794, 40601.59398406015, 40690.0, 9506.667266645669, 9521.47631880248, 9536.666216682417, 9555.569999350046, 9560.56977436017, 8347.040090389592, 9300.627974880997, 9419.0110038446, 9440.244780417584, 9442.527873606326, 8140.674373025102, 11383.658490245305, 11675.591354302602, 11681.474333655005, 11681.883181168207, 11289.548418063268, 11379.943100284529, 11380.260283081656, 11381.487833047533, 11388.71528211793, 8365.163483651648, 11091.059064663652, 11199.0, 11337.773244535145, 11448.198626096177, 38397.62433259346, 38895.8331250063, 38976.80511597452, 39057.0, 39243.8037809812, 3183.060997005889, 3199.96800031999, 3223.774335796495, 3231.466807976681, 3295.8681652733862, 27391.863040684868, 27953.720462795314, 28033.57949630757, 28051.15846524587, 28267.434651307063, 2745.0666773297175, 2758.2001219646277, 2771.182501162162, 2786.150224181624, 2844.0, 408570.0, 472970.0, 473297.0, 475911.0, 476432.0, 62197.0, 62683.37316626866, 62683.6865815668, 62763.372366276664, 62936.68531657404, 67948.0, 68064.3193568058, 68076.97884531735, 68217.65891170512, 68224.0, 16409.83590164107, 16933.0, 16963.0, 16988.830111698724, 17002.809803313896, 11618.825717614243, 11898.405079745979, 11916.46375913086, 11929.463174157183, 11947.462364193632, 15042.946993710335, 17386.3045478182, 18108.36620718295, 18667.81332186688, 18674.626507469773, 5485.0, 6227.0, 6334.873302534015, 6386.489080873519, 6411.198600174978, 923.266003527184, 987.3138168972639, 1004.9095581397563, 1076.321917192164, 1146.8853114688632, 28237.15288541347, 28563.57154642682, 29111.56332655012, 29464.410711785644, 29782.10653680393, 1048.1667074675652, 1063.9255252132432, 1066.461436974323, 1093.316677076827, 1133.1274918312854, 15325.386984520717, 15326.616834579225, 15645.452409165851, 15799.447019354267, 15957.680846383008, 607502.0, 750599.0, 751796.0, 754951.0, 757066.0, 59686.70156649189, 59721.0, 60492.39507604868, 60589.697051515344, 60797.696011520544, 1298.7792075347213, 1310.9147905385928, 1322.7288405876773, 1353.5871559174152, 1471.1173296022514, 25979.610305845807, 29743.958961436245, 29837.0, 30763.0, 31806.36387272195, 54424.095156669326, 59220.11169832542, 61116.08325875204, 61153.0, 61255.0, 483008.0, 489444.0, 491620.0, 494142.0, 494599.0, 23339.649905251776, 23919.16282930089, 26533.0, 27093.72906270912, 27162.32094197661, 35079.12302192466, 47547.0, 48626.5137348622, 49288.014239714284, 50303.74848125882, 35712.642873570934, 36368.636313636525, 37463.43804842984, 37518.43722344113, 38422.0, 36313.0, 36326.818365908, 36898.8155059223, 37135.07162320964, 37181.0, 35701.64298356983, 36251.09372265609, 36459.27081458409, 36784.89645310645, 37292.813535932146, 31893.7242510297, 32487.675123248464, 32553.186170345933, 32840.50739238961, 32874.83562582172, 20139.993000350216, 20304.0, 23997.640035399134, 24343.14798982027, 24906.626400604368], "value": 19596.991872644994, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.52551150352326, 395.70717668925005, 396.4825902197631, 397.40786228519516, 408.6240658594093, 19265.518362040955, 20276.89861550692, 20299.594008119828, 20422.387328380137, 21088.789112108876, 20206.88862112587, 20267.89866050668, 20888.89555552224, 20895.791042089575, 20936.16255349788, 5742.425757424245, 5785.421457854223, 5983.491403230709, 5992.651653377999, 6001.099835024737, 5911.615744976562, 5942.078977758454, 6002.669853158074, 6002.849928751794, 6039.577229593908, 5748.195252664609, 5892.2929248490245, 5926.051831706928, 5928.940710592882, 5929.703514824263, 5672.858178545528, 5901.940980590182, 5903.5572332074835, 5905.763769449239, 6042.9395706042815, 5894.646321220741, 5926.1110833374905, 5934.525237980951, 5939.020061689816, 5949.405059494016, 13137.40881660318, 13649.249291288976, 13886.791698124536, 13910.261217347832, 13942.790858137136, 2005.7994200579972, 2080.1055546115163, 2164.2641501889434, 2411.2645643078854, 2525.0783464035494, 9635.470049147294, 10040.447775372351, 10090.49547522621, 10187.54156062979, 10253.025962533547, 1718.2267979409316, 1759.2523177649448, 1768.1512873820639, 1774.6450709857952, 1791.9820801792075, 78171.0, 78398.6080069596, 110322.9999999992, 117605.23592146125, 118564.0, 11515.193936424537, 11680.70798230051, 11743.588974386026, 11745.706357341134, 11924.046076313874, 13596.048276620542, 14169.504067357593, 14172.433102675777, 14182.574522764333, 15380.846191538165, 7508.0, 8251.546164960864, 8566.3146948244, 8619.78450538729, 8712.39013269065, 8461.534615596202, 8514.063453020286, 8516.914830851736, 8584.914150858536, 8599.828003439896, 4627.467841198305, 4628.467726211461, 4648.907021859543, 4659.603933665677, 4697.694649847749, 1722.371334462912, 1940.98059019408, 1991.9402417927486, 1993.9561949002389, 1998.8400927926023, 881.8192270584515, 902.264654306751, 920.8940971788196, 954.5942974235921, 1006.9748256293504, 19547.456309905676, 20411.79588204099, 20431.182752690023, 20543.58912821735, 20578.485537861372, 965.5558443116105, 973.7468258252906, 973.7468258252906, 981.0777868803302, 986.3687240166299, 9887.555060022316, 10722.927707229215, 10744.946275268574, 10832.795992262258, 10871.130309575216, 545649.0, 636361.0, 638579.0, 656082.0, 667426.0, 133401.0, 139636.0, 143543.0, 144847.0, 145546.0, 814.3241109878786, 1032.4166845732138, 1032.7418145463485, 1055.5988724284723, 1060.2207377577474, 17860.285588576313, 17871.642567148843, 17893.463196104138, 18009.0, 18117.45647630573, 50025.999999998545, 50106.99572017224, 50414.49585504098, 50514.49485505098, 50563.24155137602, 75586.48827023318, 76578.8513172314, 76919.61540192264, 76991.61504192444, 78287.21712782799, 6807.795766127024, 7426.368758655575, 7637.427192960661, 7677.155512893689, 8411.411201215857, 9416.387934784218, 12367.14204449046, 12635.873641263837, 13025.869741302466, 13036.608901732963, 11043.447827608748, 11242.887571124184, 11253.0, 11551.364674942959, 11562.76874462523, 10825.729356766144, 10904.400257985886, 10911.236213464981, 11130.944345278222, 11160.888391115985, 10858.987040756312, 11433.142514311627, 11450.599229026944, 11763.529458821551, 11928.821067684165, 8229.670813167406, 8242.793930151794, 8316.83366332682, 8324.458910170819, 8673.566321684017, 9810.85283720759, 11184.608538701106, 11566.595169169039, 11601.651950441501, 11750.647480575597], "value": 9393.924468925357, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1402.6703724624706, 1493.8655521003107, 1579.6524764551802, 1796.6586348593767, 1949.7465329507163, 7866.803329916755, 8581.39930204886, 8838.779030524223, 8842.248408885236, 8846.248068914134, 8591.742247732578, 8603.526806025666, 8701.434406763572, 8708.25979791717, 8732.432391894523, 2131.1581925139562, 2402.759724027601, 2436.4639779248537, 2466.5313590417854, 2472.2706801493514, 2487.9751202488014, 2505.498900219954, 2507.8244522883406, 2508.7114981777054, 2508.8996440142373, 2428.9514209715885, 2464.938376540592, 2468.5309791139625, 2474.158786012755, 2480.590702534089, 1799.199356286453, 2371.893264803088, 2433.9634905476432, 2444.4866578018637, 2467.2351571012864, 2451.399407145243, 2475.344033831036, 2475.4677744285063, 2484.751524847519, 2485.9931727650333, 8570.057293697688, 8658.134186581354, 8661.263792577638, 8665.956670216672, 8671.913280867173, 5201.609879259071, 5341.759620817073, 5348.51863332298, 5354.973225133849, 5373.382061062989, 3383.3571621392102, 3494.9301013979834, 3619.8371073301764, 3624.8187590620364, 3629.201575653352, 1057.9206559508068, 1061.458656085402, 1063.8457423673524, 1074.1138560687464, 1079.9082078023378, 11628.592999244986, 11638.709032274177, 11645.94177029118, 11662.416879156093, 11665.358405287705, 4729.881752956204, 4746.551503140414, 4800.687955282895, 4914.238293064581, 4948.975255123702, 9826.557804898797, 9893.406395616286, 9904.15814655748, 9910.405375677483, 9948.403095814274, 5364.14173732201, 5396.244525766396, 5406.567474602022, 5433.212184233343, 5434.3207099112615, 3983.581723918947, 4315.741055536678, 4382.05785756064, 4904.558589726942, 4916.778744956486, 3964.0882597002274, 4002.939955900664, 4033.4353190553347, 4083.5099788025627, 4091.3658382950093, 1265.4368805881295, 1333.759923213831, 1357.850636429992, 1358.9116707413987, 1373.8969577281744, 1128.8758236593967, 1306.5231190615357, 1337.7926421404504, 1360.9523666671619, 1363.9727205455836, 7695.076590809139, 7731.226877312224, 8104.716334928367, 8143.592820358958, 8195.590220489072, 1118.8042092633757, 1163.755611321632, 1172.8709841917382, 1185.5139392848891, 1208.7582483503334, 6050.273967123973, 6214.596051256744, 6420.06908998202, 6441.066045423388, 6450.032495125675, 10306.948465257627, 10757.031867131996, 10861.83707244392, 10881.782364352668, 10906.236563440483, 10128.03783640553, 10574.52414641343, 10642.93570642945, 10800.351978881292, 10860.076893463985, 7999.720009799629, 8122.390820688472, 8168.387370947203, 8171.142030086755, 8198.180181981874, 8078.3133433658795, 8243.505389676639, 8304.377171712267, 8313.875291870505, 8323.126071762377, 9687.564059617192, 9741.074597913186, 10057.24570657189, 10057.69826905194, 10156.0, 8704.738857834274, 9075.319351048565, 10098.646547370807, 10144.289899707244, 10337.534810933375, 6961.965190174017, 7140.821479463055, 7156.248593897566, 7365.484416091036, 7653.234676532302, 8116.959415202886, 8162.347012239125, 8176.83646327082, 8196.344292456708, 8226.383021273308, 6978.965105174441, 7133.357997780225, 7464.626768661654, 7476.177620461854, 7591.316781489692, 6401.231852177769, 7168.354848063699, 7244.710211591688, 7481.551106933383, 7503.062117235346, 7780.1052878919645, 7801.29788319054, 7892.644830982735, 7894.131645519104, 7913.169117242606, 6989.33601307875, 7078.610676412847, 7084.752033678797, 7092.219855815959, 7129.714811407485, 7081.681324340314, 7205.495615307088, 7208.675609597476, 7214.89177662346, 7226.132864056347], "value": 4936.373285836356, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.3432962427025, 322.71923426618844, 327.96720327967193, 330.1515106177125, 335.9546461227735, 5697.715114244287, 5734.569907256951, 5753.338366087901, 5780.5664575156825, 5842.328132264791, 5702.45826646469, 5717.542596592273, 5721.742521586528, 5744.0, 5765.913511297334, 3835.7698538087666, 3847.2882516734353, 4026.758394496325, 4049.75701457912, 4450.243458612027, 4009.5389030261454, 4379.4963579188325, 4397.978010109945, 4415.2494076007, 4422.159789639974, 4324.481062272516, 4359.324304732756, 4363.869083927487, 4395.208862404766, 4399.802008909591, 3988.9800550997206, 4132.132252227036, 4171.91656166875, 4193.769342686151, 4408.801603927799, 3808.0, 3813.4089216171537, 3821.503204583414, 3826.521684789401, 3845.788481633509, 4925.9901720147645, 5472.5621950243885, 5490.725463726798, 5511.559075273968, 5515.944840551583, 4839.298301746262, 5040.0, 5057.4689657585795, 5077.898442031175, 5103.413107492649, 5998.0, 6038.486728628071, 6062.939370606282, 6067.878642427171, 6070.423309785563, 4247.277962746341, 4248.277792775236, 4254.723442976197, 4258.5954334338185, 4265.53079161292, 5781.814727980796, 5855.677937713424, 6015.706623076016, 6096.298925623566, 6446.419822216023, 3746.269477451871, 4247.893802654897, 4257.595528424795, 4264.296391095497, 4271.594198551133, 4307.6769242306955, 4355.80398882051, 4365.607095361433, 4373.343998400202, 4398.956010439919, 4926.524687307369, 4959.801607935714, 5025.522575355335, 5052.1663925451885, 5059.800365696463, 5644.379118296984, 5688.862227554423, 6054.0, 6103.786367477117, 6107.633541987495, 1486.576325747157, 1514.681916797463, 1517.347540557571, 1519.688463864905, 1519.8980738964383, 964.0504103458088, 1001.5743309093606, 1003.2174903575223, 1015.6343716262139, 1017.4709151241314, 5346.8395948121615, 5415.025295446857, 5501.972490137524, 5610.49505544503, 5762.654240745569, 5443.9384320058, 5604.747786349624, 6299.370062993664, 6326.240851097806, 6359.745610175633, 5397.541208997279, 5462.535684466785, 5657.688827114548, 5674.9217648647455, 5725.942740572541, 2709.525832979221, 2847.8718457669456, 3114.2214446388402, 3275.901722948315, 3317.3696997570382, 5514.779408823682, 6315.652639104802, 6391.744330226739, 6544.149260596092, 6596.241432235259, 6258.748250349949, 6461.806145815539, 6469.997150441689, 6479.870402591921, 6525.608463492205, 5769.9711501442225, 6529.408825146151, 6533.901991470132, 6558.048673251665, 6569.343065693583, 5956.0, 6264.404881536247, 6280.780172693934, 6289.842753931189, 6293.433590976834, 5496.708273555631, 5620.74706638194, 5639.601111133323, 5732.111522713986, 6219.973704338733, 6158.476529495043, 6272.8118156455375, 6440.710168042356, 6501.122348482894, 6653.933460665331, 4260.701750877409, 4327.567243275647, 4337.7831108443825, 4352.717073390219, 4360.738355698668, 5488.725563721718, 5573.665580065209, 6077.939220607737, 6335.176427064452, 6347.746090156526, 5819.127130930225, 6084.75262571163, 6108.877822443437, 6119.694015299307, 6150.323464419, 6038.003729384603, 6064.848378790565, 6090.9390906090375, 6097.817065488042, 6105.84735381619, 5785.3636100028125, 5892.440218179266, 5941.465268125889, 5947.078202878561, 5994.460498555151, 5185.170372740495, 6035.305939816802, 6062.695830772328, 6088.6042407243385, 6092.69536523181, 4858.3441235432765, 5945.959457095078, 5970.701464926823, 5982.252218472691, 5995.910061348996], "value": 4483.55123475461, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [750.5271678842329, 754.9849003019943, 758.2152472191283, 768.2970082374624, 821.4906757810156, 13724.17654940703, 15170.620734481643, 15187.772183417257, 15204.011739236941, 15230.238488075607, 13933.233672148028, 14019.649508762286, 14022.368993395296, 14025.78961315581, 14049.64875878101, 735.4888352594922, 758.0486489455725, 897.5108565831638, 924.1036194890962, 950.3110245072302, 929.4794914847707, 940.1068984464786, 942.0955882352949, 942.3121121581249, 945.2815859946421, 996.8006398720285, 1003.2124782046095, 1005.005045005443, 1005.5977608956402, 1005.8189525885338, 776.3207193705508, 953.6471505542925, 987.629638885418, 992.007992007992, 997.2171845101597, 734.9595772232525, 735.8234023834294, 738.2469880721634, 738.2469880721687, 739.486057190253, 14871.182084985321, 14966.850331496655, 14975.026623269561, 15010.949233553656, 15015.849841501664, 12451.564195253213, 12488.625341239778, 12603.621891343275, 12646.683832904158, 12700.42848071839, 8970.327225458052, 9814.90185098147, 10047.849282260771, 10095.545700443497, 10221.02887771931, 3490.685838274542, 3513.896177189855, 3552.3960926642535, 3618.6924111450558, 3648.452732090181, 74319.0, 75149.0, 76472.0, 76957.61521192415, 77150.0, 9045.909540904639, 9351.766205844908, 9470.479123648127, 9637.614495420245, 9764.414135151914, 21560.24539141154, 21617.0, 21640.56718865614, 21651.56696866054, 21669.241576544744, 7352.485326027234, 7424.814379640552, 7526.09686837583, 7631.3513351365755, 7669.9616501917135, 4060.1879624075304, 4115.8765237042935, 4122.835086596562, 4231.78841057952, 4359.869203923888, 3491.633378495272, 3605.3330133925306, 3608.963910360863, 3610.205754734007, 3611.0611241076986, 576.469647923911, 616.2825205262673, 632.5477283742055, 640.7821340744076, 664.1432552007952, 503.32805704385055, 565.4006752842, 579.9281522459838, 583.1777194156305, 607.6445279511536, 7590.1650818409935, 7802.609869506502, 7876.842463150705, 8128.187181281943, 8362.58187090643, 574.6381076847814, 583.6031498581006, 593.9584229104007, 619.0, 627.7332133843098, 3749.5500539935383, 3810.942835857464, 3812.066043819282, 3986.4418981342637, 4014.538328092307, 82421.0, 84385.57807210925, 84817.0, 85633.0, 86238.0, 74548.15436996687, 74856.25143748602, 75098.0, 75299.24700752922, 75520.62239688876, 50374.74812625913, 61928.0, 66427.66786166039, 67504.6624766873, 68072.31927680758, 7405.0, 7450.327826381649, 7561.3194812467145, 7565.0, 7616.771496855104, 41312.1737565241, 42079.789601053024, 42309.1538169241, 42483.0, 43164.784176078916, 57464.71267643635, 58100.70949645225, 58810.41189588049, 60658.48353791014, 61004.694976524836, 8518.990186530926, 10196.898031019595, 10225.43760093202, 10225.84661230097, 10294.742631434274, 9066.50134242623, 10652.680419587425, 10714.089302409382, 10783.6225732099, 10878.836817447585, 8971.775705607412, 10228.59085636596, 10233.48832558384, 11342.0, 11470.541178352772, 11063.778724425627, 11109.666709998713, 11125.944370278097, 11160.944195278971, 11411.372374519482, 10898.945505272422, 10950.288231265262, 10962.890371096188, 11226.270292430965, 11295.943520282346, 9408.43549387039, 9472.905270947202, 9514.476703781358, 9633.401120232664, 9725.708228753148, 9273.86089208649, 9541.904580954102, 9610.27922905799, 9948.078404093989, 10051.396916185053], "value": 6728.379248472431, "unit": "score"}], "name": "dromaeo_css", "value": 7318.298204283411, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 110.0, 113.0, 156.0, 160.0, 114.0, 118.0, 114.0, 112.0, 113.0], "value": 122.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 121.0, 145.0, 171.0, 119.0, 141.0, 140.0, 120.0, 206.0, 150.0], "value": 147.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 185.0, 188.0, 186.0, 188.0, 186.0, 184.0, 186.0, 187.0, 186.0], "value": 186.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 74.0, 86.0, 91.0, 55.0, 61.0, 57.0, 80.0, 84.0, 55.0], "value": 72.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 93.0, 135.0, 74.0, 108.0, 123.0, 154.0, 78.0, 80.0, 132.0], "value": 106.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 88.0, 85.0, 87.0, 84.0, 88.0, 85.0, 88.0, 84.0], "value": 86.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 93.0, 93.0, 95.0, 94.0, 92.0, 94.0], "value": 93.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 100.0, 117.0, 128.0, 131.0, 86.0, 84.0, 86.0, 84.0, 86.0], "value": 98.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 53.0, 52.0, 54.0, 53.0, 53.0, 72.0, 54.0, 52.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 72.0, 73.0, 71.0, 71.0, 69.0, 68.0, 69.0, 68.0], "value": 69.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 85.0, 86.0, 84.0, 86.0, 85.0, 83.0, 86.0, 87.0], "value": 85.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 141.0, 140.0, 142.0, 141.0, 144.0, 186.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 214.0, 198.0, 169.0, 169.0, 172.0, 167.0, 169.0, 168.0, 171.0], "value": 177.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 69.0, 68.0, 66.0, 66.0, 67.0, 69.0, 68.0, 69.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1515.8000000000002, "alertThreshold": 2.0}]} 13:32:51 INFO - Return code: 0 13:32:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:32:51 ERROR - # TBPL SUCCESS # 13:32:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:32:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:32:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:32:51 INFO - 2016-04-12 13:32:51.987 screenresolution[1940:21611] starting screenresolution argv=screenresolution get 13:32:51 INFO - 2016-04-12 13:32:51.990 screenresolution[1940:21611] Display 0: 1600x1200x32@60 13:32:51 INFO - 2016-04-12 13:32:51.995 screenresolution[1941:21614] starting screenresolution argv=screenresolution list 13:32:51 INFO - Available Modes on Display 0 13:32:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:32:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:32:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:32:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:32:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:32:52 INFO - Intel Iris: 13:32:52 INFO - Chipset Model: Intel Iris 13:32:52 INFO - Type: GPU 13:32:52 INFO - Bus: Built-In 13:32:52 INFO - VRAM (Dynamic, Max): 1536 MB 13:32:52 INFO - Vendor: Intel (0x8086) 13:32:52 INFO - Device ID: 0x0a2e 13:32:52 INFO - Revision ID: 0x0009 13:32:52 INFO - Displays: 13:32:52 INFO - Display: 13:32:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:32:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:32:52 INFO - Display Serial Number: 1600x1200 60 13:32:52 INFO - Main Display: Yes 13:32:52 INFO - Mirror: Off 13:32:52 INFO - Online: Yes 13:32:52 INFO - Rotation: Supported 13:32:52 INFO - Return code: 0 13:32:52 INFO - Running post-action listener: _resource_record_post_action 13:32:52 INFO - Running post-run listener: _resource_record_post_run 13:32:53 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 434176; Write bytes: 694881280; Read time: 8; Write time: 2060 13:32:53 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 388000256; Write bytes: 383485952; Read time: 28877; Write time: 765 13:32:53 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 434176; Write bytes: 298107904; Read time: 8; Write time: 1261 13:32:53 INFO - Running post-run listener: _upload_blobber_files 13:32:53 INFO - Blob upload gear active. 13:32:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:32:53 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:32:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:32:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:32:53 INFO - (blobuploader) - INFO - Open directory for files ... 13:32:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:32:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:32:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:32:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:32:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:32:54 INFO - (blobuploader) - INFO - Done attempting. 13:32:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:32:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:32:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:32:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:32:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:32:55 INFO - (blobuploader) - INFO - Done attempting. 13:32:55 INFO - (blobuploader) - INFO - Iteration through files over. 13:32:55 INFO - Return code: 0 13:32:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:32:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:32:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/af01eed40de349d1e7ef77140d97ef3960b455bb3a6774683fb54857e6e1b64c5f0e388ef76db292428bd1082cd07636d72091c27b41715670fe829f4d64cb89", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/14f9ca1606b899fc31881b7b7ac672398f858ffa9eeb831ef8cdbb510e7ea51f333e86bf3e2f7f3bc682c6f5338eedf13baa1d7f552b9415550ceeb906d64bb6"} 13:32:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:32:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:32:55 INFO - Contents: 13:32:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/af01eed40de349d1e7ef77140d97ef3960b455bb3a6774683fb54857e6e1b64c5f0e388ef76db292428bd1082cd07636d72091c27b41715670fe829f4d64cb89", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/14f9ca1606b899fc31881b7b7ac672398f858ffa9eeb831ef8cdbb510e7ea51f333e86bf3e2f7f3bc682c6f5338eedf13baa1d7f552b9415550ceeb906d64bb6"} 13:32:55 INFO - Running post-run listener: copy_logs_to_upload_dir 13:32:55 INFO - Copying logs to upload dir... 13:32:55 INFO - mkdir: /builds/slave/test/build/upload/logs 13:32:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.452025 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-04-12 13:32:55.493506) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-12 13:32:55.498052) ========= 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.BCisJWNLtS/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.y1SPfZAJ5V/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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/af01eed40de349d1e7ef77140d97ef3960b455bb3a6774683fb54857e6e1b64c5f0e388ef76db292428bd1082cd07636d72091c27b41715670fe829f4d64cb89", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/14f9ca1606b899fc31881b7b7ac672398f858ffa9eeb831ef8cdbb510e7ea51f333e86bf3e2f7f3bc682c6f5338eedf13baa1d7f552b9415550ceeb906d64bb6"} build_url:https://queue.taskcluster.net/v1/task/fM9UUN2aTjePuPdqcuqu6A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011182 build_url: 'https://queue.taskcluster.net/v1/task/fM9UUN2aTjePuPdqcuqu6A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/af01eed40de349d1e7ef77140d97ef3960b455bb3a6774683fb54857e6e1b64c5f0e388ef76db292428bd1082cd07636d72091c27b41715670fe829f4d64cb89", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/14f9ca1606b899fc31881b7b7ac672398f858ffa9eeb831ef8cdbb510e7ea51f333e86bf3e2f7f3bc682c6f5338eedf13baa1d7f552b9415550ceeb906d64bb6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-12 13:32:55.525217) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 13:32:55.525539) ========= 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.BCisJWNLtS/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.y1SPfZAJ5V/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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.005442 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 13:32:55.577494) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-12 13:32:55.580825) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-12 13:32:55.581292) ========= ========= Total master_lag: 0.33 =========