builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0023 starttime: 1458152109.92 results: success (0) buildid: 20160316090541 builduid: a9c76d89766347ca9b6882d876ee7b79 revision: 06ae85d888e8b112a60cf34fe2f1a305ea92d8c0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-16 11:15:09.923206) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-16 11:15:09.923643) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-16 11:15:09.923950) ========= 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.6SUHLDpPDA/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.DOoRtC8pZN/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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.005582 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-16 11:15:09.951515) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-16 11:15:09.951857) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-16 11:15:09.970909) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 11:15:09.971283) ========= 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.6SUHLDpPDA/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.DOoRtC8pZN/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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.005612 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 11:15:10.019671) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-16 11:15:10.023079) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-16 11:15:10.023497) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 11:15:10.023784) ========= 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.6SUHLDpPDA/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.DOoRtC8pZN/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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-03-16 11:15:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 45.2M=0s 2016-03-16 11:15:10 (45.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121469 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 11:15:10.161456) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 11:15:10.161778) ========= 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.6SUHLDpPDA/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.DOoRtC8pZN/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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.026517 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 11:15:10.211910) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-16 11:15:10.212653) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 06ae85d888e8b112a60cf34fe2f1a305ea92d8c0 --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 06ae85d888e8b112a60cf34fe2f1a305ea92d8c0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6SUHLDpPDA/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.DOoRtC8pZN/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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-03-16 11:15:10,288 truncating revision to first 12 chars 2016-03-16 11:15:10,288 Setting DEBUG logging. 2016-03-16 11:15:10,288 attempt 1/10 2016-03-16 11:15:10,288 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/06ae85d888e8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-16 11:15:11,976 unpacking tar archive at: fx-team-06ae85d888e8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.930826 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-16 11:15:12.160651) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-16 11:15:12.161018) ========= echo 06ae85d888e8b112a60cf34fe2f1a305ea92d8c0 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'06ae85d888e8b112a60cf34fe2f1a305ea92d8c0'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6SUHLDpPDA/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.DOoRtC8pZN/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 06ae85d888e8b112a60cf34fe2f1a305ea92d8c0 program finished with exit code 0 elapsedTime=0.005293 script_repo_revision: '06ae85d888e8b112a60cf34fe2f1a305ea92d8c0' ========= master_lag: 0.08 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-16 11:15:12.244890) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-16 11:15:12.245208) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-16 11:15:12.259391) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-03-16 11:15:12.259744) ========= /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.6SUHLDpPDA/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.DOoRtC8pZN/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 11:15:12 INFO - MultiFileLogger online at 20160316 11:15:12 in /builds/slave/test 11:15:12 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 11:15:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:15:12 INFO - {'append_to_log': False, 11:15:12 INFO - 'base_work_dir': '/builds/slave/test', 11:15:12 INFO - 'blob_upload_branch': 'Fx-Team', 11:15:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:15:12 INFO - 'branch': 'Fx-Team', 11:15:12 INFO - 'buildbot_json_path': 'buildprops.json', 11:15:12 INFO - 'config_files': ('talos/mac_config.py',), 11:15:12 INFO - 'default_actions': ('clobber', 11:15:12 INFO - 'read-buildbot-config', 11:15:12 INFO - 'download-and-extract', 11:15:12 INFO - 'populate-webroot', 11:15:12 INFO - 'create-virtualenv', 11:15:12 INFO - 'install', 11:15:12 INFO - 'run-tests'), 11:15:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:15:12 INFO - 'download_minidump_stackwalk': True, 11:15:12 INFO - 'download_symbols': 'ondemand', 11:15:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:15:12 INFO - 'tooltool.py': '/tools/tooltool.py', 11:15:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:15:12 INFO - '/tools/misc-python/virtualenv.py')}, 11:15:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:15:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:15:12 INFO - 'installer_path': 'installer.exe', 11:15:12 INFO - 'log_level': 'info', 11:15:12 INFO - 'log_name': 'talos', 11:15:12 INFO - 'log_to_console': True, 11:15:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:15:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:15:12 INFO - 'opt_config_files': (), 11:15:12 INFO - 'pip_index': False, 11:15:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:15:12 INFO - 'cmd': ('bash', 11:15:12 INFO - '-c', 11:15:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:15:12 INFO - 'enabled': True, 11:15:12 INFO - 'halt_on_failure': False, 11:15:12 INFO - 'name': 'check_screen_resolution'},), 11:15:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:15:12 INFO - 'cmd': ('bash', 11:15:12 INFO - '-c', 11:15:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:15:12 INFO - 'enabled': True, 11:15:12 INFO - 'halt_on_failure': False, 11:15:12 INFO - 'name': 'check_screen_resolution'},), 11:15:12 INFO - 'run_cmd_checks_enabled': True, 11:15:12 INFO - 'sps_profile': False, 11:15:12 INFO - 'sps_profile_interval': 0, 11:15:12 INFO - 'suite': 'dromaeojs', 11:15:12 INFO - 'system_bits': '32', 11:15:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:15:12 INFO - 'title': 't-yosemite-r7-0023', 11:15:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:15:12 INFO - 'use_talos_json': True, 11:15:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:15:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:15:12 INFO - 'work_dir': 'build'} 11:15:12 INFO - ##### 11:15:12 INFO - ##### Running clobber step. 11:15:12 INFO - ##### 11:15:12 INFO - Running pre-action listener: _resource_record_pre_action 11:15:12 INFO - Running main action method: clobber 11:15:12 INFO - rmtree: /builds/slave/test/build 11:15:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:15:13 INFO - Running post-action listener: _resource_record_post_action 11:15:13 INFO - ##### 11:15:13 INFO - ##### Running read-buildbot-config step. 11:15:13 INFO - ##### 11:15:13 INFO - Running pre-action listener: _resource_record_pre_action 11:15:13 INFO - Running main action method: read_buildbot_config 11:15:13 INFO - Using buildbot properties: 11:15:13 INFO - { 11:15:13 INFO - "project": "", 11:15:13 INFO - "product": "firefox", 11:15:13 INFO - "script_repo_revision": "production", 11:15:13 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 11:15:13 INFO - "repository": "", 11:15:13 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 11:15:13 INFO - "buildid": "20160316090541", 11:15:13 INFO - "pgo_build": "False", 11:15:13 INFO - "basedir": "/builds/slave/test", 11:15:13 INFO - "buildnumber": 503, 11:15:13 INFO - "slavename": "t-yosemite-r7-0023", 11:15:13 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 11:15:13 INFO - "platform": "yosemite_r7", 11:15:13 INFO - "scheduler": "tests-fx-team-macosx64-talos", 11:15:13 INFO - "branch": "fx-team", 11:15:13 INFO - "repo_path": "integration/fx-team", 11:15:13 INFO - "revision": "06ae85d888e8b112a60cf34fe2f1a305ea92d8c0", 11:15:13 INFO - "stage_platform": "macosx64", 11:15:13 INFO - "builduid": "a9c76d89766347ca9b6882d876ee7b79", 11:15:13 INFO - "slavebuilddir": "test" 11:15:13 INFO - } 11:15:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/MQDhjE4DSC-qMfhU4Y6f9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 11:15:13 INFO - Running post-action listener: _resource_record_post_action 11:15:13 INFO - ##### 11:15:13 INFO - ##### Running download-and-extract step. 11:15:13 INFO - ##### 11:15:13 INFO - Running pre-action listener: _resource_record_pre_action 11:15:13 INFO - Running main action method: download_and_extract 11:15:13 INFO - mkdir: /builds/slave/test/build/tests 11:15:13 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')]} 11:15:13 INFO - https://queue.taskcluster.net/v1/task/MQDhjE4DSC-qMfhU4Y6f9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 11:15:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MQDhjE4DSC-qMfhU4Y6f9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 11:15:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MQDhjE4DSC-qMfhU4Y6f9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 11:15:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MQDhjE4DSC-qMfhU4Y6f9Q/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 11:15:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MQDhjE4DSC-qMfhU4Y6f9Q/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 11:15:15 INFO - Downloaded 1199 bytes. 11:15:15 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 11:15:15 INFO - Using the following test package requirements: 11:15:15 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 11:15:15 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:15:15 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 11:15:15 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:15:15 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 11:15:15 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:15:15 INFO - u'jsshell-mac.zip'], 11:15:15 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:15:15 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 11:15:15 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 11:15:15 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:15:15 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 11:15:15 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:15:15 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 11:15:15 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:15:15 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 11:15:15 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:15:15 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 11:15:15 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:15: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')]} 11:15:15 INFO - https://queue.taskcluster.net/v1/task/MQDhjE4DSC-qMfhU4Y6f9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:15:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MQDhjE4DSC-qMfhU4Y6f9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:15:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MQDhjE4DSC-qMfhU4Y6f9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:15:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MQDhjE4DSC-qMfhU4Y6f9Q/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 11:15:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MQDhjE4DSC-qMfhU4Y6f9Q/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 11:15:16 INFO - Downloaded 17854613 bytes. 11:15:16 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'] 11:15:16 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 11:15:19 INFO - Return code: 0 11:15:19 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 11:15: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')]} 11:15:19 INFO - https://queue.taskcluster.net/v1/task/MQDhjE4DSC-qMfhU4Y6f9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:15:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MQDhjE4DSC-qMfhU4Y6f9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:15:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MQDhjE4DSC-qMfhU4Y6f9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:15:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MQDhjE4DSC-qMfhU4Y6f9Q/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 11:15:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MQDhjE4DSC-qMfhU4Y6f9Q/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 11:15:20 INFO - Downloaded 17854613 bytes. 11:15:20 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'] 11:15:20 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 11:15:24 INFO - Return code: 0 11:15: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')]} 11:15:24 INFO - https://queue.taskcluster.net/v1/task/MQDhjE4DSC-qMfhU4Y6f9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 11:15:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MQDhjE4DSC-qMfhU4Y6f9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 11:15:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MQDhjE4DSC-qMfhU4Y6f9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 11:15:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MQDhjE4DSC-qMfhU4Y6f9Q/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 11:15:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MQDhjE4DSC-qMfhU4Y6f9Q/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 11:15:25 INFO - Downloaded 10846462 bytes. 11:15:25 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'] 11:15:25 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 11:15:26 INFO - Return code: 0 11:15:26 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')]} 11:15:26 INFO - https://queue.taskcluster.net/v1/task/MQDhjE4DSC-qMfhU4Y6f9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 11:15:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MQDhjE4DSC-qMfhU4Y6f9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 11:15:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MQDhjE4DSC-qMfhU4Y6f9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 11:15:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MQDhjE4DSC-qMfhU4Y6f9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 11:15:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MQDhjE4DSC-qMfhU4Y6f9Q/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 11:15:29 INFO - Downloaded 111191352 bytes. 11:15:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MQDhjE4DSC-qMfhU4Y6f9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 11:15:29 INFO - mkdir: /builds/slave/test/properties 11:15:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:15:29 INFO - Writing to file /builds/slave/test/properties/build_url 11:15:29 INFO - Contents: 11:15:29 INFO - build_url:https://queue.taskcluster.net/v1/task/MQDhjE4DSC-qMfhU4Y6f9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 11:15:30 INFO - Running post-action listener: _resource_record_post_action 11:15:30 INFO - Running post-action listener: set_extra_try_arguments 11:15:30 INFO - ##### 11:15:30 INFO - ##### Running populate-webroot step. 11:15:30 INFO - ##### 11:15:30 INFO - Running pre-action listener: _resource_record_pre_action 11:15:30 INFO - Running main action method: populate_webroot 11:15:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:15:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:15:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:15:30 INFO - '--tppagecycles', 11:15:30 INFO - '7'], 11:15:30 INFO - 'tests': ['tsvgm']}}, 11:15:30 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:15:30 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:15:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:15:30 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 11:15:30 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:15:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:15:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:15:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:15:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:15:30 INFO - 'talos_options': ['--e10s'], 11:15:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:15:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:15:30 INFO - 'tests': ['damp', 'tps']}, 11:15:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:15:30 INFO - 'talos_options': ['--e10s'], 11:15:30 INFO - 'tests': ['damp', 'tps']}, 11:15:30 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:15:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:15:30 INFO - 'other': {'tests': ['a11yr', 11:15:30 INFO - 'ts_paint', 11:15:30 INFO - 'tpaint', 11:15:30 INFO - 'sessionrestore', 11:15:30 INFO - 'sessionrestore_no_auto_restore', 11:15:30 INFO - 'tabpaint']}, 11:15:30 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:15:30 INFO - 'tests': ['a11yr', 11:15:30 INFO - 'ts_paint', 11:15:30 INFO - 'tpaint', 11:15:30 INFO - 'sessionrestore', 11:15:30 INFO - 'sessionrestore_no_auto_restore', 11:15:30 INFO - 'tabpaint']}, 11:15:30 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:15:30 INFO - 'tests': ['a11yr', 11:15:30 INFO - 'ts_paint', 11:15:30 INFO - 'tpaint', 11:15:30 INFO - 'sessionrestore', 11:15:30 INFO - 'sessionrestore_no_auto_restore', 11:15:30 INFO - 'tabpaint']}, 11:15:30 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:15:30 INFO - 'tests': ['a11yr', 11:15:30 INFO - 'ts_paint', 11:15:30 INFO - 'tpaint', 11:15:30 INFO - 'sessionrestore', 11:15:30 INFO - 'sessionrestore_no_auto_restore', 11:15:30 INFO - 'tabpaint']}, 11:15:30 INFO - 'other_l64': {'tests': ['a11yr', 11:15:30 INFO - 'ts_paint', 11:15:30 INFO - 'tpaint', 11:15:30 INFO - 'sessionrestore', 11:15:30 INFO - 'sessionrestore_no_auto_restore', 11:15:30 INFO - 'tabpaint']}, 11:15:30 INFO - 'other_nol64': {'tests': ['a11yr', 11:15:30 INFO - 'ts_paint', 11:15:30 INFO - 'tpaint', 11:15:30 INFO - 'sessionrestore', 11:15:30 INFO - 'sessionrestore_no_auto_restore', 11:15:30 INFO - 'tabpaint']}, 11:15:30 INFO - 'svgr': {'tests': ['tsvgx', 11:15:30 INFO - 'tsvgr_opacity', 11:15:30 INFO - 'tart', 11:15:30 INFO - 'tscrollx', 11:15:30 INFO - 'cart']}, 11:15:30 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:15:30 INFO - 'tests': ['tsvgx', 11:15:30 INFO - 'tsvgr_opacity', 11:15:30 INFO - 'tart', 11:15:30 INFO - 'tscrollx', 11:15:30 INFO - 'cart']}, 11:15:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:15:30 INFO - 'tests': ['tp5o']}, 11:15:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:15:30 INFO - 'talos_options': ['--e10s'], 11:15:30 INFO - 'tests': ['tp5o']}, 11:15:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:15:30 INFO - 'talos_options': ['--xperf_path', 11:15:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:15:30 INFO - 'tests': ['tp5n']}, 11:15:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:15:30 INFO - 'talos_options': ['--e10s', 11:15:30 INFO - '--xperf_path', 11:15:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:15:30 INFO - 'tests': ['tp5n']}}, 11:15:30 INFO - 'talos.zip': {'path': '', 11:15:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:15:30 INFO - Running post-action listener: _resource_record_post_action 11:15:30 INFO - ##### 11:15:30 INFO - ##### Running create-virtualenv step. 11:15:30 INFO - ##### 11:15:30 INFO - Running pre-action listener: _resource_record_pre_action 11:15:30 INFO - Running main action method: create_virtualenv 11:15:30 INFO - Creating virtualenv /builds/slave/test/build/venv 11:15:30 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:15:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:15:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:15:30 INFO - Using real prefix '/tools/python27' 11:15:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:15:31 INFO - Installing distribute.............................................................................................................................................................................................done. 11:15:34 INFO - Installing pip.................done. 11:15:34 INFO - Return code: 0 11:15:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:15: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')]} 11:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15: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')]} 11:15:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107e9ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ea64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec33dbda80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d42d30>, '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 0x107b66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d39b20>, '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.6SUHLDpPDA/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.DOoRtC8pZN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 11:15:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:15:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:15:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6SUHLDpPDA/Render', 11:15:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:15:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:15:34 INFO - 'HOME': '/Users/cltbld', 11:15:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:15:34 INFO - 'LOGNAME': 'cltbld', 11:15:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:34 INFO - 'MOZ_NO_REMOTE': '1', 11:15:34 INFO - 'NO_EM_RESTART': '1', 11:15:34 INFO - 'PAGER': '/bin/cat', 11:15:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:15:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:34 INFO - 'PWD': '/builds/slave/test', 11:15:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:15:34 INFO - 'SHELL': '/bin/bash', 11:15:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DOoRtC8pZN/Listeners', 11:15:34 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 11:15:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:15:34 INFO - 'USER': 'cltbld', 11:15:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:15:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:15:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:34 INFO - 'XPC_FLAGS': '0x0', 11:15:34 INFO - 'XPC_SERVICE_NAME': '0', 11:15:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:15:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:34 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:15:34 INFO - Cleaning up... 11:15:34 INFO - Return code: 0 11:15:34 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:15: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')]} 11:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15: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')]} 11:15:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107e9ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ea64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec33dbda80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d42d30>, '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 0x107b66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d39b20>, '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.6SUHLDpPDA/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.DOoRtC8pZN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 11:15:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 11:15:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 11:15:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6SUHLDpPDA/Render', 11:15:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:15:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:15:34 INFO - 'HOME': '/Users/cltbld', 11:15:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:15:34 INFO - 'LOGNAME': 'cltbld', 11:15:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:34 INFO - 'MOZ_NO_REMOTE': '1', 11:15:34 INFO - 'NO_EM_RESTART': '1', 11:15:34 INFO - 'PAGER': '/bin/cat', 11:15:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:15:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:34 INFO - 'PWD': '/builds/slave/test', 11:15:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:15:34 INFO - 'SHELL': '/bin/bash', 11:15:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DOoRtC8pZN/Listeners', 11:15:34 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 11:15:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:15:34 INFO - 'USER': 'cltbld', 11:15:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:15:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:15:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:34 INFO - 'XPC_FLAGS': '0x0', 11:15:34 INFO - 'XPC_SERVICE_NAME': '0', 11:15:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:15:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:34 INFO - Downloading/unpacking psutil>=0.7.1 11:15: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 11:15: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 11:15: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 11:15: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 11:15: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 11:15: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 11:15:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:15:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:15:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:15:37 INFO - Installing collected packages: psutil 11:15:37 INFO - Running setup.py install for psutil 11:15:37 INFO - building 'psutil._psutil_osx' extension 11:15:37 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 11:15:38 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 11:15:38 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 11:15:38 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 11:15:38 INFO - building 'psutil._psutil_posix' extension 11:15:38 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 11:15:38 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:15:38 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:15:38 INFO - ^ 11:15:38 INFO - 1 warning generated. 11:15:38 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 11:15:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:15:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:15:38 INFO - Successfully installed psutil 11:15:38 INFO - Cleaning up... 11:15:38 INFO - Return code: 0 11:15:38 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:15: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')]} 11:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15: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')]} 11:15:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107e9ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ea64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec33dbda80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d42d30>, '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 0x107b66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d39b20>, '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.6SUHLDpPDA/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.DOoRtC8pZN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 11:15:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 11:15:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 11:15:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6SUHLDpPDA/Render', 11:15:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:15:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:15:38 INFO - 'HOME': '/Users/cltbld', 11:15:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:15:38 INFO - 'LOGNAME': 'cltbld', 11:15:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:38 INFO - 'MOZ_NO_REMOTE': '1', 11:15:38 INFO - 'NO_EM_RESTART': '1', 11:15:38 INFO - 'PAGER': '/bin/cat', 11:15:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:15:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:38 INFO - 'PWD': '/builds/slave/test', 11:15:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:15:38 INFO - 'SHELL': '/bin/bash', 11:15:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DOoRtC8pZN/Listeners', 11:15:38 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 11:15:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:15:38 INFO - 'USER': 'cltbld', 11:15:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:15:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:15:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:38 INFO - 'XPC_FLAGS': '0x0', 11:15:38 INFO - 'XPC_SERVICE_NAME': '0', 11:15:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:15:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:39 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:41 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:15:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:15:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:15:41 INFO - Installing collected packages: mozsystemmonitor 11:15:41 INFO - Running setup.py install for mozsystemmonitor 11:15:41 INFO - Successfully installed mozsystemmonitor 11:15:41 INFO - Cleaning up... 11:15:41 INFO - Return code: 0 11:15:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:15:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107e9ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ea64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec33dbda80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d42d30>, '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 0x107b66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d39b20>, '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.6SUHLDpPDA/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.DOoRtC8pZN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 11:15:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:15:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:15:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6SUHLDpPDA/Render', 11:15:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:15:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:15:41 INFO - 'HOME': '/Users/cltbld', 11:15:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:15:41 INFO - 'LOGNAME': 'cltbld', 11:15:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:41 INFO - 'MOZ_NO_REMOTE': '1', 11:15:41 INFO - 'NO_EM_RESTART': '1', 11:15:41 INFO - 'PAGER': '/bin/cat', 11:15:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:15:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:41 INFO - 'PWD': '/builds/slave/test', 11:15:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:15:41 INFO - 'SHELL': '/bin/bash', 11:15:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DOoRtC8pZN/Listeners', 11:15:41 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 11:15:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:15:41 INFO - 'USER': 'cltbld', 11:15:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:15:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:15:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:41 INFO - 'XPC_FLAGS': '0x0', 11:15:41 INFO - 'XPC_SERVICE_NAME': '0', 11:15:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:15:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:42 INFO - Downloading/unpacking blobuploader==1.2.4 11:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:44 INFO - Downloading blobuploader-1.2.4.tar.gz 11:15:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:15:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:15:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:15:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:45 INFO - Downloading docopt-0.6.1.tar.gz 11:15:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:15:45 INFO - Installing collected packages: blobuploader, requests, docopt 11:15:45 INFO - Running setup.py install for blobuploader 11:15:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:15:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:15:45 INFO - Running setup.py install for requests 11:15:46 INFO - Running setup.py install for docopt 11:15:46 INFO - Successfully installed blobuploader requests docopt 11:15:46 INFO - Cleaning up... 11:15:46 INFO - Return code: 0 11:15:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107e9ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ea64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec33dbda80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d42d30>, '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 0x107b66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d39b20>, '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.6SUHLDpPDA/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.DOoRtC8pZN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 11:15:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:15:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:15:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6SUHLDpPDA/Render', 11:15:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:15:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:15:46 INFO - 'HOME': '/Users/cltbld', 11:15:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:15:46 INFO - 'LOGNAME': 'cltbld', 11:15:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:46 INFO - 'MOZ_NO_REMOTE': '1', 11:15:46 INFO - 'NO_EM_RESTART': '1', 11:15:46 INFO - 'PAGER': '/bin/cat', 11:15:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:15:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:46 INFO - 'PWD': '/builds/slave/test', 11:15:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:15:46 INFO - 'SHELL': '/bin/bash', 11:15:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DOoRtC8pZN/Listeners', 11:15:46 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 11:15:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:15:46 INFO - 'USER': 'cltbld', 11:15:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:15:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:15:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:46 INFO - 'XPC_FLAGS': '0x0', 11:15:46 INFO - 'XPC_SERVICE_NAME': '0', 11:15:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:15:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:15:46 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-SXCCCA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:15:46 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-xhxCEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:15:46 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-d4bvSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:15:47 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-mr1Aqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:15:47 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-WdT4fd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:15:47 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-X5Mm0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:15:47 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-MFokII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:15:47 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-CFlFcB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:15:47 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-gOumMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:15:47 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-JB_vTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:15:47 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-rXG0nQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:15:47 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-TmR7uF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:15:48 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-_RN620-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:15:48 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-uo6nF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:15:48 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-jmZ1GH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:15:48 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-9p1VTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:15:48 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-mfIHWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:15:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:15:48 INFO - Running setup.py install for manifestparser 11:15:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:15:48 INFO - Running setup.py install for mozcrash 11:15:48 INFO - Running setup.py install for mozdebug 11:15:49 INFO - Running setup.py install for mozdevice 11:15:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:15:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:15:49 INFO - Running setup.py install for mozfile 11:15:49 INFO - Running setup.py install for mozhttpd 11:15:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:15:49 INFO - Running setup.py install for mozinfo 11:15:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:15:49 INFO - Running setup.py install for mozInstall 11:15:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:15:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:15:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:15:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:15:49 INFO - Running setup.py install for mozleak 11:15:49 INFO - Running setup.py install for mozlog 11:15:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:15:50 INFO - Running setup.py install for moznetwork 11:15:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:15:50 INFO - Running setup.py install for mozprocess 11:15:50 INFO - Running setup.py install for mozprofile 11:15:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:15:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:15:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:15:50 INFO - Running setup.py install for mozrunner 11:15:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:15:50 INFO - Running setup.py install for mozscreenshot 11:15:50 INFO - Running setup.py install for moztest 11:15:50 INFO - Running setup.py install for mozversion 11:15:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:15:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:15:51 INFO - Cleaning up... 11:15:51 INFO - Return code: 0 11:15:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:15:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:51 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 0x107e9ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ea64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec33dbda80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d42d30>, '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 0x107b66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d39b20>, '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.6SUHLDpPDA/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.DOoRtC8pZN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 11:15:51 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 11:15:51 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 11:15:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6SUHLDpPDA/Render', 11:15:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:15:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:15:51 INFO - 'HOME': '/Users/cltbld', 11:15:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:15:51 INFO - 'LOGNAME': 'cltbld', 11:15:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:51 INFO - 'MOZ_NO_REMOTE': '1', 11:15:51 INFO - 'NO_EM_RESTART': '1', 11:15:51 INFO - 'PAGER': '/bin/cat', 11:15:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:15:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:51 INFO - 'PWD': '/builds/slave/test', 11:15:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:15:51 INFO - 'SHELL': '/bin/bash', 11:15:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DOoRtC8pZN/Listeners', 11:15:51 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 11:15:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:15:51 INFO - 'USER': 'cltbld', 11:15:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:15:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:15:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:51 INFO - 'XPC_FLAGS': '0x0', 11:15:51 INFO - 'XPC_SERVICE_NAME': '0', 11:15:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:15:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:15:51 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-61KsA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:15:51 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:15:51 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-UuFMsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:15:51 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)) 11:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:15:51 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-GX4PCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:15:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:15:51 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-1Hxk3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:15:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:15:51 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-4ib8uj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:15:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:15:51 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-kKnUEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:15:52 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)) 11:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:15:52 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-z5nqS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:15:52 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)) 11:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:15:52 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-Oi8yI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:15:52 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-GUFSN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:15:52 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-iyW3C5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:15:52 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-l_4rr_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:15:52 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-dptVPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:15:52 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-EF9Qwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:15:52 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-shMDEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:15:52 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-qtuWCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:15:53 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-exO1ZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:15:53 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)) 11:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:15:53 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-lr8qNq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:15:53 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)) 11:15:53 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)) 11:15:53 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)) 11:15:53 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)) 11:15:53 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)) 11:15:53 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)) 11:15:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:55 INFO - Downloading blessings-1.6.tar.gz 11:15:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:15:55 INFO - Installing collected packages: blessings 11:15:55 INFO - Running setup.py install for blessings 11:15:55 INFO - Successfully installed blessings 11:15:55 INFO - Cleaning up... 11:15:55 INFO - Return code: 0 11:15:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:15:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:15:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:15:56 INFO - Reading from file tmpfile_stdout 11:15:56 INFO - Current package versions: 11:15:56 INFO - blessings == 1.6 11:15:56 INFO - blobuploader == 1.2.4 11:15:56 INFO - docopt == 0.6.1 11:15:56 INFO - manifestparser == 1.1 11:15:56 INFO - mozInstall == 1.12 11:15:56 INFO - mozcrash == 0.17 11:15:56 INFO - mozdebug == 0.1 11:15:56 INFO - mozdevice == 0.48 11:15:56 INFO - mozfile == 1.2 11:15:56 INFO - mozhttpd == 0.7 11:15:56 INFO - mozinfo == 0.9 11:15:56 INFO - mozleak == 0.1 11:15:56 INFO - mozlog == 3.1 11:15:56 INFO - moznetwork == 0.27 11:15:56 INFO - mozprocess == 0.22 11:15:56 INFO - mozprofile == 0.28 11:15:56 INFO - mozrunner == 6.11 11:15:56 INFO - mozscreenshot == 0.1 11:15:56 INFO - mozsystemmonitor == 0.0 11:15:56 INFO - moztest == 0.7 11:15:56 INFO - mozversion == 1.4 11:15:56 INFO - psutil == 3.1.1 11:15:56 INFO - requests == 1.2.3 11:15:56 INFO - wsgiref == 0.1.2 11:15:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:15:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:56 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 0x107e9ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ea64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec33dbda80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d42d30>, '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 0x107b66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d39b20>, '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.6SUHLDpPDA/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.DOoRtC8pZN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 11:15:56 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 11:15:56 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 11:15:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6SUHLDpPDA/Render', 11:15:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:15:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:15:56 INFO - 'HOME': '/Users/cltbld', 11:15:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:15:56 INFO - 'LOGNAME': 'cltbld', 11:15:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:56 INFO - 'MOZ_NO_REMOTE': '1', 11:15:56 INFO - 'NO_EM_RESTART': '1', 11:15:56 INFO - 'PAGER': '/bin/cat', 11:15:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:15:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:56 INFO - 'PWD': '/builds/slave/test', 11:15:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:15:56 INFO - 'SHELL': '/bin/bash', 11:15:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DOoRtC8pZN/Listeners', 11:15:56 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 11:15:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:15:56 INFO - 'USER': 'cltbld', 11:15:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:15:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:15:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:56 INFO - 'XPC_FLAGS': '0x0', 11:15:56 INFO - 'XPC_SERVICE_NAME': '0', 11:15:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:15:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:15:56 INFO - Cleaning up... 11:15:56 INFO - Return code: 0 11:15:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:15:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107e9ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ea64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec33dbda80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d42d30>, '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 0x107b66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d39b20>, '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.6SUHLDpPDA/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.DOoRtC8pZN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 11:15:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:15:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:15:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6SUHLDpPDA/Render', 11:15:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:15:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:15:56 INFO - 'HOME': '/Users/cltbld', 11:15:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:15:56 INFO - 'LOGNAME': 'cltbld', 11:15:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:56 INFO - 'MOZ_NO_REMOTE': '1', 11:15:56 INFO - 'NO_EM_RESTART': '1', 11:15:56 INFO - 'PAGER': '/bin/cat', 11:15:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:15:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:56 INFO - 'PWD': '/builds/slave/test', 11:15:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:15:56 INFO - 'SHELL': '/bin/bash', 11:15:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DOoRtC8pZN/Listeners', 11:15:56 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 11:15:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:15:56 INFO - 'USER': 'cltbld', 11:15:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:15:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:15:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:56 INFO - 'XPC_FLAGS': '0x0', 11:15:56 INFO - 'XPC_SERVICE_NAME': '0', 11:15:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:15:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:56 INFO - Downloading/unpacking jsonschema 11:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:15:59 INFO - Downloading/unpacking functools32 (from jsonschema) 11:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:59 INFO - Downloading functools32-3.2.3-2.tar.gz 11:15:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:15:59 INFO - warning: no files found matching '*.txt' 11:15:59 INFO - no previously-included directories found matching 'build' 11:15:59 INFO - no previously-included directories found matching 'dist' 11:15:59 INFO - no previously-included directories found matching '.git*' 11:15:59 INFO - Installing collected packages: jsonschema, functools32 11:15:59 INFO - Running setup.py install for functools32 11:15:59 INFO - warning: no files found matching '*.txt' 11:15:59 INFO - no previously-included directories found matching 'build' 11:15:59 INFO - no previously-included directories found matching 'dist' 11:15:59 INFO - no previously-included directories found matching '.git*' 11:15:59 INFO - Successfully installed jsonschema functools32 11:15:59 INFO - Cleaning up... 11:15:59 INFO - Return code: 0 11:15:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107e9ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ea64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec33dbda80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d42d30>, '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 0x107b66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d39b20>, '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.6SUHLDpPDA/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.DOoRtC8pZN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 11:15:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 11:15:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:15:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6SUHLDpPDA/Render', 11:15:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:15:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:15:59 INFO - 'HOME': '/Users/cltbld', 11:15:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:15:59 INFO - 'LOGNAME': 'cltbld', 11:15:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:59 INFO - 'MOZ_NO_REMOTE': '1', 11:15:59 INFO - 'NO_EM_RESTART': '1', 11:15:59 INFO - 'PAGER': '/bin/cat', 11:15:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:15:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:59 INFO - 'PWD': '/builds/slave/test', 11:15:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:15:59 INFO - 'SHELL': '/bin/bash', 11:15:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DOoRtC8pZN/Listeners', 11:15:59 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 11:15:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:15:59 INFO - 'USER': 'cltbld', 11:15:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:15:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:15:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:59 INFO - 'XPC_FLAGS': '0x0', 11:15:59 INFO - 'XPC_SERVICE_NAME': '0', 11:15:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:16:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:00 INFO - Downloading/unpacking flake8 11:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:16:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:16:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:16:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:16:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:16:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:16:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:16:03 INFO - no previously-included directories found matching 'docs/_build' 11:16:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:16:03 INFO - Running setup.py install for pep8 11:16:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:16:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:16:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:16:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:16:04 INFO - no previously-included directories found matching 'docs/_build' 11:16:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:16:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:16:04 INFO - Cleaning up... 11:16:04 INFO - Return code: 0 11:16:04 INFO - Running post-action listener: _resource_record_post_action 11:16:04 INFO - Running post-action listener: _start_resource_monitoring 11:16:04 INFO - Starting resource monitoring. 11:16:04 INFO - ##### 11:16:04 INFO - ##### Running install step. 11:16:04 INFO - ##### 11:16:04 INFO - Running pre-action listener: _resource_record_pre_action 11:16:04 INFO - Running main action method: install 11:16:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:16:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:16:04 INFO - Reading from file tmpfile_stdout 11:16:04 INFO - Detecting whether we're running mozinstall >=1.0... 11:16:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:16:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:16:04 INFO - Reading from file tmpfile_stdout 11:16:04 INFO - Output received: 11:16:04 INFO - Usage: mozinstall [options] installer 11:16:04 INFO - Options: 11:16:04 INFO - -h, --help show this help message and exit 11:16:04 INFO - -d DEST, --destination=DEST 11:16:04 INFO - Directory to install application into. [default: 11:16:04 INFO - "/builds/slave/test"] 11:16:04 INFO - --app=APP Application being installed. [default: firefox] 11:16:04 INFO - mkdir: /builds/slave/test/build/application 11:16:04 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'] 11:16:04 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 11:16:37 INFO - Reading from file tmpfile_stdout 11:16:37 INFO - Output received: 11:16:37 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:16:37 INFO - Running post-action listener: _resource_record_post_action 11:16:37 INFO - ##### 11:16:37 INFO - ##### Running run-tests step. 11:16:37 INFO - ##### 11:16:37 INFO - Running pre-action listener: _resource_record_pre_action 11:16:37 INFO - Running main action method: run_tests 11:16:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:16:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:16:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:16:37 INFO - 2016-03-16 11:16:37.968 screenresolution[1643:7459] starting screenresolution argv=screenresolution get 11:16:37 INFO - 2016-03-16 11:16:37.971 screenresolution[1643:7459] Display 0: 1600x1200x32@60 11:16:37 INFO - 2016-03-16 11:16:37.977 screenresolution[1644:7461] starting screenresolution argv=screenresolution list 11:16:37 INFO - Available Modes on Display 0 11:16:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:16:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:16:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:16:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:16:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:16:38 INFO - Intel Iris: 11:16:38 INFO - Chipset Model: Intel Iris 11:16:38 INFO - Type: GPU 11:16:38 INFO - Bus: Built-In 11:16:38 INFO - VRAM (Dynamic, Max): 1536 MB 11:16:38 INFO - Vendor: Intel (0x8086) 11:16:38 INFO - Device ID: 0x0a2e 11:16:38 INFO - Revision ID: 0x0009 11:16:38 INFO - Displays: 11:16:38 INFO - Display: 11:16:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:16:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:16:38 INFO - Display Serial Number: 1600x1200 60 11:16:38 INFO - Main Display: Yes 11:16:38 INFO - Mirror: Off 11:16:38 INFO - Online: Yes 11:16:38 INFO - Rotation: Supported 11:16:38 INFO - Return code: 0 11:16:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:16:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:16:38 INFO - Python 2.7.3 11:16:38 INFO - Return code: 0 11:16:38 INFO - grabbing minidump binary from tooltool 11:16: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')]} 11:16:38 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d42d30>, '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 0x107b66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d39b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:16:38 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:16:38 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 11:16:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:16:38 INFO - Return code: 0 11:16:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:16:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:16:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:16:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:16:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:16:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:16:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:16:39 INFO - Return code: 0 11:16:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MQDhjE4DSC-qMfhU4Y6f9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0023', '--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 11:16:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MQDhjE4DSC-qMfhU4Y6f9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0023 --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 11:16:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6SUHLDpPDA/Render', 11:16:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:16:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:16:39 INFO - 'HOME': '/Users/cltbld', 11:16:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:16:39 INFO - 'LOGNAME': 'cltbld', 11:16:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:16:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:16:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:39 INFO - 'MOZ_NO_REMOTE': '1', 11:16:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:16:39 INFO - 'NO_EM_RESTART': '1', 11:16:39 INFO - 'PAGER': '/bin/cat', 11:16:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:16:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:39 INFO - 'PWD': '/builds/slave/test', 11:16:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:16:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:16:39 INFO - 'SHELL': '/bin/bash', 11:16:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DOoRtC8pZN/Listeners', 11:16:39 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 11:16:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:16:39 INFO - 'USER': 'cltbld', 11:16:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:16:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:16:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:39 INFO - 'XPC_FLAGS': '0x0', 11:16:39 INFO - 'XPC_SERVICE_NAME': '0', 11:16:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:16:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MQDhjE4DSC-qMfhU4Y6f9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0023', '--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 11:16:39 INFO - mozversion application_buildid: 20160316090541 11:16:39 INFO - mozversion application_changeset: 06ae85d888e8b112a60cf34fe2f1a305ea92d8c0 11:16:39 INFO - mozversion application_display_name: Nightly 11:16:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:16:39 INFO - mozversion application_name: Firefox 11:16:39 INFO - mozversion application_remotingname: firefox 11:16:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:16:39 INFO - mozversion application_vendor: Mozilla 11:16:39 INFO - mozversion application_version: 48.0a1 11:16:39 INFO - mozversion platform_buildid: 20160316090541 11:16:39 INFO - mozversion platform_changeset: 06ae85d888e8b112a60cf34fe2f1a305ea92d8c0 11:16:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:16:39 INFO - mozversion platform_version: 48.0a1 11:16:39 INFO - using testdate: 1458152199 11:16:39 INFO - actual date: 1458152199 11:16:39 INFO - starting webserver on 'localhost:49277' 11:16:39 INFO - SUITE-START | Running 2 tests 11:16:39 INFO - TEST-START | dromaeo_css 11:16:39 INFO - operating with platform_type : mac_ 11:16:39 INFO - Initialising browser for dromaeo_css test... 11:16:39 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmpCLCvZO/profile http://localhost:49277/getInfo.html) 11:16:42 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 11:16:42 INFO - PROCESS | 1662 | colorDepth:24 11:16:42 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 11:16:42 INFO - PROCESS | 1662 | __metrics 11:16:42 INFO - PROCESS | 1662 | 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" 11:16:42 ERROR - PROCESS | 1662 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:16:42 INFO - TEST-INFO | 1662: exit 0 11:16:42 INFO - Browser initialized. 11:16:42 INFO - Running cycle 1/1 for dromaeo_css test... 11:16:42 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmpCLCvZO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:16:54 INFO - PROCESS | 1665 | RSS: Main: 243486720 11:16:54 INFO - PROCESS | 1665 | 11:17:45 INFO - PROCESS | 1665 | 1458152265990 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] 11:19:55 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49277/tests/dromaeo/cssquery-ext.html) 11:19:57 INFO - PROCESS | 1665 | RSS: Main: 380248064 11:19:57 INFO - PROCESS | 1665 | 11:23:00 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-ext.html (next: http://localhost:49277/tests/dromaeo/cssquery-jquery.html) 11:23:00 INFO - PROCESS | 1665 | RSS: Main: 373243904 11:23:00 INFO - PROCESS | 1665 | 11:26:02 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49277/tests/dromaeo/cssquery-mootools.html) 11:26:03 INFO - PROCESS | 1665 | RSS: Main: 374427648 11:26:03 INFO - PROCESS | 1665 | 11:29:05 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49277/tests/dromaeo/cssquery-prototype.html) 11:29:05 INFO - PROCESS | 1665 | RSS: Main: 336683008 11:29:05 INFO - PROCESS | 1665 | 11:32:08 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49277/tests/dromaeo/cssquery-yui.html) 11:32:09 INFO - PROCESS | 1665 | RSS: Main: 333230080 11:32:09 INFO - PROCESS | 1665 | 11:35:12 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-yui.html (next: http://localhost:49277/tests/dromaeo/cssquery-dojo.html) 11:35:12 INFO - PROCESS | 1665 | RSS: Main: 438784000 11:35:12 INFO - PROCESS | 1665 | 11:35:12 INFO - PROCESS | 1665 | __start_tp_report 11:35:12 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 11:35:12 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 11:35:12 INFO - PROCESS | 1665 | |i|pagename|runs| 11:35:12 INFO - PROCESS | 1665 | |0;dojo.html;2990.566367876659;3170.397624451354;3476.860925562976;3521.7886926784404;3561.9287614247714;4379.62773164281;5396.676199428032;5530.391656917735;5634.4365563443735;5693.174489698986;5621.241132447119;5622.353429355625;5665.575081868856;5671.092625179972;5675.2054712340305;5121.692698438096;5151.304573882516;5166.43169251382;5236.423993360727;5241.2400201970695;5201.609879259052;5246.606504512177;5250.4487028861995;5250.579953603722;5261.684298942057;5168.7932482700835;5215.817446389377;5222.929299493614;5250.579953603703;5261.053010458116;4849.787553111722;5223.399309079467;5233.476652334774;5285.762140703678;5342.958123165984;5048.318477005594;5117;5132;5186.170212765939;5194.142966410538;5546.27898373213;5554.750036248338;5584.944150558483;5595.412481689405;5656.971715141398;6189.257289125334;6236.03341482071;6237.7816776413065;6244.344343843876;6245.718942647546;6126.111713801519;6136.478399336017;6225.7509699611965;6249.906266403406;6268.279147898004;5784.219130417424;5800;5805.10020946754;5816.069428891357;5817.738201780845;6198.6280823150755;6260.686965651699;6262.812115636538;6266.592671476339;6276.340984196685;5978.940210597838;6055.7274922628585;6104.15601054772;6117.082437634391;6147.508199344042;6186.381361863778;6216.7824126155365;6227.813165605039;6238.625682459067;6256.624602523772;6173.629582224991;6182.474489668339;6188.938110618837;6207.534434917399;6221.3156552779155;4537.886552836139;6076.574639775262;6136.12084543884;6148.9854174061675;6187.752489900444;4888.7311197884455;4890.633202509826;4904.828331008398;4918.483559226302;4945.381827271591;4374.978125109354;4390.8024138913825;4394.1651086293505;4406.052698669801;4438.556144385536;5639.182318563785;5688.687122208235;5707.229524014288;5749.9712501437225;5752.165935939265;6183.536234782409;6233.625982440977;6236.376362363727;6253.249610046823;6268.185135932391;5125.64120511568;5493.7802487900835;5786.42135786418;5799.971000144972;5810.331811841608;5239.73801309933;5309.920351194735;5346;5358.437364076716;5365.436629153883;6170.753169873335;6311.715972781236;6359.300476947532;6363;6375.330590287953;5372.704501252469;6179.3631280485815;6220.315765265726;6227.346128656607;6235.937640623536;6164;6259.374062593886;6288;6348.206474190726;6352.237731472253;6154.323024467216;6158.107074474266;6162.198914141133;6163.938360616516;6176.598521096114;6071;6174.629522228681;6178.135061091541;6199.938000619936;6244.68776561161;5941.930452518588;6057.303410107894;6088.5737998341465;6101.792513241593;6122.459144589048;6095.725692343766;6103.992841181333;6104.145419641165;6109.358517355614;6133.785317514044;4372.672049596229;5482.91775623358;5570.832875013756;5984.611000284967;5996.820095397145;5923.289205295392;5957.285125784933;5997.220361352996;6061.242344706911;6068.7269072892705;5912.881742365214;5928.644281343133;5961.135635332939;5976.491998180029;6033.215681961317 11:35:12 INFO - PROCESS | 1665 | |1;ext.html;474.36908911148174;559.9384067752546;580.3934888041993;621.8775110924781;640.9775657851975;30369.392612147745;39112.41331380028;39420.211595768065;39462.210755784865;39629.80185099078;42065.57934420655;42382.99999999992;42461;42480;42529;8009.679612815509;8194.180581941817;9441.339106262547;9671.081247281498;9684.515774211297;9534.09426104519;9659.758506037335;9662.855057174149;9677;9691.176250018756;9669.419834809934;9871.40771553709;9872.45701486418;9883.061109194616;9886.703398898044;9749.708818427664;9840.458774767385;9844.228038952986;9853.014698530125;9868.013198680146;9641.807163856683;9789.608415663364;9794.265430092772;9804.215662747034;9821;41130.58869411297;41606.583934160575;41678.37482437766;41774;41824.79087604573;3397.69420752131;3421.674940880612;3451.1027132945364;3532.6467353264725;3891.5135608048995;28666.270065439177;28725.425491490052;28758.70585823643;28796.712032879823;29734.107976760733;2633.3285012321926;2634.5916382960672;2739.2877851758485;2750.477409292228;2758.2690586994463;471178.99999999657;477593;477809;478141;481239;45461;45724.99999999934;45914.39299624497;70265.64867175734;70674.64662676654;45101.097978040256;45149.77425112853;45231;45281;45311.86720332018;15953.840461595235;16085.597860053358;16100.275487602852;16110.919445402698;16128.516144515448;12877.420516076612;12934.741305173844;12947.611571652866;12972.870271297355;12991.960643148526;14897.329620167118;14928.954973151775;14940.701185976219;14989.70020599582;15044.774328385083;6450.8064758057335;6540.542162048611;6592.17597800275;6598.505112116514;6608.537402381883;953.1374106433689;1017.8524114003428;1036.290141253244;1085.3650614390513;1093.1254996003324;29564;29736;30048.39903201924;30357;30437.543436848464;976.497103991445;1064.8818740322786;1113.0761467981556;1183.4496958914146;1239.2007155384727;15010.324535395934;15164.165970871487;15217.163056032025;15533.922330388275;15565.29956151976;518889;702960;718516;720835;723175;53738;62080.689596552635;62784;62886;64116.679416602616;1360.4082224232293;1395.1559306619552;1516.438917600473;1538.9307481163376;1652.7686123942658;30543.847280763453;30907.690923090482;31181.064568062993;31488.685113148575;31494.89767858114;53963.730181348845;54205;54567;54577;54654.72672636611;424996;428771;428902;429567;429698;33248.54451413028;33320;33973.320533589686;34044;34087.147821304665;45122.09755804931;45368.31947520856;45540.772296138304;45565.77217113893;47047.7657010857;37229;37240.813795930844;37274.440883386225;37826.62173378341;38589.4211586832;36738;37142.44286335761;37907.81046094752;38125.85622431331;38157.85526434211;36875;37302.06744831401;37303.067423314635;37532.624673752915;38163.42754858735;31643.764132893226;32606.828215833495;33275.16812079717;33348.99953001414;33366;24307.35424983481;24763.32611994101;24842.130525431523;24997.125100622117;25256.23206375536 11:35:12 INFO - PROCESS | 1665 | |2;jquery.html;362.99455508167375;366.40825067515954;369.48456902620836;371.5745471435207;378.89959160822406;19270.807291927078;19604.60790784185;19650.508737281576;19986.900065499653;20018.29935952238;10868.130549556035;11218.831717524243;11248.606298779545;11255.43722813858;11266.887331126707;4587.472440669316;5220.373555173375;5240.423553409122;5362.115250983583;5436.238926550286;5216.9478305217035;5275.551578115865;5300.549453296474;5301.416844147141;5315.123004704219;5294.073537131006;5301.973490132544;5308.150695888658;5424.294841670578;6004.8498787530225;5797.884042319151;5948.791792287292;5978.432048955342;5986.311574168983;5991.910121348205;5124.974375128138;5166.457521960216;5231.9476805232225;5254.4220135785035;5259.053370393328;10846.620368287151;12520.499180032788;12937.547185848543;13026.153300035467;13029.609111726664;1989.204318272688;2000.249906285143;2243.9663405048937;2376.2158487699016;2576.4203054312816;9134.497602631853;9443.952780236124;9504.239660827117;9696.46669433181;9697.806043879153;1465.4138344662115;1713.751506031631;1797.020623760054;1806.3858288182082;1819.972700409495;94359.11281774325;103943.96056039419;104377.43433848498;105282.49290656533;106189;11071.280366776135;11281.21031527785;11309.321440713584;11321.660350189508;11426.029232399469;13683.657908552166;13703.520376786764;13752.65618359549;13766.724665506634;13769.655758605915;7228.385587225145;8273.544955027532;8316;8482.575871206414;8574.657013719381;8634.6977855776;8637.956810215908;8639.438436501607;8752.081031491729;8774.780630484289;4327.17783621111;4355.237833379146;4390.736555806662;4447.199504089295;4502.729836209838;1675.3801093595448;1813.9818601814077;1907.1417861962173;1911.5794525204433;1930.5656227349016;724.1035856573706;857.4640849469082;900.446225571269;945.6217512994857;977.1986970683971;16733.828631995642;17065;19416.805831941783;19585.902070489556;19690.70463943042;902.6621051476576;909.9181073703267;937.3017102258724;950.2065775077888;950.4107453378949;10374.325668831501;10855.294405863593;10898.782024359627;10912.672619821418;10919.727006824893;509954;512951;513230;622061;623806;101679.34046265593;107083.39374909383;114714;117587;123221;1009.914157296638;1011.7774089700254;1038.7818558102883;1060.5068643081004;1061.9522121504551;18061.729074063638;18403.53991150232;18465.53836154107;18607.72088418702;18695.840878818177;51882.740586298336;52876.47123528716;52910.73544632252;53530.732346338016;54061.72969135129;74985;75078;75134.62432687801;77412.6129369372;77766;7263.636818159177;7270.6728197230195;7669.693212271447;7785.610719464117;8058.395620328616;11326.32042077478;12433.44049517792;12630.938670097108;12691.682707932376;12795.872041279841;10764.784704306026;10889.504432408723;10979.956904094099;11036.668899933014;11050;10667.51996160159;10788.946055269673;10849.186311026862;11036.282641628268;11116.44417779124;9641.951790241004;10744.140468762636;10777.08394786452;10991.505382257978;11263.155263355116;7431.29402706742;7432;7500.62496875165;7577.772666820004;7803.063632364153;8491.957540212507;10653.307535010199;10788.730281743019;11096.945790149923;11097.278676885977 11:35:12 INFO - PROCESS | 1665 | |3;mootools.html;1446.8842492600593;1579.65247645518;1603.1583418705181;1920.75030246068;2040.2145174107964;8071.313938315243;8744.475331480107;8907.28741700664;8910.955445222773;8936.329775266848;8589.742307730763;8839.425437346568;8842.690505832297;8847.646094156242;8852.95573522133;2450.9264722058365;2471.4439251168433;2474.257722683197;2474.4927289905527;2476.19523654812;2415.758424157588;2502.9374265643323;2504.949901001988;2507.4107584717576;2514.88683009265;2473.245660073677;2489.5394352044927;2512.836665616738;2517.2196619048063;2526.1411120219122;2462.8645424501733;2478.6901637295337;2492.0779311654715;2504.561701702213;2506.0602274147195;2426.4055306449854;2459;2464.7904928081134;2469.555480013597;2476.987615061913;8958.86561701575;9022.593983270768;9025.729228123168;9031.187193152648;9041.457512549268;5408.864778380533;5550.8057217997175;5614.9719251403485;5617.662940223599;5619.831405057855;3589.910252243689;3680.1719613087107;3738.775673459574;3739.906502337436;3757.6618104370737;891.8216356728616;1042.9205772025994;1050.9632162874339;1051.1789644641706;1062.3519653011656;12408.317542535156;12432.254064756144;12465;12475.563355282613;12476.563320283747;4808.711477311303;4885.462599114095;4937.506249375106;4945.406551213878;4968.925466118011;10441.060304572473;10470.528826202839;10490.527926243338;10493.9475302623;10503.2122590806;5533.3083364579425;5568.331800184003;5570.470805273492;5579.553635709133;5586.217929489874;4394.8242070317465;4568.794404251817;4829.879253018703;4982.90034199314;5055.090083784954;3643.9817800911355;3711.6659500645073;4019.618136277049;4031.9798401007806;4042;1316.697159653285;1320.966975825612;1321.6960099177243;1324.3775425549977;1335.2389138191331;967.2697113679268;996.8106059848606;1039.8856125826153;1151.5681619392728;1399.3772771116755;8208.466449680871;8373.455725377831;8373.706920257762;8392.874106888401;8395.118512556215;1210.6549633354452;1211.0795795195716;1232.0882546915398;1247.5945317771761;1253.0476837603487;6386.457151142205;6452.677366131768;6462.838429039218;6469.353064693587;6506.089147519351;10282.383057016603;10825.188110891557;10946.507407166697;10975.560977560808;10987.340759554452;9684.692566503572;10645.733856653645;10876.836847447295;10907.890921090846;11049.668509944715;6811.352921472452;8500.277476414574;8657.091005444463;8687.435316704394;8713.259372953244;7941.404394670307;8186.508809471213;8258.793530161794;8260.215279548433;8326.6669333226;9589.520523973913;9643.2767542436;9730.75673108178;9751.171150452292;9848.409095454295;9672.22622190209;9936.950315248378;10097.040781125781;10157.949210254197;10168.847467288144;7616.162222155669;7665.156832748505;7695.461317707706;7772.300492955661;7802.219778022152;8316.293115085286;8326.542040187605;8367.58162091905;8382.958085209779;8392.076871544003;6450.516211284079;7360;7566.848663026599;7734.419918506022;7822.139564647998;7397.371223445852;7415.8146046349275;7430.0340955677575;7541.132769731551;7565.319121279112;7898.842023159619;7909;7967.2431119043595;7969.282764551218;7971.202879711982;7095.254998225112;7151;7152.427805775629;7203.819904502429;7218.711251549879;7250.274972502708;7298.708051677873;7301.525400848928;7319.377852882564;7353.522021068614 11:35:12 INFO - PROCESS | 1665 | |4;prototype.html;318.4395463983389;319.56858241374147;327.09884268839346;327.15267457285626;332.080138017691;5387.973060134699;6678.465722742181;6680.732770689178;6683.966580167098;6725.361090696382;6535.8366040849005;6609.900851487219;6616.4782100117;6622.668866556677;6638.867222655544;3647.689946354563;4652.604528615055;4765.90468190636;4772.952270477285;4944.332515110459;4015.176888737816;4886.096072226632;4925.48282430345;4930.53159949806;4939.975300123512;3968.30554652936;4859.003904199648;4863.805447782084;4873;4873.976464942366;4630.166570017395;4749.382580264578;4841.830535931225;4875.171220892421;4883;4162.2299874523005;4170.854020109282;4174.812133454002;4175.352820312856;4186.162767446523;6278.560500764948;6308.621482711006;6323.620582765049;6359.682015899187;6382.393672601095;4943.258511223309;5490.149026900836;5745.683987380692;5764.798232061899;5786.594938354317;6995.160580730345;7004.649767511604;7005.299470053005;7007.369336759665;7016.5790052597;4472.664550158718;4626.421697287839;4654.836290927268;4669.32294817253;4697.13103075932;7310.561366317985;7460.25397460255;7466.775996720053;7487.213842546563;7501.0248667673395;4771.212749896228;4771.427428708508;4774.069056534012;4781.832635857728;4783.091212669582;4805.399325084364;4836.830710925101;4837.612990960714;4853.805847766121;4858.271259311132;5749;5753.453421924911;5772.797952071657;5777.248957635565;5788.710564471759;6219.222597175353;6603.834904127435;6805.863882722318;7039.366457018893;7079.575225486487;1487.0482890949802;1527.7326467868302;1651.2651869917772;1659.2533359988054;1675.5308513616208;1073.758404359013;1090.2695194219891;1099.8130317845985;1101.1191047162238;1106.590561492253;6432.9678351607945;6625.972974189009;6655.168103987002;6755.189377274758;6775.966120169368;7382.630868456556;7388.113426388761;7394.667239974214;7417.369523590447;7430.442716796262;6714.3957043866285;6722.596644201363;6738.460923126237;6745.898811517831;6751.291114433012;3849.672777813917;3906.980465097656;3907.081835768592;3908.1402091539817;3918.6081391860585;7333.853322933512;7731.7680469586;7752.302292793675;7752.379809615217;7768.53388796674;6883.8967415488805;7571.962140189264;7613.809654758565;7619.390448764086;7621.771346859603;7191.173015103121;7698.653560589787;7704.036995375578;7714.382849372037;7718.652660630285;7065.717371305091;7362.595057271901;7372.668229929559;7377.225391333833;7383.593902335423;7247.710091596277;7284.49008569395;7292.34368906801;7294.744683936036;7300.196978332486;7736.303732664087;7736.690532378641;7743.845123097394;7747.1090824555895;7766.611669416619;4107.199096176217;4305.655547556125;4534.954650453453;4568.88577785558;4574.862754117382;6981.654482799849;7304.151380961323;7315.195328513752;7317.5609463432365;7328.193898671036;7036.437085033082;7063.858722825412;7074.186468556182;7094.503384763017;7094.751683691046;7023.543469674455;7065.717371305091;7071.893921591078;7077.787666370017;7094.858102838018;6900.723971041102;6902.585844849124;6906.585604863724;6908.481863860331;6911.447084233148;6778.254392016973;7051.858962820817;7058;7075.540089894141;7076.0801095857205;6719.126513553207;6734.158230221223;6901;6929.930700692928;6942.305769423017 11:35:12 INFO - PROCESS | 1665 | |5;yui.html;766.7469734987454;770.9730159444417;780.4497829030535;782.464012151676;786.1352512236539;15021.774673379909;15145.318460669268;15315.770263446057;15320.157391343471;15370.923145384271;13921.23433211173;13925.442982280696;13998.440062397518;14005.929970350135;14100.717985640282;754.943379246556;758.5562445969115;910.1217325281102;925.2875286029753;945.054945054945;929.9116583924516;936.5223735894708;939.3847030195199;942.7690215897114;944;999.5651891427216;1002.8194924913513;1003.2174903575186;1005.0452070533023;1005.1004351105756;789.2896393246095;970.2092794372634;995.7759504111553;996.0288718499478;1001.8697569316015;742.1205871042831;745.5526683989617;745.9850802983964;747.4655621230792;747.9700811967515;13509.662258443519;14720.779188312184;14793;14803.851961480355;14813.0002449669;11611.477483513178;12495.000399967981;12856.935715321364;12869.22784632925;13062.412191451407;9253.537323133884;10004.499775011293;10018.749531261705;10090.990900909923;10343.89656103437;2983.6419629644583;3469.61834198238;3498.807565583892;3537.6992955598803;3589.766665166756;81694;81772.59113704452;81917;82030;85140.57429712874;9389.201917836925;9459.76350591227;9488.383255088396;9680.612775489042;10321.432321222404;21500.032498537603;21909.452263693216;21937.451563711034;21945.451363715714;21990.89004554999;7161.39128174111;7249.8550028999125;7251.4923955323675;7296.854062918712;7321.231270716605;3929.7445666031617;3986.60133986599;3992;3997.2605068062503;4015.8393664253103;3598.9280214395567;3648.7263455240964;3651.94522082169;3654.524911761507;3654.543182102237;676.7513936786621;680.4284401103097;687.7145984416511;688.7004153193377;708.7802781137864;516.6744950681122;548.6077454619966;586.8956284180025;592.914027466015;600.579594284003;7958.442908996431;8099.797505062421;8188.590570471452;8273.296769774637;8284.08875023747;577.238045779567;583.775246530089;603.9486643635253;612.4426771637789;638.1002786071617;3824.158685089276;3825.6174382562076;3860.4981352424006;3889.572147063821;4054.8378064877074;92875;96203;96350.51824740971;97154;98343;82254.58872705598;82494.35011299861;82561;83826.16173838306;84792;66663.66672666617;66822.32944176337;67148.6642566784;67964.98052529315;74883.25116748763;8363.749087527383;8532.658693652184;8578.828423431622;8647.697330593399;8682.52246126469;48346.758266208446;50303;51241.23138152856;51950.220746689585;51968;65667;72654;72798;73361;73418;10749;10972.780544389227;11276.605318813803;11298.983091521803;11318.151138664798;11816.881831181578;11834.644960651194;11868.940655296668;11908.642740717793;12750.42623081945;11380.658580242605;11381.317120972768;11785.646430607096;12292;12350.505979760708;11487.712807179887;11538.250013749079;11552.6534203974;11770.411479426166;11830.585929492427;11196.328220306808;11289.491972861406;11477.540898364306;11569.768604628029;12264.443311439583;9610.423374597547;9648.131668149901;9831.5084245786;10051.447170405698;10225.028622281168;8411.579421028802;8512.319014478951;8986;9292.6282948684;9696.321257511907 11:35:12 INFO - PROCESS | 1665 | __end_tp_report 11:35:12 INFO - PROCESS | 1665 | __start_cc_report 11:35:12 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,1362 11:35:12 INFO - PROCESS | 1665 | __end_cc_report 11:35:12 INFO - PROCESS | 1665 | __startTimestamp1458153312516__endTimestamp 11:35:12 INFO - PROCESS | 1665 | 11:35:12 INFO - PROCESS | 1665 | ------- Summary: start ------- 11:35:12 INFO - PROCESS | 1665 | Number of tests: 6 11:35:12 INFO - PROCESS | 1665 | 11:35:12 INFO - PROCESS | 1665 | [#0] dojo.html Cycles:165 Average:5680.89 Median:5928.64 stddev:661.39 (11.2%) stddev-sans-first:628.84 11:35:12 INFO - PROCESS | 1665 | Values: 2990.6 3170.4 3476.9 3521.8 3561.9 4379.6 5396.7 5530.4 5634.4 5693.2 5621.2 5622.4 5665.6 5671.1 5675.2 5121.7 5151.3 5166.4 5236.4 5241.2 5201.6 5246.6 5250.4 5250.6 5261.7 5168.8 5215.8 5222.9 5250.6 5261.1 4849.8 5223.4 5233.5 5285.8 5343.0 5048.3 5117.0 5132.0 5186.2 5194.1 5546.3 5554.8 5584.9 5595.4 5657.0 6189.3 6236.0 6237.8 6244.3 6245.7 6126.1 6136.5 6225.8 6249.9 6268.3 5784.2 5800.0 5805.1 5816.1 5817.7 6198.6 6260.7 6262.8 6266.6 6276.3 5978.9 6055.7 6104.2 6117.1 6147.5 6186.4 6216.8 6227.8 6238.6 6256.6 6173.6 6182.5 6188.9 6207.5 6221.3 4537.9 6076.6 6136.1 6149.0 6187.8 4888.7 4890.6 4904.8 4918.5 4945.4 4375.0 4390.8 4394.2 4406.1 4438.6 5639.2 5688.7 5707.2 5750.0 5752.2 6183.5 6233.6 6236.4 6253.2 6268.2 5125.6 5493.8 5786.4 5800.0 5810.3 5239.7 5309.9 5346.0 5358.4 5365.4 6170.8 6311.7 6359.3 6363.0 6375.3 5372.7 6179.4 6220.3 6227.3 6235.9 6164.0 6259.4 6288.0 6348.2 6352.2 6154.3 6158.1 6162.2 6163.9 6176.6 6071.0 6174.6 6178.1 6199.9 6244.7 5941.9 6057.3 6088.6 6101.8 6122.5 6095.7 6104.0 6104.1 6109.4 6133.8 4372.7 5482.9 5570.8 5984.6 5996.8 5923.3 5957.3 5997.2 6061.2 6068.7 5912.9 5928.6 5961.1 5976.5 6033.2 11:35:12 INFO - PROCESS | 1665 | 11:35:12 INFO - PROCESS | 1665 | [#1] ext.html Cycles:180 Average:66240.97 Median:39441.21 stddev:144542.91 (366.5%) stddev-sans-first:144864.05 11:35:12 INFO - PROCESS | 1665 | Values: 474.4 559.9 580.4 621.9 641.0 30369.4 39112.4 39420.2 39462.2 39629.8 42065.6 42383.0 42461.0 42480.0 42529.0 8009.7 8194.2 9441.3 9671.1 9684.5 9534.1 9659.8 9662.9 9677.0 9691.2 9669.4 9871.4 9872.5 9883.1 9886.7 9749.7 9840.5 9844.2 9853.0 9868.0 9641.8 9789.6 9794.3 9804.2 9821.0 41130.6 41606.6 41678.4 41774.0 41824.8 3397.7 3421.7 3451.1 3532.6 3891.5 28666.3 28725.4 28758.7 28796.7 29734.1 2633.3 2634.6 2739.3 2750.5 2758.3 471179.0 477593.0 477809.0 478141.0 481239.0 45461.0 45725.0 45914.4 70265.6 70674.6 45101.1 45149.8 45231.0 45281.0 45311.9 15953.8 16085.6 16100.3 16110.9 16128.5 12877.4 12934.7 12947.6 12972.9 12992.0 14897.3 14929.0 14940.7 14989.7 15044.8 6450.8 6540.5 6592.2 6598.5 6608.5 953.1 1017.9 1036.3 1085.4 1093.1 29564.0 29736.0 30048.4 30357.0 30437.5 976.5 1064.9 1113.1 1183.4 1239.2 15010.3 15164.2 15217.2 15533.9 15565.3 518889.0 702960.0 718516.0 720835.0 723175.0 53738.0 62080.7 62784.0 62886.0 64116.7 1360.4 1395.2 1516.4 1538.9 1652.8 30543.8 30907.7 31181.1 31488.7 31494.9 53963.7 54205.0 54567.0 54577.0 54654.7 424996.0 428771.0 428902.0 429567.0 429698.0 33248.5 33320.0 33973.3 34044.0 34087.1 45122.1 45368.3 45540.8 45565.8 47047.8 37229.0 37240.8 37274.4 37826.6 38589.4 36738.0 37142.4 37907.8 38125.9 38157.9 36875.0 37302.1 37303.1 37532.6 38163.4 31643.8 32606.8 33275.2 33349.0 33366.0 24307.4 24763.3 24842.1 24997.1 25256.2 11:35:12 INFO - PROCESS | 1665 | 11:35:12 INFO - PROCESS | 1665 | [#2] jquery.html Cycles:180 Average:32073.64 Median:2476.32 stddev:93118.35 (3760.4%) stddev-sans-first:93349.13 11:35:12 INFO - PROCESS | 1665 | Values: 363.0 366.4 369.5 371.6 378.9 19270.8 19604.6 19650.5 19986.9 20018.3 10868.1 11218.8 11248.6 11255.4 11266.9 4587.5 5220.4 5240.4 5362.1 5436.2 5216.9 5275.6 5300.5 5301.4 5315.1 5294.1 5302.0 5308.2 5424.3 6004.8 5797.9 5948.8 5978.4 5986.3 5991.9 5125.0 5166.5 5231.9 5254.4 5259.1 10846.6 12520.5 12937.5 13026.2 13029.6 1989.2 2000.2 2244.0 2376.2 2576.4 9134.5 9444.0 9504.2 9696.5 9697.8 1465.4 1713.8 1797.0 1806.4 1820.0 94359.1 103944.0 104377.4 105282.5 106189.0 11071.3 11281.2 11309.3 11321.7 11426.0 13683.7 13703.5 13752.7 13766.7 13769.7 7228.4 8273.5 8316.0 8482.6 8574.7 8634.7 8638.0 8639.4 8752.1 8774.8 4327.2 4355.2 4390.7 4447.2 4502.7 1675.4 1814.0 1907.1 1911.6 1930.6 724.1 857.5 900.4 945.6 977.2 16733.8 17065.0 19416.8 19585.9 19690.7 902.7 909.9 937.3 950.2 950.4 10374.3 10855.3 10898.8 10912.7 10919.7 509954.0 512951.0 513230.0 622061.0 623806.0 101679.3 107083.4 114714.0 117587.0 123221.0 1009.9 1011.8 1038.8 1060.5 1062.0 18061.7 18403.5 18465.5 18607.7 18695.8 51882.7 52876.5 52910.7 53530.7 54061.7 74985.0 75078.0 75134.6 77412.6 77766.0 7263.6 7270.7 7669.7 7785.6 8058.4 11326.3 12433.4 12630.9 12691.7 12795.9 10764.8 10889.5 10980.0 11036.7 11050.0 10667.5 10788.9 10849.2 11036.3 11116.4 9642.0 10744.1 10777.1 10991.5 11263.2 7431.3 7432.0 7500.6 7577.8 7803.1 8492.0 10653.3 10788.7 11096.9 11097.3 11:35:12 INFO - PROCESS | 1665 | 11:35:12 INFO - PROCESS | 1665 | [#3] mootools.html Cycles:180 Average:6178.65 Median:5542.06 stddev:3267.16 (59.0%) stddev-sans-first:3256.96 11:35:12 INFO - PROCESS | 1665 | Values: 1446.9 1579.7 1603.2 1920.8 2040.2 8071.3 8744.5 8907.3 8911.0 8936.3 8589.7 8839.4 8842.7 8847.6 8853.0 2450.9 2471.4 2474.3 2474.5 2476.2 2415.8 2502.9 2504.9 2507.4 2514.9 2473.2 2489.5 2512.8 2517.2 2526.1 2462.9 2478.7 2492.1 2504.6 2506.1 2426.4 2459.0 2464.8 2469.6 2477.0 8958.9 9022.6 9025.7 9031.2 9041.5 5408.9 5550.8 5615.0 5617.7 5619.8 3589.9 3680.2 3738.8 3739.9 3757.7 891.8 1042.9 1051.0 1051.2 1062.4 12408.3 12432.3 12465.0 12475.6 12476.6 4808.7 4885.5 4937.5 4945.4 4968.9 10441.1 10470.5 10490.5 10493.9 10503.2 5533.3 5568.3 5570.5 5579.6 5586.2 4394.8 4568.8 4829.9 4982.9 5055.1 3644.0 3711.7 4019.6 4032.0 4042.0 1316.7 1321.0 1321.7 1324.4 1335.2 967.3 996.8 1039.9 1151.6 1399.4 8208.5 8373.5 8373.7 8392.9 8395.1 1210.7 1211.1 1232.1 1247.6 1253.0 6386.5 6452.7 6462.8 6469.4 6506.1 10282.4 10825.2 10946.5 10975.6 10987.3 9684.7 10645.7 10876.8 10907.9 11049.7 6811.4 8500.3 8657.1 8687.4 8713.3 7941.4 8186.5 8258.8 8260.2 8326.7 9589.5 9643.3 9730.8 9751.2 9848.4 9672.2 9937.0 10097.0 10157.9 10168.8 7616.2 7665.2 7695.5 7772.3 7802.2 8316.3 8326.5 8367.6 8383.0 8392.1 6450.5 7360.0 7566.8 7734.4 7822.1 7397.4 7415.8 7430.0 7541.1 7565.3 7898.8 7909.0 7967.2 7969.3 7971.2 7095.3 7151.0 7152.4 7203.8 7218.7 7250.3 7298.7 7301.5 7319.4 7353.5 11:35:12 INFO - PROCESS | 1665 | 11:35:12 INFO - PROCESS | 1665 | [#4] prototype.html Cycles:180 Average:5789.49 Median:6666.82 stddev:1868.18 (28.0%) stddev-sans-first:1827.73 11:35:12 INFO - PROCESS | 1665 | Values: 318.4 319.6 327.1 327.2 332.1 5388.0 6678.5 6680.7 6684.0 6725.4 6535.8 6609.9 6616.5 6622.7 6638.9 3647.7 4652.6 4765.9 4773.0 4944.3 4015.2 4886.1 4925.5 4930.5 4940.0 3968.3 4859.0 4863.8 4873.0 4874.0 4630.2 4749.4 4841.8 4875.2 4883.0 4162.2 4170.9 4174.8 4175.4 4186.2 6278.6 6308.6 6323.6 6359.7 6382.4 4943.3 5490.1 5745.7 5764.8 5786.6 6995.2 7004.6 7005.3 7007.4 7016.6 4472.7 4626.4 4654.8 4669.3 4697.1 7310.6 7460.3 7466.8 7487.2 7501.0 4771.2 4771.4 4774.1 4781.8 4783.1 4805.4 4836.8 4837.6 4853.8 4858.3 5749.0 5753.5 5772.8 5777.2 5788.7 6219.2 6603.8 6805.9 7039.4 7079.6 1487.0 1527.7 1651.3 1659.3 1675.5 1073.8 1090.3 1099.8 1101.1 1106.6 6433.0 6626.0 6655.2 6755.2 6776.0 7382.6 7388.1 7394.7 7417.4 7430.4 6714.4 6722.6 6738.5 6745.9 6751.3 3849.7 3907.0 3907.1 3908.1 3918.6 7333.9 7731.8 7752.3 7752.4 7768.5 6883.9 7572.0 7613.8 7619.4 7621.8 7191.2 7698.7 7704.0 7714.4 7718.7 7065.7 7362.6 7372.7 7377.2 7383.6 7247.7 7284.5 7292.3 7294.7 7300.2 7736.3 7736.7 7743.8 7747.1 7766.6 4107.2 4305.7 4535.0 4568.9 4574.9 6981.7 7304.2 7315.2 7317.6 7328.2 7036.4 7063.9 7074.2 7094.5 7094.8 7023.5 7065.7 7071.9 7077.8 7094.9 6900.7 6902.6 6906.6 6908.5 6911.4 6778.3 7051.9 7058.0 7075.5 7076.1 6719.1 6734.2 6901.0 6929.9 6942.3 11:35:12 INFO - PROCESS | 1665 | 11:35:12 INFO - PROCESS | 1665 | [#5] yui.html Cycles:180 Average:18716.95 Median:585.34 stddev:26632.69 (4550.0%) stddev-sans-first:26673.29 11:35:12 INFO - PROCESS | 1665 | Values: 766.7 771.0 780.4 782.5 786.1 15021.8 15145.3 15315.8 15320.2 15370.9 13921.2 13925.4 13998.4 14005.9 14100.7 754.9 758.6 910.1 925.3 945.1 929.9 936.5 939.4 942.8 944.0 999.6 1002.8 1003.2 1005.0 1005.1 789.3 970.2 995.8 996.0 1001.9 742.1 745.6 746.0 747.5 748.0 13509.7 14720.8 14793.0 14803.9 14813.0 11611.5 12495.0 12856.9 12869.2 13062.4 9253.5 10004.5 10018.7 10091.0 10343.9 2983.6 3469.6 3498.8 3537.7 3589.8 81694.0 81772.6 81917.0 82030.0 85140.6 9389.2 9459.8 9488.4 9680.6 10321.4 21500.0 21909.5 21937.5 21945.5 21990.9 7161.4 7249.9 7251.5 7296.9 7321.2 3929.7 3986.6 3992.0 3997.3 4015.8 3598.9 3648.7 3651.9 3654.5 3654.5 676.8 680.4 687.7 688.7 708.8 516.7 548.6 586.9 592.9 600.6 7958.4 8099.8 8188.6 8273.3 8284.1 577.2 583.8 603.9 612.4 638.1 3824.2 3825.6 3860.5 3889.6 4054.8 92875.0 96203.0 96350.5 97154.0 98343.0 82254.6 82494.4 82561.0 83826.2 84792.0 66663.7 66822.3 67148.7 67965.0 74883.3 8363.7 8532.7 8578.8 8647.7 8682.5 48346.8 50303.0 51241.2 51950.2 51968.0 65667.0 72654.0 72798.0 73361.0 73418.0 10749.0 10972.8 11276.6 11299.0 11318.2 11816.9 11834.6 11868.9 11908.6 12750.4 11380.7 11381.3 11785.6 12292.0 12350.5 11487.7 11538.3 11552.7 11770.4 11830.6 11196.3 11289.5 11477.5 11569.8 12264.4 9610.4 9648.1 9831.5 10051.4 10225.0 8411.6 8512.3 8986.0 9292.6 9696.3 11:35:12 INFO - PROCESS | 1665 | -------- Summary: end -------- 11:35:12 INFO - PROCESS | 1665 | 11:35:13 INFO - TEST-INFO | 1665: exit 0 11:35:13 INFO - TEST-OK | dromaeo_css | took 1113314ms 11:35:13 INFO - TEST-START | kraken 11:35:13 INFO - operating with platform_type : mac_ 11:35:13 INFO - Initialising browser for kraken test... 11:35:13 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmpYEwai0/profile http://localhost:49277/getInfo.html) 11:35:15 INFO - PROCESS | 1677 | __metrics Screen width/height:1600/1200 11:35:15 INFO - PROCESS | 1677 | colorDepth:24 11:35:15 INFO - PROCESS | 1677 | Browser inner width/height: 1024/689 11:35:15 INFO - PROCESS | 1677 | __metrics 11:35:15 INFO - PROCESS | 1677 | 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" 11:35:15 ERROR - PROCESS | 1677 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:35:15 INFO - TEST-INFO | 1677: exit 0 11:35:15 INFO - Browser initialized. 11:35:15 INFO - Running cycle 1/1 for kraken test... 11:35:15 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmpYEwai0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:35:27 INFO - PROCESS | 1679 | RSS: Main: 243363840 11:35:27 INFO - PROCESS | 1679 | 11:35:30 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection) 11:35:31 INFO - PROCESS | 1679 | RSS: Main: 289325056 11:35:31 INFO - PROCESS | 1679 | 11:35:33 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-dft) 11:35:34 INFO - PROCESS | 1679 | RSS: Main: 299651072 11:35:34 INFO - PROCESS | 1679 | 11:35:37 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-fft) 11:35:38 INFO - PROCESS | 1679 | RSS: Main: 286142464 11:35:38 INFO - PROCESS | 1679 | 11:35:40 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator) 11:35:40 INFO - PROCESS | 1679 | RSS: Main: 289628160 11:35:40 INFO - PROCESS | 1679 | 11:35:42 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:35:43 INFO - PROCESS | 1679 | RSS: Main: 290770944 11:35:43 INFO - PROCESS | 1679 | 11:35:46 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom) 11:35:46 INFO - PROCESS | 1679 | RSS: Main: 289705984 11:35:46 INFO - PROCESS | 1679 | 11:35:49 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate) 11:35:50 INFO - PROCESS | 1679 | RSS: Main: 290811904 11:35:50 INFO - PROCESS | 1679 | 11:35:53 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial) 11:35:53 INFO - PROCESS | 1679 | RSS: Main: 292298752 11:35:53 INFO - PROCESS | 1679 | 11:35:55 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:35:55 INFO - PROCESS | 1679 | RSS: Main: 324882432 11:35:55 INFO - PROCESS | 1679 | 11:35:57 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:35:58 INFO - PROCESS | 1679 | RSS: Main: 325160960 11:35:58 INFO - PROCESS | 1679 | 11:36:00 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:36:01 INFO - PROCESS | 1679 | RSS: Main: 331468800 11:36:01 INFO - PROCESS | 1679 | 11:36:03 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:36:04 INFO - PROCESS | 1679 | RSS: Main: 332517376 11:36:04 INFO - PROCESS | 1679 | 11:36:06 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:36:07 INFO - PROCESS | 1679 | RSS: Main: 333328384 11:36:07 INFO - PROCESS | 1679 | 11:36:09 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49277/tests/kraken/driver.html?testName=ai-astar) 11:36:09 INFO - PROCESS | 1679 | RSS: Main: 392724480 11:36:09 INFO - PROCESS | 1679 | 11:36:09 INFO - PROCESS | 1679 | __start_tp_report 11:36:09 INFO - PROCESS | 1679 | _x_x_mozilla_page_load 11:36:09 INFO - PROCESS | 1679 | _x_x_mozilla_page_load_details 11:36:09 INFO - PROCESS | 1679 | |i|pagename|runs| 11:36:09 INFO - PROCESS | 1679 | |0;ai-astar;108;104;108;108;110;108;117;108;109;107 11:36:09 INFO - PROCESS | 1679 | |1;audio-beat-detection;153;116;138;148;114;131;165;144;198;150 11:36:09 INFO - PROCESS | 1679 | |2;audio-dft;185;186;182;185;182;183;184;185;189;181 11:36:09 INFO - PROCESS | 1679 | |3;audio-fft;79;73;82;77;55;56;58;75;75;55 11:36:09 INFO - PROCESS | 1679 | |4;audio-oscillator;96;92;131;80;77;87;115;105;123;144 11:36:09 INFO - PROCESS | 1679 | |5;imaging-gaussian-blur;86;84;86;84;85;87;135;121;86;83 11:36:09 INFO - PROCESS | 1679 | |6;imaging-darkroom;92;92;93;93;113;152;105;93;91;101 11:36:09 INFO - PROCESS | 1679 | |7;imaging-desaturate;87;87;86;86;82;85;86;87;84;104 11:36:09 INFO - PROCESS | 1679 | |8;json-parse-financial;55;55;53;53;53;52;53;64;54;52 11:36:09 INFO - PROCESS | 1679 | |9;json-stringify-tinderbox;65;73;63;74;72;68;68;92;103;99 11:36:09 INFO - PROCESS | 1679 | |10;stanford-crypto-aes;82;82;83;83;80;82;83;83;84;85 11:36:09 INFO - PROCESS | 1679 | |11;stanford-crypto-ccm;120;130;119;119;130;125;125;124;120;123 11:36:09 INFO - PROCESS | 1679 | |12;stanford-crypto-pbkdf2;128;127;140;137;138;127;137;137;141;178 11:36:09 INFO - PROCESS | 1679 | |13;stanford-crypto-sha256-iterative;68;67;66;68;66;67;67;67;67;67 11:36:09 INFO - PROCESS | 1679 | __end_tp_report 11:36:09 INFO - PROCESS | 1679 | __start_cc_report 11:36:09 INFO - PROCESS | 1679 | _x_x_mozilla_cycle_collect,1243 11:36:09 INFO - PROCESS | 1679 | __end_cc_report 11:36:09 INFO - PROCESS | 1679 | __startTimestamp1458153369323__endTimestamp 11:36:09 INFO - PROCESS | 1679 | 11:36:09 INFO - PROCESS | 1679 | ------- Summary: start ------- 11:36:09 INFO - PROCESS | 1679 | Number of tests: 14 11:36:09 INFO - PROCESS | 1679 | 11:36:09 INFO - PROCESS | 1679 | [#0] ai-astar Cycles:10 Average:108.70 Median:108.00 stddev:3.30 (3.1%) stddev-sans-first:3.49 11:36:09 INFO - PROCESS | 1679 | Values: 108.0 104.0 108.0 108.0 110.0 108.0 117.0 108.0 109.0 107.0 11:36:09 INFO - PROCESS | 1679 | 11:36:09 INFO - PROCESS | 1679 | [#1] audio-beat-detection Cycles:10 Average:145.70 Median:149.00 stddev:24.38 (16.4%) stddev-sans-first:25.72 11:36:09 INFO - PROCESS | 1679 | Values: 153.0 116.0 138.0 148.0 114.0 131.0 165.0 144.0 198.0 150.0 11:36:09 INFO - PROCESS | 1679 | 11:36:09 INFO - PROCESS | 1679 | [#2] audio-dft Cycles:10 Average:184.20 Median:185.00 stddev:2.35 (1.3%) stddev-sans-first:2.47 11:36:09 INFO - PROCESS | 1679 | Values: 185.0 186.0 182.0 185.0 182.0 183.0 184.0 185.0 189.0 181.0 11:36:09 INFO - PROCESS | 1679 | 11:36:09 INFO - PROCESS | 1679 | [#3] audio-fft Cycles:10 Average:68.50 Median:75.00 stddev:11.06 (14.7%) stddev-sans-first:11.06 11:36:09 INFO - PROCESS | 1679 | Values: 79.0 73.0 82.0 77.0 55.0 56.0 58.0 75.0 75.0 55.0 11:36:09 INFO - PROCESS | 1679 | 11:36:09 INFO - PROCESS | 1679 | [#4] audio-oscillator Cycles:10 Average:105.00 Median:78.50 stddev:22.62 (28.8%) stddev-sans-first:23.75 11:36:09 INFO - PROCESS | 1679 | Values: 96.0 92.0 131.0 80.0 77.0 87.0 115.0 105.0 123.0 144.0 11:36:09 INFO - PROCESS | 1679 | 11:36:09 INFO - PROCESS | 1679 | [#5] imaging-gaussian-blur Cycles:10 Average:93.70 Median:85.50 stddev:18.42 (21.5%) stddev-sans-first:19.32 11:36:09 INFO - PROCESS | 1679 | Values: 86.0 84.0 86.0 84.0 85.0 87.0 135.0 121.0 86.0 83.0 11:36:09 INFO - PROCESS | 1679 | 11:36:09 INFO - PROCESS | 1679 | [#6] imaging-darkroom Cycles:10 Average:102.50 Median:92.00 stddev:18.83 (20.5%) stddev-sans-first:19.59 11:36:09 INFO - PROCESS | 1679 | Values: 92.0 92.0 93.0 93.0 113.0 152.0 105.0 93.0 91.0 101.0 11:36:09 INFO - PROCESS | 1679 | 11:36:09 INFO - PROCESS | 1679 | [#7] imaging-desaturate Cycles:10 Average:87.40 Median:86.00 stddev:6.04 (7.0%) stddev-sans-first:6.41 11:36:09 INFO - PROCESS | 1679 | Values: 87.0 87.0 86.0 86.0 82.0 85.0 86.0 87.0 84.0 104.0 11:36:09 INFO - PROCESS | 1679 | 11:36:09 INFO - PROCESS | 1679 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:53.50 stddev:3.53 (6.6%) stddev-sans-first:3.74 11:36:09 INFO - PROCESS | 1679 | Values: 55.0 55.0 53.0 53.0 53.0 52.0 53.0 64.0 54.0 52.0 11:36:09 INFO - PROCESS | 1679 | 11:36:09 INFO - PROCESS | 1679 | [#9] json-stringify-tinderbox Cycles:10 Average:77.70 Median:72.50 stddev:14.65 (20.2%) stddev-sans-first:14.80 11:36:09 INFO - PROCESS | 1679 | Values: 65.0 73.0 63.0 74.0 72.0 68.0 68.0 92.0 103.0 99.0 11:36:09 INFO - PROCESS | 1679 | 11:36:09 INFO - PROCESS | 1679 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:83.00 stddev:1.34 (1.6%) stddev-sans-first:1.39 11:36:09 INFO - PROCESS | 1679 | Values: 82.0 82.0 83.0 83.0 80.0 82.0 83.0 83.0 84.0 85.0 11:36:09 INFO - PROCESS | 1679 | 11:36:09 INFO - PROCESS | 1679 | [#11] stanford-crypto-ccm Cycles:10 Average:123.50 Median:124.50 stddev:4.14 (3.3%) stddev-sans-first:4.20 11:36:09 INFO - PROCESS | 1679 | Values: 120.0 130.0 119.0 119.0 130.0 125.0 125.0 124.0 120.0 123.0 11:36:09 INFO - PROCESS | 1679 | 11:36:09 INFO - PROCESS | 1679 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.00 Median:137.50 stddev:14.71 (10.7%) stddev-sans-first:15.06 11:36:09 INFO - PROCESS | 1679 | Values: 128.0 127.0 140.0 137.0 138.0 127.0 137.0 137.0 141.0 178.0 11:36:09 INFO - PROCESS | 1679 | 11:36:09 INFO - PROCESS | 1679 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 11:36:09 INFO - PROCESS | 1679 | Values: 68.0 67.0 66.0 68.0 66.0 67.0 67.0 67.0 67.0 67.0 11:36:09 INFO - PROCESS | 1679 | -------- Summary: end -------- 11:36:09 INFO - PROCESS | 1679 | 11:36:10 INFO - TEST-INFO | 1679: exit 0 11:36:10 INFO - TEST-OK | kraken | took 57016ms 11:36:10 INFO - SUITE-END | took 1170s 11:36:10 INFO - Completed test suite (00:19:30) 11:36:10 INFO - javascript benchmark 11:36:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2990.566367876659, 3170.397624451354, 3476.860925562976, 3521.7886926784404, 3561.9287614247714, 4379.62773164281, 5396.676199428032, 5530.391656917735, 5634.4365563443735, 5693.174489698986, 5621.241132447119, 5622.353429355625, 5665.575081868856, 5671.092625179972, 5675.2054712340305, 5121.692698438096, 5151.304573882516, 5166.43169251382, 5236.423993360727, 5241.2400201970695, 5201.609879259052, 5246.606504512177, 5250.4487028861995, 5250.579953603722, 5261.684298942057, 5168.7932482700835, 5215.817446389377, 5222.929299493614, 5250.579953603703, 5261.053010458116, 4849.787553111722, 5223.399309079467, 5233.476652334774, 5285.762140703678, 5342.958123165984, 5048.318477005594, 5117.0, 5132.0, 5186.170212765939, 5194.142966410538, 5546.27898373213, 5554.750036248338, 5584.944150558483, 5595.412481689405, 5656.971715141398, 6189.257289125334, 6236.03341482071, 6237.7816776413065, 6244.344343843876, 6245.718942647546, 6126.111713801519, 6136.478399336017, 6225.7509699611965, 6249.906266403406, 6268.279147898004, 5784.219130417424, 5800.0, 5805.10020946754, 5816.069428891357, 5817.738201780845, 6198.6280823150755, 6260.686965651699, 6262.812115636538, 6266.592671476339, 6276.340984196685, 5978.940210597838, 6055.7274922628585, 6104.15601054772, 6117.082437634391, 6147.508199344042, 6186.381361863778, 6216.7824126155365, 6227.813165605039, 6238.625682459067, 6256.624602523772, 6173.629582224991, 6182.474489668339, 6188.938110618837, 6207.534434917399, 6221.3156552779155, 4537.886552836139, 6076.574639775262, 6136.12084543884, 6148.9854174061675, 6187.752489900444, 4888.7311197884455, 4890.633202509826, 4904.828331008398, 4918.483559226302, 4945.381827271591, 4374.978125109354, 4390.8024138913825, 4394.1651086293505, 4406.052698669801, 4438.556144385536, 5639.182318563785, 5688.687122208235, 5707.229524014288, 5749.9712501437225, 5752.165935939265, 6183.536234782409, 6233.625982440977, 6236.376362363727, 6253.249610046823, 6268.185135932391, 5125.64120511568, 5493.7802487900835, 5786.42135786418, 5799.971000144972, 5810.331811841608, 5239.73801309933, 5309.920351194735, 5346.0, 5358.437364076716, 5365.436629153883, 6170.753169873335, 6311.715972781236, 6359.300476947532, 6363.0, 6375.330590287953, 5372.704501252469, 6179.3631280485815, 6220.315765265726, 6227.346128656607, 6235.937640623536, 6164.0, 6259.374062593886, 6288.0, 6348.206474190726, 6352.237731472253, 6154.323024467216, 6158.107074474266, 6162.198914141133, 6163.938360616516, 6176.598521096114, 6071.0, 6174.629522228681, 6178.135061091541, 6199.938000619936, 6244.68776561161, 5941.930452518588, 6057.303410107894, 6088.5737998341465, 6101.792513241593, 6122.459144589048, 6095.725692343766, 6103.992841181333, 6104.145419641165, 6109.358517355614, 6133.785317514044, 4372.672049596229, 5482.91775623358, 5570.832875013756, 5984.611000284967, 5996.820095397145, 5923.289205295392, 5957.285125784933, 5997.220361352996, 6061.242344706911, 6068.7269072892705, 5912.881742365214, 5928.644281343133, 5961.135635332939, 5976.491998180029, 6033.215681961317], "unit": "score", "name": "dojo.html", "value": 5639.825225924991}, {"lowerIsBetter": false, "replicates": [474.36908911148174, 559.9384067752546, 580.3934888041993, 621.8775110924781, 640.9775657851975, 30369.392612147745, 39112.41331380028, 39420.211595768065, 39462.210755784865, 39629.80185099078, 42065.57934420655, 42382.99999999992, 42461.0, 42480.0, 42529.0, 8009.679612815509, 8194.180581941817, 9441.339106262547, 9671.081247281498, 9684.515774211297, 9534.09426104519, 9659.758506037335, 9662.855057174149, 9677.0, 9691.176250018756, 9669.419834809934, 9871.40771553709, 9872.45701486418, 9883.061109194616, 9886.703398898044, 9749.708818427664, 9840.458774767385, 9844.228038952986, 9853.014698530125, 9868.013198680146, 9641.807163856683, 9789.608415663364, 9794.265430092772, 9804.215662747034, 9821.0, 41130.58869411297, 41606.583934160575, 41678.37482437766, 41774.0, 41824.79087604573, 3397.69420752131, 3421.674940880612, 3451.1027132945364, 3532.6467353264725, 3891.5135608048995, 28666.270065439177, 28725.425491490052, 28758.70585823643, 28796.712032879823, 29734.107976760733, 2633.3285012321926, 2634.5916382960672, 2739.2877851758485, 2750.477409292228, 2758.2690586994463, 471178.99999999657, 477593.0, 477809.0, 478141.0, 481239.0, 45461.0, 45724.99999999934, 45914.39299624497, 70265.64867175734, 70674.64662676654, 45101.097978040256, 45149.77425112853, 45231.0, 45281.0, 45311.86720332018, 15953.840461595235, 16085.597860053358, 16100.275487602852, 16110.919445402698, 16128.516144515448, 12877.420516076612, 12934.741305173844, 12947.611571652866, 12972.870271297355, 12991.960643148526, 14897.329620167118, 14928.954973151775, 14940.701185976219, 14989.70020599582, 15044.774328385083, 6450.8064758057335, 6540.542162048611, 6592.17597800275, 6598.505112116514, 6608.537402381883, 953.1374106433689, 1017.8524114003428, 1036.290141253244, 1085.3650614390513, 1093.1254996003324, 29564.0, 29736.0, 30048.39903201924, 30357.0, 30437.543436848464, 976.497103991445, 1064.8818740322786, 1113.0761467981556, 1183.4496958914146, 1239.2007155384727, 15010.324535395934, 15164.165970871487, 15217.163056032025, 15533.922330388275, 15565.29956151976, 518889.0, 702960.0, 718516.0, 720835.0, 723175.0, 53738.0, 62080.689596552635, 62784.0, 62886.0, 64116.679416602616, 1360.4082224232293, 1395.1559306619552, 1516.438917600473, 1538.9307481163376, 1652.7686123942658, 30543.847280763453, 30907.690923090482, 31181.064568062993, 31488.685113148575, 31494.89767858114, 53963.730181348845, 54205.0, 54567.0, 54577.0, 54654.72672636611, 424996.0, 428771.0, 428902.0, 429567.0, 429698.0, 33248.54451413028, 33320.0, 33973.320533589686, 34044.0, 34087.147821304665, 45122.09755804931, 45368.31947520856, 45540.772296138304, 45565.77217113893, 47047.7657010857, 37229.0, 37240.813795930844, 37274.440883386225, 37826.62173378341, 38589.4211586832, 36738.0, 37142.44286335761, 37907.81046094752, 38125.85622431331, 38157.85526434211, 36875.0, 37302.06744831401, 37303.067423314635, 37532.624673752915, 38163.42754858735, 31643.764132893226, 32606.828215833495, 33275.16812079717, 33348.99953001414, 33366.0, 24307.35424983481, 24763.32611994101, 24842.130525431523, 24997.125100622117, 25256.23206375536], "unit": "score", "name": "ext.html", "value": 19610.141376257896}, {"lowerIsBetter": false, "replicates": [362.99455508167375, 366.40825067515954, 369.48456902620836, 371.5745471435207, 378.89959160822406, 19270.807291927078, 19604.60790784185, 19650.508737281576, 19986.900065499653, 20018.29935952238, 10868.130549556035, 11218.831717524243, 11248.606298779545, 11255.43722813858, 11266.887331126707, 4587.472440669316, 5220.373555173375, 5240.423553409122, 5362.115250983583, 5436.238926550286, 5216.9478305217035, 5275.551578115865, 5300.549453296474, 5301.416844147141, 5315.123004704219, 5294.073537131006, 5301.973490132544, 5308.150695888658, 5424.294841670578, 6004.8498787530225, 5797.884042319151, 5948.791792287292, 5978.432048955342, 5986.311574168983, 5991.910121348205, 5124.974375128138, 5166.457521960216, 5231.9476805232225, 5254.4220135785035, 5259.053370393328, 10846.620368287151, 12520.499180032788, 12937.547185848543, 13026.153300035467, 13029.609111726664, 1989.204318272688, 2000.249906285143, 2243.9663405048937, 2376.2158487699016, 2576.4203054312816, 9134.497602631853, 9443.952780236124, 9504.239660827117, 9696.46669433181, 9697.806043879153, 1465.4138344662115, 1713.751506031631, 1797.020623760054, 1806.3858288182082, 1819.972700409495, 94359.11281774325, 103943.96056039419, 104377.43433848498, 105282.49290656533, 106189.0, 11071.280366776135, 11281.21031527785, 11309.321440713584, 11321.660350189508, 11426.029232399469, 13683.657908552166, 13703.520376786764, 13752.65618359549, 13766.724665506634, 13769.655758605915, 7228.385587225145, 8273.544955027532, 8316.0, 8482.575871206414, 8574.657013719381, 8634.6977855776, 8637.956810215908, 8639.438436501607, 8752.081031491729, 8774.780630484289, 4327.17783621111, 4355.237833379146, 4390.736555806662, 4447.199504089295, 4502.729836209838, 1675.3801093595448, 1813.9818601814077, 1907.1417861962173, 1911.5794525204433, 1930.5656227349016, 724.1035856573706, 857.4640849469082, 900.446225571269, 945.6217512994857, 977.1986970683971, 16733.828631995642, 17065.0, 19416.805831941783, 19585.902070489556, 19690.70463943042, 902.6621051476576, 909.9181073703267, 937.3017102258724, 950.2065775077888, 950.4107453378949, 10374.325668831501, 10855.294405863593, 10898.782024359627, 10912.672619821418, 10919.727006824893, 509954.0, 512951.0, 513230.0, 622061.0, 623806.0, 101679.34046265593, 107083.39374909383, 114714.0, 117587.0, 123221.0, 1009.914157296638, 1011.7774089700254, 1038.7818558102883, 1060.5068643081004, 1061.9522121504551, 18061.729074063638, 18403.53991150232, 18465.53836154107, 18607.72088418702, 18695.840878818177, 51882.740586298336, 52876.47123528716, 52910.73544632252, 53530.732346338016, 54061.72969135129, 74985.0, 75078.0, 75134.62432687801, 77412.6129369372, 77766.0, 7263.636818159177, 7270.6728197230195, 7669.693212271447, 7785.610719464117, 8058.395620328616, 11326.32042077478, 12433.44049517792, 12630.938670097108, 12691.682707932376, 12795.872041279841, 10764.784704306026, 10889.504432408723, 10979.956904094099, 11036.668899933014, 11050.0, 10667.51996160159, 10788.946055269673, 10849.186311026862, 11036.282641628268, 11116.44417779124, 9641.951790241004, 10744.140468762636, 10777.08394786452, 10991.505382257978, 11263.155263355116, 7431.29402706742, 7432.0, 7500.62496875165, 7577.772666820004, 7803.063632364153, 8491.957540212507, 10653.307535010199, 10788.730281743019, 11096.945790149923, 11097.278676885977], "unit": "score", "name": "jquery.html", "value": 8841.54498974907}, {"lowerIsBetter": false, "replicates": [1446.8842492600593, 1579.65247645518, 1603.1583418705181, 1920.75030246068, 2040.2145174107964, 8071.313938315243, 8744.475331480107, 8907.28741700664, 8910.955445222773, 8936.329775266848, 8589.742307730763, 8839.425437346568, 8842.690505832297, 8847.646094156242, 8852.95573522133, 2450.9264722058365, 2471.4439251168433, 2474.257722683197, 2474.4927289905527, 2476.19523654812, 2415.758424157588, 2502.9374265643323, 2504.949901001988, 2507.4107584717576, 2514.88683009265, 2473.245660073677, 2489.5394352044927, 2512.836665616738, 2517.2196619048063, 2526.1411120219122, 2462.8645424501733, 2478.6901637295337, 2492.0779311654715, 2504.561701702213, 2506.0602274147195, 2426.4055306449854, 2459.0, 2464.7904928081134, 2469.555480013597, 2476.987615061913, 8958.86561701575, 9022.593983270768, 9025.729228123168, 9031.187193152648, 9041.457512549268, 5408.864778380533, 5550.8057217997175, 5614.9719251403485, 5617.662940223599, 5619.831405057855, 3589.910252243689, 3680.1719613087107, 3738.775673459574, 3739.906502337436, 3757.6618104370737, 891.8216356728616, 1042.9205772025994, 1050.9632162874339, 1051.1789644641706, 1062.3519653011656, 12408.317542535156, 12432.254064756144, 12465.0, 12475.563355282613, 12476.563320283747, 4808.711477311303, 4885.462599114095, 4937.506249375106, 4945.406551213878, 4968.925466118011, 10441.060304572473, 10470.528826202839, 10490.527926243338, 10493.9475302623, 10503.2122590806, 5533.3083364579425, 5568.331800184003, 5570.470805273492, 5579.553635709133, 5586.217929489874, 4394.8242070317465, 4568.794404251817, 4829.879253018703, 4982.90034199314, 5055.090083784954, 3643.9817800911355, 3711.6659500645073, 4019.618136277049, 4031.9798401007806, 4042.0, 1316.697159653285, 1320.966975825612, 1321.6960099177243, 1324.3775425549977, 1335.2389138191331, 967.2697113679268, 996.8106059848606, 1039.8856125826153, 1151.5681619392728, 1399.3772771116755, 8208.466449680871, 8373.455725377831, 8373.706920257762, 8392.874106888401, 8395.118512556215, 1210.6549633354452, 1211.0795795195716, 1232.0882546915398, 1247.5945317771761, 1253.0476837603487, 6386.457151142205, 6452.677366131768, 6462.838429039218, 6469.353064693587, 6506.089147519351, 10282.383057016603, 10825.188110891557, 10946.507407166697, 10975.560977560808, 10987.340759554452, 9684.692566503572, 10645.733856653645, 10876.836847447295, 10907.890921090846, 11049.668509944715, 6811.352921472452, 8500.277476414574, 8657.091005444463, 8687.435316704394, 8713.259372953244, 7941.404394670307, 8186.508809471213, 8258.793530161794, 8260.215279548433, 8326.6669333226, 9589.520523973913, 9643.2767542436, 9730.75673108178, 9751.171150452292, 9848.409095454295, 9672.22622190209, 9936.950315248378, 10097.040781125781, 10157.949210254197, 10168.847467288144, 7616.162222155669, 7665.156832748505, 7695.461317707706, 7772.300492955661, 7802.219778022152, 8316.293115085286, 8326.542040187605, 8367.58162091905, 8382.958085209779, 8392.076871544003, 6450.516211284079, 7360.0, 7566.848663026599, 7734.419918506022, 7822.139564647998, 7397.371223445852, 7415.8146046349275, 7430.0340955677575, 7541.132769731551, 7565.319121279112, 7898.842023159619, 7909.0, 7967.2431119043595, 7969.282764551218, 7971.202879711982, 7095.254998225112, 7151.0, 7152.427805775629, 7203.819904502429, 7218.711251549879, 7250.274972502708, 7298.708051677873, 7301.525400848928, 7319.377852882564, 7353.522021068614], "unit": "score", "name": "mootools.html", "value": 5021.572685345247}, {"lowerIsBetter": false, "replicates": [318.4395463983389, 319.56858241374147, 327.09884268839346, 327.15267457285626, 332.080138017691, 5387.973060134699, 6678.465722742181, 6680.732770689178, 6683.966580167098, 6725.361090696382, 6535.8366040849005, 6609.900851487219, 6616.4782100117, 6622.668866556677, 6638.867222655544, 3647.689946354563, 4652.604528615055, 4765.90468190636, 4772.952270477285, 4944.332515110459, 4015.176888737816, 4886.096072226632, 4925.48282430345, 4930.53159949806, 4939.975300123512, 3968.30554652936, 4859.003904199648, 4863.805447782084, 4873.0, 4873.976464942366, 4630.166570017395, 4749.382580264578, 4841.830535931225, 4875.171220892421, 4883.0, 4162.2299874523005, 4170.854020109282, 4174.812133454002, 4175.352820312856, 4186.162767446523, 6278.560500764948, 6308.621482711006, 6323.620582765049, 6359.682015899187, 6382.393672601095, 4943.258511223309, 5490.149026900836, 5745.683987380692, 5764.798232061899, 5786.594938354317, 6995.160580730345, 7004.649767511604, 7005.299470053005, 7007.369336759665, 7016.5790052597, 4472.664550158718, 4626.421697287839, 4654.836290927268, 4669.32294817253, 4697.13103075932, 7310.561366317985, 7460.25397460255, 7466.775996720053, 7487.213842546563, 7501.0248667673395, 4771.212749896228, 4771.427428708508, 4774.069056534012, 4781.832635857728, 4783.091212669582, 4805.399325084364, 4836.830710925101, 4837.612990960714, 4853.805847766121, 4858.271259311132, 5749.0, 5753.453421924911, 5772.797952071657, 5777.248957635565, 5788.710564471759, 6219.222597175353, 6603.834904127435, 6805.863882722318, 7039.366457018893, 7079.575225486487, 1487.0482890949802, 1527.7326467868302, 1651.2651869917772, 1659.2533359988054, 1675.5308513616208, 1073.758404359013, 1090.2695194219891, 1099.8130317845985, 1101.1191047162238, 1106.590561492253, 6432.9678351607945, 6625.972974189009, 6655.168103987002, 6755.189377274758, 6775.966120169368, 7382.630868456556, 7388.113426388761, 7394.667239974214, 7417.369523590447, 7430.442716796262, 6714.3957043866285, 6722.596644201363, 6738.460923126237, 6745.898811517831, 6751.291114433012, 3849.672777813917, 3906.980465097656, 3907.081835768592, 3908.1402091539817, 3918.6081391860585, 7333.853322933512, 7731.7680469586, 7752.302292793675, 7752.379809615217, 7768.53388796674, 6883.8967415488805, 7571.962140189264, 7613.809654758565, 7619.390448764086, 7621.771346859603, 7191.173015103121, 7698.653560589787, 7704.036995375578, 7714.382849372037, 7718.652660630285, 7065.717371305091, 7362.595057271901, 7372.668229929559, 7377.225391333833, 7383.593902335423, 7247.710091596277, 7284.49008569395, 7292.34368906801, 7294.744683936036, 7300.196978332486, 7736.303732664087, 7736.690532378641, 7743.845123097394, 7747.1090824555895, 7766.611669416619, 4107.199096176217, 4305.655547556125, 4534.954650453453, 4568.88577785558, 4574.862754117382, 6981.654482799849, 7304.151380961323, 7315.195328513752, 7317.5609463432365, 7328.193898671036, 7036.437085033082, 7063.858722825412, 7074.186468556182, 7094.503384763017, 7094.751683691046, 7023.543469674455, 7065.717371305091, 7071.893921591078, 7077.787666370017, 7094.858102838018, 6900.723971041102, 6902.585844849124, 6906.585604863724, 6908.481863860331, 6911.447084233148, 6778.254392016973, 7051.858962820817, 7058.0, 7075.540089894141, 7076.0801095857205, 6719.126513553207, 6734.158230221223, 6901.0, 6929.930700692928, 6942.305769423017], "unit": "score", "name": "prototype.html", "value": 5162.588304889819}, {"lowerIsBetter": false, "replicates": [766.7469734987454, 770.9730159444417, 780.4497829030535, 782.464012151676, 786.1352512236539, 15021.774673379909, 15145.318460669268, 15315.770263446057, 15320.157391343471, 15370.923145384271, 13921.23433211173, 13925.442982280696, 13998.440062397518, 14005.929970350135, 14100.717985640282, 754.943379246556, 758.5562445969115, 910.1217325281102, 925.2875286029753, 945.054945054945, 929.9116583924516, 936.5223735894708, 939.3847030195199, 942.7690215897114, 944.0, 999.5651891427216, 1002.8194924913513, 1003.2174903575186, 1005.0452070533023, 1005.1004351105756, 789.2896393246095, 970.2092794372634, 995.7759504111553, 996.0288718499478, 1001.8697569316015, 742.1205871042831, 745.5526683989617, 745.9850802983964, 747.4655621230792, 747.9700811967515, 13509.662258443519, 14720.779188312184, 14793.0, 14803.851961480355, 14813.0002449669, 11611.477483513178, 12495.000399967981, 12856.935715321364, 12869.22784632925, 13062.412191451407, 9253.537323133884, 10004.499775011293, 10018.749531261705, 10090.990900909923, 10343.89656103437, 2983.6419629644583, 3469.61834198238, 3498.807565583892, 3537.6992955598803, 3589.766665166756, 81694.0, 81772.59113704452, 81917.0, 82030.0, 85140.57429712874, 9389.201917836925, 9459.76350591227, 9488.383255088396, 9680.612775489042, 10321.432321222404, 21500.032498537603, 21909.452263693216, 21937.451563711034, 21945.451363715714, 21990.89004554999, 7161.39128174111, 7249.8550028999125, 7251.4923955323675, 7296.854062918712, 7321.231270716605, 3929.7445666031617, 3986.60133986599, 3992.0, 3997.2605068062503, 4015.8393664253103, 3598.9280214395567, 3648.7263455240964, 3651.94522082169, 3654.524911761507, 3654.543182102237, 676.7513936786621, 680.4284401103097, 687.7145984416511, 688.7004153193377, 708.7802781137864, 516.6744950681122, 548.6077454619966, 586.8956284180025, 592.914027466015, 600.579594284003, 7958.442908996431, 8099.797505062421, 8188.590570471452, 8273.296769774637, 8284.08875023747, 577.238045779567, 583.775246530089, 603.9486643635253, 612.4426771637789, 638.1002786071617, 3824.158685089276, 3825.6174382562076, 3860.4981352424006, 3889.572147063821, 4054.8378064877074, 92875.0, 96203.0, 96350.51824740971, 97154.0, 98343.0, 82254.58872705598, 82494.35011299861, 82561.0, 83826.16173838306, 84792.0, 66663.66672666617, 66822.32944176337, 67148.6642566784, 67964.98052529315, 74883.25116748763, 8363.749087527383, 8532.658693652184, 8578.828423431622, 8647.697330593399, 8682.52246126469, 48346.758266208446, 50303.0, 51241.23138152856, 51950.220746689585, 51968.0, 65667.0, 72654.0, 72798.0, 73361.0, 73418.0, 10749.0, 10972.780544389227, 11276.605318813803, 11298.983091521803, 11318.151138664798, 11816.881831181578, 11834.644960651194, 11868.940655296668, 11908.642740717793, 12750.42623081945, 11380.658580242605, 11381.317120972768, 11785.646430607096, 12292.0, 12350.505979760708, 11487.712807179887, 11538.250013749079, 11552.6534203974, 11770.411479426166, 11830.585929492427, 11196.328220306808, 11289.491972861406, 11477.540898364306, 11569.768604628029, 12264.443311439583, 9610.423374597547, 9648.131668149901, 9831.5084245786, 10051.447170405698, 10225.028622281168, 8411.579421028802, 8512.319014478951, 8986.0, 9292.6282948684, 9696.321257511907], "unit": "score", "name": "yui.html", "value": 6999.764665730561}], "name": "dromaeo_css", "value": 7496.348264920011}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 104.0, 108.0, 108.0, 110.0, 108.0, 117.0, 108.0, 109.0, 107.0], "unit": "score", "name": "ai-astar", "value": 108.7}, {"lowerIsBetter": true, "replicates": [153.0, 116.0, 138.0, 148.0, 114.0, 131.0, 165.0, 144.0, 198.0, 150.0], "unit": "score", "name": "audio-beat-detection", "value": 145.7}, {"lowerIsBetter": true, "replicates": [185.0, 186.0, 182.0, 185.0, 182.0, 183.0, 184.0, 185.0, 189.0, 181.0], "unit": "score", "name": "audio-dft", "value": 184.2}, {"lowerIsBetter": true, "replicates": [79.0, 73.0, 82.0, 77.0, 55.0, 56.0, 58.0, 75.0, 75.0, 55.0], "unit": "score", "name": "audio-fft", "value": 68.5}, {"lowerIsBetter": true, "replicates": [96.0, 92.0, 131.0, 80.0, 77.0, 87.0, 115.0, 105.0, 123.0, 144.0], "unit": "score", "name": "audio-oscillator", "value": 105.0}, {"lowerIsBetter": true, "replicates": [86.0, 84.0, 86.0, 84.0, 85.0, 87.0, 135.0, 121.0, 86.0, 83.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 93.7}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 93.0, 93.0, 113.0, 152.0, 105.0, 93.0, 91.0, 101.0], "unit": "score", "name": "imaging-darkroom", "value": 102.5}, {"lowerIsBetter": true, "replicates": [87.0, 87.0, 86.0, 86.0, 82.0, 85.0, 86.0, 87.0, 84.0, 104.0], "unit": "score", "name": "imaging-desaturate", "value": 87.4}, {"lowerIsBetter": true, "replicates": [55.0, 55.0, 53.0, 53.0, 53.0, 52.0, 53.0, 64.0, 54.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 54.4}, {"lowerIsBetter": true, "replicates": [65.0, 73.0, 63.0, 74.0, 72.0, 68.0, 68.0, 92.0, 103.0, 99.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 77.7}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 83.0, 83.0, 80.0, 82.0, 83.0, 83.0, 84.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.7}, {"lowerIsBetter": true, "replicates": [120.0, 130.0, 119.0, 119.0, 130.0, 125.0, 125.0, 124.0, 120.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.5}, {"lowerIsBetter": true, "replicates": [128.0, 127.0, 140.0, 137.0, 138.0, 127.0, 137.0, 137.0, 141.0, 178.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.0}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 66.0, 68.0, 66.0, 67.0, 67.0, 67.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.0}], "name": "kraken", "value": 1440.0}]} 11:36:10 INFO - Return code: 0 11:36:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:36:10 ERROR - # TBPL SUCCESS # 11:36:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:36:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:36:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:36:10 INFO - 2016-03-16 11:36:10.647 screenresolution[1683:9807] starting screenresolution argv=screenresolution get 11:36:10 INFO - 2016-03-16 11:36:10.650 screenresolution[1683:9807] Display 0: 1600x1200x32@60 11:36:10 INFO - 2016-03-16 11:36:10.655 screenresolution[1684:9810] starting screenresolution argv=screenresolution list 11:36:10 INFO - Available Modes on Display 0 11:36:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:36:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:36:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:36:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:36:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:36:10 INFO - Intel Iris: 11:36:10 INFO - Chipset Model: Intel Iris 11:36:10 INFO - Type: GPU 11:36:10 INFO - Bus: Built-In 11:36:10 INFO - VRAM (Dynamic, Max): 1536 MB 11:36:10 INFO - Vendor: Intel (0x8086) 11:36:10 INFO - Device ID: 0x0a2e 11:36:10 INFO - Revision ID: 0x0009 11:36:10 INFO - Displays: 11:36:10 INFO - Display: 11:36:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:36:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:36:10 INFO - Display Serial Number: 1600x1200 60 11:36:10 INFO - Main Display: Yes 11:36:10 INFO - Mirror: Off 11:36:10 INFO - Online: Yes 11:36:10 INFO - Rotation: Supported 11:36:10 INFO - Return code: 0 11:36:10 INFO - Running post-action listener: _resource_record_post_action 11:36:10 INFO - Running post-run listener: _resource_record_post_run 11:36:11 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 39704064; Write bytes: 706442240; Read time: 431; Write time: 2306 11:36:11 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 387201536; Write bytes: 386529280; Read time: 28792; Write time: 725 11:36:11 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 38761984; Write bytes: 301176320; Read time: 416; Write time: 1532 11:36:11 INFO - Running post-run listener: _upload_blobber_files 11:36:11 INFO - Blob upload gear active. 11:36:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:36:11 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:36:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:36:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:36:12 INFO - (blobuploader) - INFO - Open directory for files ... 11:36:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:36:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:36:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:36:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:36:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:36:13 INFO - (blobuploader) - INFO - Done attempting. 11:36:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:36:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:36:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:36:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:36:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:36:14 INFO - (blobuploader) - INFO - Done attempting. 11:36:14 INFO - (blobuploader) - INFO - Iteration through files over. 11:36:14 INFO - Return code: 0 11:36:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:36:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:36:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f5d3e52b30f8a05ff55ecb9865d83b442ac7aea00bd9e5777330290cc22afba2f2d3e6b0894233421f5891a596c9957762db23bb7ba5eb47f8cc2dba867fa4d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/36ee1c20e89ae4137bdfe06607ac722fc0dc342aeb3cf2b38cf29d049fd9a0490900c1c53b1ca66fe70af3691c372853c1928f2563342618fccc530bd9c6985f"} 11:36:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:36:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:36:14 INFO - Contents: 11:36:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f5d3e52b30f8a05ff55ecb9865d83b442ac7aea00bd9e5777330290cc22afba2f2d3e6b0894233421f5891a596c9957762db23bb7ba5eb47f8cc2dba867fa4d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/36ee1c20e89ae4137bdfe06607ac722fc0dc342aeb3cf2b38cf29d049fd9a0490900c1c53b1ca66fe70af3691c372853c1928f2563342618fccc530bd9c6985f"} 11:36:14 INFO - Running post-run listener: copy_logs_to_upload_dir 11:36:14 INFO - Copying logs to upload dir... 11:36:14 INFO - mkdir: /builds/slave/test/build/upload/logs 11:36:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.820278 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-03-16 11:36:14.110962) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-16 11:36:14.114270) ========= 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.6SUHLDpPDA/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.DOoRtC8pZN/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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/f5d3e52b30f8a05ff55ecb9865d83b442ac7aea00bd9e5777330290cc22afba2f2d3e6b0894233421f5891a596c9957762db23bb7ba5eb47f8cc2dba867fa4d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/36ee1c20e89ae4137bdfe06607ac722fc0dc342aeb3cf2b38cf29d049fd9a0490900c1c53b1ca66fe70af3691c372853c1928f2563342618fccc530bd9c6985f"} build_url:https://queue.taskcluster.net/v1/task/MQDhjE4DSC-qMfhU4Y6f9Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011396 build_url: 'https://queue.taskcluster.net/v1/task/MQDhjE4DSC-qMfhU4Y6f9Q/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/f5d3e52b30f8a05ff55ecb9865d83b442ac7aea00bd9e5777330290cc22afba2f2d3e6b0894233421f5891a596c9957762db23bb7ba5eb47f8cc2dba867fa4d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/36ee1c20e89ae4137bdfe06607ac722fc0dc342aeb3cf2b38cf29d049fd9a0490900c1c53b1ca66fe70af3691c372853c1928f2563342618fccc530bd9c6985f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-16 11:36:14.142572) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 11:36:14.142912) ========= 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.6SUHLDpPDA/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.DOoRtC8pZN/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005274 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 11:36:14.191750) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-16 11:36:14.192074) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-16 11:36:14.192456) ========= ========= Total master_lag: 0.29 =========