builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0074 starttime: 1460116557.42 results: success (0) buildid: 20160408030202 builduid: b274a7f4591046aeba4f115b51f3370e revision: d9b1a9829c8ee2862955043f28183efa07de3d2b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-08 04:55:57.423067) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-08 04:55:57.423513) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-08 04:55:57.423858) ========= 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.SWRcH3TuNp/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.n4sDCcOYsH/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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.005970 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-08 04:55:57.446640) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-08 04:55:57.446921) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-08 04:55:57.464031) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 04:55:57.464339) ========= 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.SWRcH3TuNp/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.n4sDCcOYsH/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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.005326 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 04:55:57.513897) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-08 04:55:57.514427) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-08 04:55:57.514797) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 04:55:57.515088) ========= 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.SWRcH3TuNp/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.n4sDCcOYsH/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-08 04:55:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 152M=0s 2016-04-08 04:55:57 (152 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.165796 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 04:55:57.696773) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 04:55:57.697120) ========= 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.SWRcH3TuNp/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.n4sDCcOYsH/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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.019950 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 04:55:57.745239) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-08 04:55:57.745616) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d9b1a9829c8ee2862955043f28183efa07de3d2b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev d9b1a9829c8ee2862955043f28183efa07de3d2b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SWRcH3TuNp/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.n4sDCcOYsH/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-08 04:55:57,923 truncating revision to first 12 chars 2016-04-08 04:55:57,924 Setting DEBUG logging. 2016-04-08 04:55:57,924 attempt 1/10 2016-04-08 04:55:57,924 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d9b1a9829c8e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-08 04:55:59,000 unpacking tar archive at: mozilla-central-d9b1a9829c8e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.328576 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-08 04:55:59.090166) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-08 04:55:59.093553) ========= echo d9b1a9829c8ee2862955043f28183efa07de3d2b in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'd9b1a9829c8ee2862955043f28183efa07de3d2b'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SWRcH3TuNp/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.n4sDCcOYsH/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 d9b1a9829c8ee2862955043f28183efa07de3d2b program finished with exit code 0 elapsedTime=0.005114 script_repo_revision: 'd9b1a9829c8ee2862955043f28183efa07de3d2b' ========= master_lag: 0.29 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-08 04:55:59.390203) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-08 04:55:59.393552) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-08 04:55:59.410300) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-04-08 04:55:59.410607) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SWRcH3TuNp/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.n4sDCcOYsH/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:55:59 INFO - MultiFileLogger online at 20160408 04:55:59 in /builds/slave/test 04:55:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:55:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:55:59 INFO - {'append_to_log': False, 04:55:59 INFO - 'base_work_dir': '/builds/slave/test', 04:55:59 INFO - 'blob_upload_branch': 'Firefox', 04:55:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:55:59 INFO - 'branch': 'Firefox', 04:55:59 INFO - 'buildbot_json_path': 'buildprops.json', 04:55:59 INFO - 'config_files': ('talos/mac_config.py',), 04:55:59 INFO - 'default_actions': ('clobber', 04:55:59 INFO - 'read-buildbot-config', 04:55:59 INFO - 'download-and-extract', 04:55:59 INFO - 'populate-webroot', 04:55:59 INFO - 'create-virtualenv', 04:55:59 INFO - 'install', 04:55:59 INFO - 'run-tests'), 04:55:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:55:59 INFO - 'download_minidump_stackwalk': True, 04:55:59 INFO - 'download_symbols': 'ondemand', 04:55:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:55:59 INFO - 'tooltool.py': '/tools/tooltool.py', 04:55:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:55:59 INFO - '/tools/misc-python/virtualenv.py')}, 04:55:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:55:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:55:59 INFO - 'installer_path': 'installer.exe', 04:55:59 INFO - 'log_level': 'info', 04:55:59 INFO - 'log_name': 'talos', 04:55:59 INFO - 'log_to_console': True, 04:55:59 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:55:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:55:59 INFO - 'opt_config_files': (), 04:55:59 INFO - 'pip_index': False, 04:55:59 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:55:59 INFO - 'cmd': ('bash', 04:55:59 INFO - '-c', 04:55:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:55:59 INFO - 'enabled': True, 04:55:59 INFO - 'halt_on_failure': False, 04:55:59 INFO - 'name': 'check_screen_resolution'},), 04:55:59 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:55:59 INFO - 'cmd': ('bash', 04:55:59 INFO - '-c', 04:55:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:55:59 INFO - 'enabled': True, 04:55:59 INFO - 'halt_on_failure': False, 04:55:59 INFO - 'name': 'check_screen_resolution'},), 04:55:59 INFO - 'run_cmd_checks_enabled': True, 04:55:59 INFO - 'sps_profile': False, 04:55:59 INFO - 'sps_profile_interval': 0, 04:55:59 INFO - 'suite': 'dromaeojs', 04:55:59 INFO - 'system_bits': '32', 04:55:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:55:59 INFO - 'title': 't-yosemite-r7-0074', 04:55:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:55:59 INFO - 'use_talos_json': True, 04:55:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:55:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:55:59 INFO - 'work_dir': 'build'} 04:55:59 INFO - ##### 04:55:59 INFO - ##### Running clobber step. 04:55:59 INFO - ##### 04:55:59 INFO - Running pre-action listener: _resource_record_pre_action 04:55:59 INFO - Running main action method: clobber 04:55:59 INFO - rmtree: /builds/slave/test/build 04:55:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:56:01 INFO - Running post-action listener: _resource_record_post_action 04:56:01 INFO - ##### 04:56:01 INFO - ##### Running read-buildbot-config step. 04:56:01 INFO - ##### 04:56:01 INFO - Running pre-action listener: _resource_record_pre_action 04:56:01 INFO - Running main action method: read_buildbot_config 04:56:01 INFO - Using buildbot properties: 04:56:01 INFO - { 04:56:01 INFO - "project": "", 04:56:01 INFO - "product": "firefox", 04:56:01 INFO - "script_repo_revision": "production", 04:56:01 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:56:01 INFO - "repository": "", 04:56:01 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:56:01 INFO - "buildid": "20160408030202", 04:56:01 INFO - "pgo_build": "False", 04:56:01 INFO - "basedir": "/builds/slave/test", 04:56:01 INFO - "buildnumber": 200, 04:56:01 INFO - "slavename": "t-yosemite-r7-0074", 04:56:01 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 04:56:01 INFO - "platform": "yosemite_r7", 04:56:01 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:56:01 INFO - "branch": "mozilla-central", 04:56:01 INFO - "repo_path": "mozilla-central", 04:56:01 INFO - "revision": "d9b1a9829c8ee2862955043f28183efa07de3d2b", 04:56:01 INFO - "stage_platform": "macosx64", 04:56:01 INFO - "builduid": "b274a7f4591046aeba4f115b51f3370e", 04:56:01 INFO - "slavebuilddir": "test" 04:56:01 INFO - } 04:56:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ruwyq2yrQ8ap6fYt0gl0ug/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 04:56:01 INFO - Running post-action listener: _resource_record_post_action 04:56:01 INFO - ##### 04:56:01 INFO - ##### Running download-and-extract step. 04:56:01 INFO - ##### 04:56:01 INFO - Running pre-action listener: _resource_record_pre_action 04:56:01 INFO - Running main action method: download_and_extract 04:56:01 INFO - mkdir: /builds/slave/test/build/tests 04:56:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:01 INFO - https://queue.taskcluster.net/v1/task/Ruwyq2yrQ8ap6fYt0gl0ug/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 04:56:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ruwyq2yrQ8ap6fYt0gl0ug/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 04:56:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ruwyq2yrQ8ap6fYt0gl0ug/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 04:56:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ruwyq2yrQ8ap6fYt0gl0ug/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 04:56:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ruwyq2yrQ8ap6fYt0gl0ug/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 04:56:03 INFO - Downloaded 1199 bytes. 04:56:03 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 04:56:03 INFO - Using the following test package requirements: 04:56:03 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 04:56:03 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:56:03 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 04:56:03 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:56:03 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 04:56:03 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:56:03 INFO - u'jsshell-mac.zip'], 04:56:03 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:56:03 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 04:56:03 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 04:56:03 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:56:03 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 04:56:03 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:56:03 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 04:56:03 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:56:03 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 04:56:03 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:56:03 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 04:56:03 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:56:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:03 INFO - https://queue.taskcluster.net/v1/task/Ruwyq2yrQ8ap6fYt0gl0ug/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:56:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ruwyq2yrQ8ap6fYt0gl0ug/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:56:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ruwyq2yrQ8ap6fYt0gl0ug/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:56:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ruwyq2yrQ8ap6fYt0gl0ug/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 04:56:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ruwyq2yrQ8ap6fYt0gl0ug/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 04:56:04 INFO - Downloaded 18014571 bytes. 04:56:04 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'] 04:56:04 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 04:56:08 INFO - Return code: 0 04:56:08 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 04:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:08 INFO - https://queue.taskcluster.net/v1/task/Ruwyq2yrQ8ap6fYt0gl0ug/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:56:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ruwyq2yrQ8ap6fYt0gl0ug/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:56:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ruwyq2yrQ8ap6fYt0gl0ug/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:56:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ruwyq2yrQ8ap6fYt0gl0ug/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 04:56:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ruwyq2yrQ8ap6fYt0gl0ug/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 04:56:09 INFO - Downloaded 18014571 bytes. 04:56:09 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'] 04:56:09 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 04:56:12 INFO - Return code: 0 04:56:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:12 INFO - https://queue.taskcluster.net/v1/task/Ruwyq2yrQ8ap6fYt0gl0ug/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:56:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ruwyq2yrQ8ap6fYt0gl0ug/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 04:56:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ruwyq2yrQ8ap6fYt0gl0ug/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 04:56:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ruwyq2yrQ8ap6fYt0gl0ug/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 04:56:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ruwyq2yrQ8ap6fYt0gl0ug/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 04:56:13 INFO - Downloaded 10841097 bytes. 04:56:13 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'] 04:56:13 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 04:56:14 INFO - Return code: 0 04:56:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:14 INFO - https://queue.taskcluster.net/v1/task/Ruwyq2yrQ8ap6fYt0gl0ug/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:56:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ruwyq2yrQ8ap6fYt0gl0ug/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:56:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ruwyq2yrQ8ap6fYt0gl0ug/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:56:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ruwyq2yrQ8ap6fYt0gl0ug/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 04:56:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ruwyq2yrQ8ap6fYt0gl0ug/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 04:56:17 INFO - Downloaded 108774200 bytes. 04:56:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ruwyq2yrQ8ap6fYt0gl0ug/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:56:17 INFO - mkdir: /builds/slave/test/properties 04:56:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:56:17 INFO - Writing to file /builds/slave/test/properties/build_url 04:56:17 INFO - Contents: 04:56:17 INFO - build_url:https://queue.taskcluster.net/v1/task/Ruwyq2yrQ8ap6fYt0gl0ug/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:56:18 INFO - Running post-action listener: _resource_record_post_action 04:56:18 INFO - Running post-action listener: set_extra_try_arguments 04:56:18 INFO - ##### 04:56:18 INFO - ##### Running populate-webroot step. 04:56:18 INFO - ##### 04:56:18 INFO - Running pre-action listener: _resource_record_pre_action 04:56:18 INFO - Running main action method: populate_webroot 04:56:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:56:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:56:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:56:18 INFO - '--tppagecycles', 04:56:18 INFO - '7'], 04:56:18 INFO - 'tests': ['tsvgm']}}, 04:56:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:56:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:56:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:56:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:56:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:56:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:56:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:18 INFO - 'talos_options': ['--disable-e10s'], 04:56:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:56:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:56:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:18 INFO - 'talos_options': ['--disable-e10s'], 04:56:18 INFO - 'tests': ['damp', 'tps']}, 04:56:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:18 INFO - 'tests': ['damp', 'tps']}, 04:56:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:56:18 INFO - 'tests': ['dromaeo_dom']}, 04:56:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:56:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:56:18 INFO - 'tests': ['a11yr', 04:56:18 INFO - 'ts_paint', 04:56:18 INFO - 'tpaint', 04:56:18 INFO - 'sessionrestore', 04:56:18 INFO - 'sessionrestore_no_auto_restore', 04:56:18 INFO - 'tabpaint']}, 04:56:18 INFO - 'other-e10s': {'tests': ['a11yr', 04:56:18 INFO - 'ts_paint', 04:56:18 INFO - 'tpaint', 04:56:18 INFO - 'sessionrestore', 04:56:18 INFO - 'sessionrestore_no_auto_restore', 04:56:18 INFO - 'tabpaint']}, 04:56:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:56:18 INFO - 'ts_paint', 04:56:18 INFO - 'tpaint', 04:56:18 INFO - 'sessionrestore', 04:56:18 INFO - 'sessionrestore_no_auto_restore', 04:56:18 INFO - 'tabpaint']}, 04:56:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:56:18 INFO - 'ts_paint', 04:56:18 INFO - 'tpaint', 04:56:18 INFO - 'sessionrestore', 04:56:18 INFO - 'sessionrestore_no_auto_restore', 04:56:18 INFO - 'tabpaint']}, 04:56:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:56:18 INFO - 'tests': ['a11yr', 04:56:18 INFO - 'ts_paint', 04:56:18 INFO - 'tpaint', 04:56:18 INFO - 'sessionrestore', 04:56:18 INFO - 'sessionrestore_no_auto_restore', 04:56:18 INFO - 'tabpaint']}, 04:56:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:56:18 INFO - 'tests': ['a11yr', 04:56:18 INFO - 'ts_paint', 04:56:18 INFO - 'tpaint', 04:56:18 INFO - 'sessionrestore', 04:56:18 INFO - 'sessionrestore_no_auto_restore', 04:56:18 INFO - 'tabpaint']}, 04:56:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:56:18 INFO - 'tests': ['tsvgx', 04:56:18 INFO - 'tsvgr_opacity', 04:56:18 INFO - 'tart', 04:56:18 INFO - 'tscrollx', 04:56:18 INFO - 'cart']}, 04:56:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:56:18 INFO - 'tsvgr_opacity', 04:56:18 INFO - 'tart', 04:56:18 INFO - 'tscrollx', 04:56:18 INFO - 'cart']}, 04:56:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:18 INFO - 'talos_options': ['--disable-e10s'], 04:56:18 INFO - 'tests': ['tp5o']}, 04:56:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:18 INFO - 'tests': ['tp5o']}, 04:56:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:18 INFO - 'talos_options': ['--disable-e10s', 04:56:18 INFO - '--xperf_path', 04:56:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:56:18 INFO - 'tests': ['tp5n']}, 04:56:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:18 INFO - 'talos_options': ['--xperf_path', 04:56:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:56:18 INFO - 'tests': ['tp5n']}}, 04:56:18 INFO - 'talos.zip': {'path': '', 04:56:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:56:18 INFO - Running post-action listener: _resource_record_post_action 04:56:18 INFO - ##### 04:56:18 INFO - ##### Running create-virtualenv step. 04:56:18 INFO - ##### 04:56:18 INFO - Running pre-action listener: _resource_record_pre_action 04:56:18 INFO - Running main action method: create_virtualenv 04:56:18 INFO - Creating virtualenv /builds/slave/test/build/venv 04:56:18 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:56:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:56:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:56:18 INFO - Using real prefix '/tools/python27' 04:56:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:56:19 INFO - Installing distribute.............................................................................................................................................................................................done. 04:56:22 INFO - Installing pip.................done. 04:56:22 INFO - Return code: 0 04:56:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:56:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:22 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 0x105cb9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cc9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9adb571120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b58e00>, '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 0x105981db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b53b20>, '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.SWRcH3TuNp/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.n4sDCcOYsH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:56:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:56:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:56:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SWRcH3TuNp/Render', 04:56:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:22 INFO - 'HOME': '/Users/cltbld', 04:56:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:22 INFO - 'LOGNAME': 'cltbld', 04:56:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:22 INFO - 'MOZ_NO_REMOTE': '1', 04:56:22 INFO - 'NO_EM_RESTART': '1', 04:56:22 INFO - 'PAGER': '/bin/cat', 04:56:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:22 INFO - 'PWD': '/builds/slave/test', 04:56:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:22 INFO - 'SHELL': '/bin/bash', 04:56:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n4sDCcOYsH/Listeners', 04:56:22 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 04:56:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:22 INFO - 'USER': 'cltbld', 04:56:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:22 INFO - 'XPC_FLAGS': '0x0', 04:56:22 INFO - 'XPC_SERVICE_NAME': '0', 04:56:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:56:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:22 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:56:22 INFO - Cleaning up... 04:56:22 INFO - Return code: 0 04:56:22 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:56:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:22 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 0x105cb9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cc9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9adb571120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b58e00>, '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 0x105981db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b53b20>, '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.SWRcH3TuNp/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.n4sDCcOYsH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:56:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:56:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:56:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SWRcH3TuNp/Render', 04:56:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:22 INFO - 'HOME': '/Users/cltbld', 04:56:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:22 INFO - 'LOGNAME': 'cltbld', 04:56:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:22 INFO - 'MOZ_NO_REMOTE': '1', 04:56:22 INFO - 'NO_EM_RESTART': '1', 04:56:22 INFO - 'PAGER': '/bin/cat', 04:56:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:22 INFO - 'PWD': '/builds/slave/test', 04:56:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:22 INFO - 'SHELL': '/bin/bash', 04:56:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n4sDCcOYsH/Listeners', 04:56:22 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 04:56:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:22 INFO - 'USER': 'cltbld', 04:56:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:22 INFO - 'XPC_FLAGS': '0x0', 04:56:22 INFO - 'XPC_SERVICE_NAME': '0', 04:56:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:56:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:22 INFO - Downloading/unpacking psutil>=0.7.1 04:56:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:56:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:56:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:56:25 INFO - Installing collected packages: psutil 04:56:25 INFO - Running setup.py install for psutil 04:56:25 INFO - building 'psutil._psutil_osx' extension 04:56:25 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:56:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:56:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:56:26 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:56:26 INFO - building 'psutil._psutil_posix' extension 04:56:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:56:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:56:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:56:26 INFO - ^ 04:56:26 INFO - 1 warning generated. 04:56:26 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:56:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:56:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:56:26 INFO - Successfully installed psutil 04:56:26 INFO - Cleaning up... 04:56:26 INFO - Return code: 0 04:56:26 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:56: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')]} 04:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56: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')]} 04:56:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:26 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 0x105cb9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cc9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9adb571120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b58e00>, '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 0x105981db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b53b20>, '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.SWRcH3TuNp/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.n4sDCcOYsH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:56:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:56:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:56:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SWRcH3TuNp/Render', 04:56:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:26 INFO - 'HOME': '/Users/cltbld', 04:56:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:26 INFO - 'LOGNAME': 'cltbld', 04:56:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:26 INFO - 'MOZ_NO_REMOTE': '1', 04:56:26 INFO - 'NO_EM_RESTART': '1', 04:56:26 INFO - 'PAGER': '/bin/cat', 04:56:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:26 INFO - 'PWD': '/builds/slave/test', 04:56:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:26 INFO - 'SHELL': '/bin/bash', 04:56:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n4sDCcOYsH/Listeners', 04:56:26 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 04:56:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:26 INFO - 'USER': 'cltbld', 04:56:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:26 INFO - 'XPC_FLAGS': '0x0', 04:56:26 INFO - 'XPC_SERVICE_NAME': '0', 04:56:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:56:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:26 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:29 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:56:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:56:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:56:29 INFO - Installing collected packages: mozsystemmonitor 04:56:29 INFO - Running setup.py install for mozsystemmonitor 04:56:29 INFO - Successfully installed mozsystemmonitor 04:56:29 INFO - Cleaning up... 04:56:29 INFO - Return code: 0 04:56:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:56:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:29 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 0x105cb9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cc9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9adb571120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b58e00>, '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 0x105981db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b53b20>, '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.SWRcH3TuNp/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.n4sDCcOYsH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:56:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:56:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:56:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SWRcH3TuNp/Render', 04:56:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:29 INFO - 'HOME': '/Users/cltbld', 04:56:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:29 INFO - 'LOGNAME': 'cltbld', 04:56:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:29 INFO - 'MOZ_NO_REMOTE': '1', 04:56:29 INFO - 'NO_EM_RESTART': '1', 04:56:29 INFO - 'PAGER': '/bin/cat', 04:56:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:29 INFO - 'PWD': '/builds/slave/test', 04:56:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:29 INFO - 'SHELL': '/bin/bash', 04:56:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n4sDCcOYsH/Listeners', 04:56:29 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 04:56:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:29 INFO - 'USER': 'cltbld', 04:56:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:29 INFO - 'XPC_FLAGS': '0x0', 04:56:29 INFO - 'XPC_SERVICE_NAME': '0', 04:56:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:56:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:29 INFO - Downloading/unpacking blobuploader==1.2.4 04:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:32 INFO - Downloading blobuploader-1.2.4.tar.gz 04:56:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:56:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:56:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:56:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:56:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:33 INFO - Downloading docopt-0.6.1.tar.gz 04:56:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:56:33 INFO - Installing collected packages: blobuploader, requests, docopt 04:56:33 INFO - Running setup.py install for blobuploader 04:56:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:56:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:56:33 INFO - Running setup.py install for requests 04:56:34 INFO - Running setup.py install for docopt 04:56:34 INFO - Successfully installed blobuploader requests docopt 04:56:34 INFO - Cleaning up... 04:56:34 INFO - Return code: 0 04:56:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:56: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')]} 04:56:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56: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')]} 04:56:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:34 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 0x105cb9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cc9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9adb571120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b58e00>, '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 0x105981db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b53b20>, '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.SWRcH3TuNp/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.n4sDCcOYsH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:56:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:56:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:56:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SWRcH3TuNp/Render', 04:56:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:34 INFO - 'HOME': '/Users/cltbld', 04:56:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:34 INFO - 'LOGNAME': 'cltbld', 04:56:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:34 INFO - 'MOZ_NO_REMOTE': '1', 04:56:34 INFO - 'NO_EM_RESTART': '1', 04:56:34 INFO - 'PAGER': '/bin/cat', 04:56:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:34 INFO - 'PWD': '/builds/slave/test', 04:56:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:34 INFO - 'SHELL': '/bin/bash', 04:56:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n4sDCcOYsH/Listeners', 04:56:34 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 04:56:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:34 INFO - 'USER': 'cltbld', 04:56:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:34 INFO - 'XPC_FLAGS': '0x0', 04:56:34 INFO - 'XPC_SERVICE_NAME': '0', 04:56:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:56:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:56:34 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-UM6NaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:56:34 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-3eKsTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:56:34 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-GYmPJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:56:35 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-UMLf3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:56:35 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-Kwa0TG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:56:35 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-LN8x1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:56:35 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-MH42St-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:56:35 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-8AQUoO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:56:35 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-_LhNQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:56:35 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-VxdnI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:56:35 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-vaVjY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:56:35 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-0rjnyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:56:35 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-Xlrcnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:56:36 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-D08adm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:56:36 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-UmbK4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:56:36 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-GlgR_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:56:36 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-jNM6Or-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:56:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:56:36 INFO - Running setup.py install for manifestparser 04:56:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:56:36 INFO - Running setup.py install for mozcrash 04:56:36 INFO - Running setup.py install for mozdebug 04:56:36 INFO - Running setup.py install for mozdevice 04:56:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:56:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:56:37 INFO - Running setup.py install for mozfile 04:56:37 INFO - Running setup.py install for mozhttpd 04:56:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:56:37 INFO - Running setup.py install for mozinfo 04:56:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:56:37 INFO - Running setup.py install for mozInstall 04:56:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:56:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:56:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:56:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:56:37 INFO - Running setup.py install for mozleak 04:56:37 INFO - Running setup.py install for mozlog 04:56:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:56:37 INFO - Running setup.py install for moznetwork 04:56:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:56:38 INFO - Running setup.py install for mozprocess 04:56:38 INFO - Running setup.py install for mozprofile 04:56:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:56:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:56:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:56:38 INFO - Running setup.py install for mozrunner 04:56:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:56:38 INFO - Running setup.py install for mozscreenshot 04:56:38 INFO - Running setup.py install for moztest 04:56:38 INFO - Running setup.py install for mozversion 04:56:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:56:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:56:38 INFO - Cleaning up... 04:56:38 INFO - Return code: 0 04:56:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:56: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')]} 04:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56: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')]} 04:56:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:38 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 0x105cb9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cc9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9adb571120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b58e00>, '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 0x105981db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b53b20>, '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.SWRcH3TuNp/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.n4sDCcOYsH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:56:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:56:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:56:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SWRcH3TuNp/Render', 04:56:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:38 INFO - 'HOME': '/Users/cltbld', 04:56:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:38 INFO - 'LOGNAME': 'cltbld', 04:56:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:38 INFO - 'MOZ_NO_REMOTE': '1', 04:56:38 INFO - 'NO_EM_RESTART': '1', 04:56:38 INFO - 'PAGER': '/bin/cat', 04:56:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:38 INFO - 'PWD': '/builds/slave/test', 04:56:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:38 INFO - 'SHELL': '/bin/bash', 04:56:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n4sDCcOYsH/Listeners', 04:56:38 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 04:56:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:38 INFO - 'USER': 'cltbld', 04:56:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:38 INFO - 'XPC_FLAGS': '0x0', 04:56:38 INFO - 'XPC_SERVICE_NAME': '0', 04:56:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:56:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:56:39 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-6vJkG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:56:39 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:56:39 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-l0kair-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:56:39 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)) 04:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:56:39 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-6sUIbt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:56:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:56:39 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-zoGa2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:56:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:56:39 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-5kYLIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:56:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:56:39 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-Yn0oSo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:56:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:56:39 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-YeJbGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:56:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:56:39 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-Qc_iCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:56:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:56:40 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-8OmFxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:56:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:56:40 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-iBq2tr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:56:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:56:40 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-CdVnzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:56:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:56:40 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-Hj8eXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:56:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:56:40 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-CAuqss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:56:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:56:40 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-rbDjqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:56:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:56:40 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-ZWTMic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:56:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:56:40 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-3vfyeC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:56:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:56:40 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-Lu97_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:56:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:56:41 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)) 04:56:41 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)) 04:56:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:56:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:56:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:56:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:56:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:43 INFO - Downloading blessings-1.6.tar.gz 04:56:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:56:43 INFO - Installing collected packages: blessings 04:56:43 INFO - Running setup.py install for blessings 04:56:43 INFO - Successfully installed blessings 04:56:43 INFO - Cleaning up... 04:56:43 INFO - Return code: 0 04:56:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:56:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:56:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:56:44 INFO - Reading from file tmpfile_stdout 04:56:44 INFO - Current package versions: 04:56:44 INFO - blessings == 1.6 04:56:44 INFO - blobuploader == 1.2.4 04:56:44 INFO - docopt == 0.6.1 04:56:44 INFO - manifestparser == 1.1 04:56:44 INFO - mozInstall == 1.12 04:56:44 INFO - mozcrash == 0.17 04:56:44 INFO - mozdebug == 0.1 04:56:44 INFO - mozdevice == 0.48 04:56:44 INFO - mozfile == 1.2 04:56:44 INFO - mozhttpd == 0.7 04:56:44 INFO - mozinfo == 0.9 04:56:44 INFO - mozleak == 0.1 04:56:44 INFO - mozlog == 3.1 04:56:44 INFO - moznetwork == 0.27 04:56:44 INFO - mozprocess == 0.22 04:56:44 INFO - mozprofile == 0.28 04:56:44 INFO - mozrunner == 6.11 04:56:44 INFO - mozscreenshot == 0.1 04:56:44 INFO - mozsystemmonitor == 0.0 04:56:44 INFO - moztest == 0.7 04:56:44 INFO - mozversion == 1.4 04:56:44 INFO - psutil == 3.1.1 04:56:44 INFO - requests == 1.2.3 04:56:44 INFO - wsgiref == 0.1.2 04:56:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:56:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:44 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 0x105cb9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cc9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9adb571120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b58e00>, '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 0x105981db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b53b20>, '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.SWRcH3TuNp/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.n4sDCcOYsH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:56:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:56:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:56:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SWRcH3TuNp/Render', 04:56:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:44 INFO - 'HOME': '/Users/cltbld', 04:56:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:44 INFO - 'LOGNAME': 'cltbld', 04:56:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:44 INFO - 'MOZ_NO_REMOTE': '1', 04:56:44 INFO - 'NO_EM_RESTART': '1', 04:56:44 INFO - 'PAGER': '/bin/cat', 04:56:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:44 INFO - 'PWD': '/builds/slave/test', 04:56:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:44 INFO - 'SHELL': '/bin/bash', 04:56:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n4sDCcOYsH/Listeners', 04:56:44 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 04:56:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:44 INFO - 'USER': 'cltbld', 04:56:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:44 INFO - 'XPC_FLAGS': '0x0', 04:56:44 INFO - 'XPC_SERVICE_NAME': '0', 04:56:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:56:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:56:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:56:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:56:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:56:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:56:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:56:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:56:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:56:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:56:44 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:56:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:56:44 INFO - Cleaning up... 04:56:44 INFO - Return code: 0 04:56:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:56:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:44 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 0x105cb9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cc9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9adb571120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b58e00>, '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 0x105981db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b53b20>, '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.SWRcH3TuNp/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.n4sDCcOYsH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:56:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:56:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:56:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SWRcH3TuNp/Render', 04:56:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:44 INFO - 'HOME': '/Users/cltbld', 04:56:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:44 INFO - 'LOGNAME': 'cltbld', 04:56:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:44 INFO - 'MOZ_NO_REMOTE': '1', 04:56:44 INFO - 'NO_EM_RESTART': '1', 04:56:44 INFO - 'PAGER': '/bin/cat', 04:56:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:44 INFO - 'PWD': '/builds/slave/test', 04:56:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:44 INFO - 'SHELL': '/bin/bash', 04:56:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n4sDCcOYsH/Listeners', 04:56:44 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 04:56:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:44 INFO - 'USER': 'cltbld', 04:56:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:44 INFO - 'XPC_FLAGS': '0x0', 04:56:44 INFO - 'XPC_SERVICE_NAME': '0', 04:56:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:56:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:44 INFO - Downloading/unpacking jsonschema 04:56: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 04:56: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 04:56: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 04:56: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 04:56: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 04:56: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 04:56:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:56:46 INFO - Downloading/unpacking functools32 (from jsonschema) 04:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:47 INFO - Downloading functools32-3.2.3-2.tar.gz 04:56:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:56:47 INFO - warning: no files found matching '*.txt' 04:56:47 INFO - no previously-included directories found matching 'build' 04:56:47 INFO - no previously-included directories found matching 'dist' 04:56:47 INFO - no previously-included directories found matching '.git*' 04:56:47 INFO - Installing collected packages: jsonschema, functools32 04:56:47 INFO - Running setup.py install for functools32 04:56:47 INFO - warning: no files found matching '*.txt' 04:56:47 INFO - no previously-included directories found matching 'build' 04:56:47 INFO - no previously-included directories found matching 'dist' 04:56:47 INFO - no previously-included directories found matching '.git*' 04:56:47 INFO - Successfully installed jsonschema functools32 04:56:47 INFO - Cleaning up... 04:56:47 INFO - Return code: 0 04:56:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:56:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:47 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 0x105cb9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cc9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9adb571120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b58e00>, '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 0x105981db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b53b20>, '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.SWRcH3TuNp/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.n4sDCcOYsH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:56:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:56:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:56:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SWRcH3TuNp/Render', 04:56:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:47 INFO - 'HOME': '/Users/cltbld', 04:56:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:47 INFO - 'LOGNAME': 'cltbld', 04:56:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:47 INFO - 'MOZ_NO_REMOTE': '1', 04:56:47 INFO - 'NO_EM_RESTART': '1', 04:56:47 INFO - 'PAGER': '/bin/cat', 04:56:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:47 INFO - 'PWD': '/builds/slave/test', 04:56:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:47 INFO - 'SHELL': '/bin/bash', 04:56:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n4sDCcOYsH/Listeners', 04:56:47 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 04:56:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:47 INFO - 'USER': 'cltbld', 04:56:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:47 INFO - 'XPC_FLAGS': '0x0', 04:56:47 INFO - 'XPC_SERVICE_NAME': '0', 04:56:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:56:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:47 INFO - Downloading/unpacking flake8 04:56:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:56:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:56:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:56:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:56:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:56:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:56:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:56:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:56:51 INFO - no previously-included directories found matching 'docs/_build' 04:56:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:56:51 INFO - Running setup.py install for pep8 04:56:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:56:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:56:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:56:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:56:51 INFO - no previously-included directories found matching 'docs/_build' 04:56:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:56:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:56:51 INFO - Cleaning up... 04:56:51 INFO - Return code: 0 04:56:51 INFO - Running post-action listener: _resource_record_post_action 04:56:51 INFO - Running post-action listener: _start_resource_monitoring 04:56:52 INFO - Starting resource monitoring. 04:56:52 INFO - ##### 04:56:52 INFO - ##### Running install step. 04:56:52 INFO - ##### 04:56:52 INFO - Running pre-action listener: _resource_record_pre_action 04:56:52 INFO - Running main action method: install 04:56:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:56:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:56:52 INFO - Reading from file tmpfile_stdout 04:56:52 INFO - Detecting whether we're running mozinstall >=1.0... 04:56:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:56:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:56:52 INFO - Reading from file tmpfile_stdout 04:56:52 INFO - Output received: 04:56:52 INFO - Usage: mozinstall [options] installer 04:56:52 INFO - Options: 04:56:52 INFO - -h, --help show this help message and exit 04:56:52 INFO - -d DEST, --destination=DEST 04:56:52 INFO - Directory to install application into. [default: 04:56:52 INFO - "/builds/slave/test"] 04:56:52 INFO - --app=APP Application being installed. [default: firefox] 04:56:52 INFO - mkdir: /builds/slave/test/build/application 04:56:52 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'] 04:56:52 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 04:57:25 INFO - Reading from file tmpfile_stdout 04:57:25 INFO - Output received: 04:57:25 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:57:25 INFO - Running post-action listener: _resource_record_post_action 04:57:25 INFO - ##### 04:57:25 INFO - ##### Running run-tests step. 04:57:25 INFO - ##### 04:57:25 INFO - Running pre-action listener: _resource_record_pre_action 04:57:25 INFO - Running main action method: run_tests 04:57:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:57:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:57:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:57:25 INFO - 2016-04-08 04:57:25.869 screenresolution[1946:14442] starting screenresolution argv=screenresolution get 04:57:25 INFO - 2016-04-08 04:57:25.871 screenresolution[1946:14442] Display 0: 1600x1200x32@60 04:57:25 INFO - 2016-04-08 04:57:25.876 screenresolution[1947:14444] starting screenresolution argv=screenresolution list 04:57:25 INFO - Available Modes on Display 0 04:57:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:57:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:57:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:57:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:57:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:57:26 INFO - Intel Iris: 04:57:26 INFO - Chipset Model: Intel Iris 04:57:26 INFO - Type: GPU 04:57:26 INFO - Bus: Built-In 04:57:26 INFO - VRAM (Dynamic, Max): 1536 MB 04:57:26 INFO - Vendor: Intel (0x8086) 04:57:26 INFO - Device ID: 0x0a2e 04:57:26 INFO - Revision ID: 0x0009 04:57:26 INFO - Displays: 04:57:26 INFO - Display: 04:57:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:57:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:57:26 INFO - Display Serial Number: 1600x1200 60 04:57:26 INFO - Main Display: Yes 04:57:26 INFO - Mirror: Off 04:57:26 INFO - Online: Yes 04:57:26 INFO - Rotation: Supported 04:57:26 INFO - Return code: 0 04:57:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:57:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:57:26 INFO - Python 2.7.3 04:57:26 INFO - Return code: 0 04:57:26 INFO - grabbing minidump binary from tooltool 04:57: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')]} 04:57:26 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 0x105b58e00>, '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 0x105981db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b53b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:57:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:57:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:57:26 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:57:26 INFO - Return code: 0 04:57:26 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:57:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:57:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:57:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:57:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:57:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:57:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:57:27 INFO - Return code: 0 04:57:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ruwyq2yrQ8ap6fYt0gl0ug/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0074', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:57:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ruwyq2yrQ8ap6fYt0gl0ug/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0074 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:57:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SWRcH3TuNp/Render', 04:57:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:57:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:57:27 INFO - 'HOME': '/Users/cltbld', 04:57:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:57:27 INFO - 'LOGNAME': 'cltbld', 04:57:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:57:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:57:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:27 INFO - 'MOZ_NO_REMOTE': '1', 04:57:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:57:27 INFO - 'NO_EM_RESTART': '1', 04:57:27 INFO - 'PAGER': '/bin/cat', 04:57:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:57:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:27 INFO - 'PWD': '/builds/slave/test', 04:57:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:57:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:57:27 INFO - 'SHELL': '/bin/bash', 04:57:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.n4sDCcOYsH/Listeners', 04:57:27 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 04:57:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:57:27 INFO - 'USER': 'cltbld', 04:57:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:57:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:57:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:27 INFO - 'XPC_FLAGS': '0x0', 04:57:27 INFO - 'XPC_SERVICE_NAME': '0', 04:57:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:57:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ruwyq2yrQ8ap6fYt0gl0ug/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0074', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:57:27 INFO - mozversion application_buildid: 20160408030202 04:57:27 INFO - mozversion application_changeset: d9b1a9829c8ee2862955043f28183efa07de3d2b 04:57:27 INFO - mozversion application_display_name: Nightly 04:57:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:57:27 INFO - mozversion application_name: Firefox 04:57:27 INFO - mozversion application_remotingname: firefox 04:57:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:57:27 INFO - mozversion application_vendor: Mozilla 04:57:27 INFO - mozversion application_version: 48.0a1 04:57:27 INFO - mozversion platform_buildid: 20160408030202 04:57:27 INFO - mozversion platform_changeset: d9b1a9829c8ee2862955043f28183efa07de3d2b 04:57:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:57:27 INFO - mozversion platform_version: 48.0a1 04:57:27 INFO - using testdate: 1460116647 04:57:27 INFO - actual date: 1460116647 04:57:27 INFO - starting webserver on 'localhost:49737' 04:57:27 INFO - SUITE-START | Running 2 tests 04:57:27 INFO - TEST-START | dromaeo_css 04:57:27 INFO - operating with platform_type : mac_ 04:57:27 INFO - Initialising browser for dromaeo_css test... 04:57:27 INFO - TEST-INFO | started process 1965 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/tmpnlkM_G/profile http://localhost:49737/getInfo.html) 04:57:29 INFO - PROCESS | 1965 | __metrics Screen width/height:1600/1200 04:57:29 INFO - PROCESS | 1965 | colorDepth:24 04:57:29 INFO - PROCESS | 1965 | Browser inner width/height: 1024/689 04:57:29 INFO - PROCESS | 1965 | __metrics 04:57:29 INFO - PROCESS | 1965 | 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" 04:57:29 ERROR - PROCESS | 1965 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:57:30 INFO - TEST-INFO | 1965: exit 0 04:57:30 INFO - Browser initialized. 04:57:30 INFO - Running cycle 1/1 for dromaeo_css test... 04:57:30 INFO - TEST-INFO | started process 1967 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/tmpnlkM_G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:57:42 INFO - PROCESS | 1967 | RSS: Main: 237277184 04:57:42 INFO - PROCESS | 1967 | 04:58:33 INFO - PROCESS | 1967 | 1460116713415 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:00:43 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49737/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49737/tests/dromaeo/cssquery-ext.html) 05:00:44 INFO - PROCESS | 1967 | RSS: Main: 322973696 05:00:44 INFO - PROCESS | 1967 | 05:03:47 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49737/tests/dromaeo/cssquery-ext.html (next: http://localhost:49737/tests/dromaeo/cssquery-jquery.html) 05:03:48 INFO - PROCESS | 1967 | RSS: Main: 379797504 05:03:48 INFO - PROCESS | 1967 | 05:06:50 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49737/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49737/tests/dromaeo/cssquery-mootools.html) 05:06:50 INFO - PROCESS | 1967 | RSS: Main: 378617856 05:06:50 INFO - PROCESS | 1967 | 05:09:52 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49737/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49737/tests/dromaeo/cssquery-prototype.html) 05:09:53 INFO - PROCESS | 1967 | RSS: Main: 341450752 05:09:53 INFO - PROCESS | 1967 | 05:12:56 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49737/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49737/tests/dromaeo/cssquery-yui.html) 05:12:57 INFO - PROCESS | 1967 | RSS: Main: 341467136 05:12:57 INFO - PROCESS | 1967 | 05:16:00 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49737/tests/dromaeo/cssquery-yui.html (next: http://localhost:49737/tests/dromaeo/cssquery-dojo.html) 05:16:00 INFO - PROCESS | 1967 | RSS: Main: 383623168 05:16:00 INFO - PROCESS | 1967 | 05:16:00 INFO - PROCESS | 1967 | __start_tp_report 05:16:00 INFO - PROCESS | 1967 | _x_x_mozilla_page_load 05:16:00 INFO - PROCESS | 1967 | _x_x_mozilla_page_load_details 05:16:00 INFO - PROCESS | 1967 | |i|pagename|runs| 05:16:00 INFO - PROCESS | 1967 | |0;dojo.html;2795.231311389368;3376.459766437369;3393.8303084845784;3406.727461803056;3460.4809278608204;5543.750531226095;5596.16057591361;5605.887882242353;5621.971890140544;5651.689157096358;4109.363048727445;5585.636933599313;5604.8038318658855;5616.269884914956;5621.381648018714;5073.365829271341;5079.009593129332;5114.053900028488;5182.455842136578;5182.844514664566;5123.795048198086;5182.818601348954;5185.896282074356;5194.298769666103;5202.531772140506;5149.922751158736;5169.043726910515;5211.270422140903;5219.42586315505;5234.319538459995;5177.637565370425;5244.554212891909;5259.184826351921;5259.421463638997;5315.946840531584;5034.09386310464;5109.489051094898;5153.3815942087185;5166.121759300928;5174.990876779029;5545.085060964976;5568.554515638739;5575.553955683536;5580.051391263495;5646.181303710939;6185.84535386619;6196.81409557714;6218.875622487571;6233.065040243954;6237.157983672191;5158.53573178412;6061.757529698807;6100.3995136355825;6242.15730876335;6248.843778905563;5767.423257674283;5779.682117483537;5787.334456537468;5794.62334948227;5840.8247752567495;6172.9074063889075;6235.900097825877;6256.405641464054;6272.843178920472;6296.087067375205;5932.19915311436;6075.574709770273;6102.389621759329;6104.786332478342;6139.921477737097;6174;6226.5641405101205;6234.812955611339;6247.375262473807;6250.343713910065;5220.451852555503;6170.598911070766;6191.040388739752;6200.751969921243;6205.6586887721605;6020.217371741645;6098.371716891094;6142.754289828356;6173.290071641819;6205.751769929152;4864.78108485119;4876.634252431082;4877.317175595419;4909.754512274372;4926.729029903318;4375.606195442426;4376.015396535754;4399.296112621965;4401.713888597231;4440.600345968878;5494.423085575957;5531.640443371168;5612.831615051555;5706.71466426677;5730.570207234474;6199.628022318585;6236.18929539157;6238.064290356483;6240.687965601702;6257.217847769029;4666.62666986647;5596;5654.660720356792;5684.204211410406;5696;4737.597304229179;5318.867028324323;5342.1452567589;5396.3524377075;5400.378956419983;6287.402696743802;6316;6322.683865806691;6328.335524770017;6337.176167098248;6224.688765561795;6227.96886015567;6243.625382477066;6255.655938923221;6277.780277690442;6110.012029148408;6248.781292654735;6282.623042617458;6308.747650093945;6314.905276420949;6091.939080609137;6153.600015998945;6159.106929495288;6162.352952939877;6171.105189747372;5585.636933599303;6111.602745821508;6228.22147231596;6231.470325022243;6249.687515624291;5837.445442682938;5959.791407300723;6005.429484198994;6090.969545152246;6107;6062.151298818081;6076.787312444043;6077.969610151921;6092.69536523181;6108.755649774137;5920.911186332122;5934.080217566284;5934.465898069195;5945.672987985702;5972.492338151305;5861;5957.940420595739;5970.492508136857;6119.2350956130485;6129.816105516842;5849.590528662953;5885.440883116268;5891.882162356815;5895.322037965689;5909.55678324136 05:16:00 INFO - PROCESS | 1967 | |1;ext.html;493.27488591770083;507.9384087257631;518.7613697699057;521.8538809133439;563.8421242052221;27962.161135165927;36983.89048328551;38219;38357.23285534291;38375.84872453831;40529;41071.58928410715;41186.38220426696;41317.17365652685;41359.96600084999;9457.716268511938;9666.613335466607;9669.661561845336;9671.177949874269;9675.903240967571;8660.527710289265;9033.683821066264;9356.017618150065;9485.620575176985;9520.000399957973;9614.80770384592;9658.613655453773;9677.661281855137;9679.661211857587;9694;9560;9611.567479463441;9635.90364096357;9653.806923861554;9663.17862981651;9520.476373799438;9630.807383852354;9641.325107242496;9646.951765241129;9656.179224765903;38917.61082389196;39359.40960885589;39507;39567.40648890269;39674.603253967376;3120.7503399727966;3318.1538707629643;3365.730741540671;3554.5379100717;3595.2449985503076;27428.177154685392;27551;27822.165335039983;28124.859375703196;28264.576031359546;2704.2157774245643;2730.7269273072734;2783.5407157818936;2809.508336041205;2866.426714657077;396089;396731;397220;397811;399781;47189.5281047192;57525.712371437876;58001.12998305029;58024.12963805546;58158.12762808561;61333.38666613277;61804.07293890595;66303;68055.65972170107;68102.65948670324;16115.516534503984;16250;16358;16401.671966560603;16457.91771041137;12528.436220370106;12657.556985505464;12670.049746269067;12671.239725616493;12695.873041269653;16556.089415082286;16592.585185370463;17273.65452690939;17371.73942390865;18761.968091755083;7705.3914795768715;7907.288344049063;7914.485558438683;7963.960180199062;7980.960095199487;867.2541614211773;946.4841661294473;947.8672985781996;953.952302384878;1051.8422236664408;25546.872265638554;29177.27056823554;29327.706722932926;29901.40197196044;30036.846131155915;773.8568364852521;957.7214418750906;1027.5222021759917;1040.661784919904;1069.8823129455754;14379.352929118215;14577.708445831237;14601.561953141423;14926.328315225841;14990.025648333041;589886.0505697444;607024;609590;609857.9507102525;612176;57843.42156578464;58766.41233587695;58841.823163537345;58877;58910.11634825481;1261.703499677575;1391.5199256256576;1401.1242973141786;1435.9353829077716;1445.2773613193403;21526.892365538697;24642;28161.014364497143;28808.567871481526;29726.554101688926;47114.293285600055;47124.76437617927;47866;47905.28142077802;48004.5199548;393438.0328098456;395962;396274;396817;397341;22869.428264293525;23527.882360588774;25749.485010300064;26069.087581934542;26382.736172638797;41278.79360603178;41503.169936601706;41963.7901810489;42460.575394245665;42765.35851962285;34586.654133458345;34648.653513464546;34909;35480.64519354773;35616;34213.31573368568;34277;34767;35403.29193416169;35590.28819423545;35833;36305.092372690895;36397.45403818998;36524.63475365212;36799.632003680694;30892.69107308988;32344.029679109666;33124.834375827966;33344.333113338085;33525.83237083799;22558.548829023657;22922.656160157276;23210.419739506648;23214.705279523343;23560.88219558891 05:16:00 INFO - PROCESS | 1967 | |2;jquery.html;380.27367727640205;382.17068960356016;389.81483795197283;393.55921368067766;399.2015968063872;19495.02524873756;21044.789552104474;21061.894690526526;21363.465913352156;21379.25172618959;19766.407007789752;19869;20611.175552977864;20653.070611822466;20695.482612934684;5622.156676498517;5709.800156994506;5942;5953.017752070903;5971.313298970609;5931.555133364994;5933.732982015819;5979.671118088503;5980.132880732292;5981.461668449839;5559.499645031946;5841.707914604274;5865;5868.589198756067;5882.294124705041;5773.562949738674;5817.185594016841;5819.127130930352;5841.094630332284;5850.268716410427;4460.219461594241;4957.3307603473795;5130.897382052338;5139.794408223666;5140.640155189139;24642.383940401633;24698.753012469824;25573.400735021263;25812.74187258141;25902.611460828102;2255.424866659008;2284.588774020676;2348.3072493614254;2380.833341666084;2410.866892560494;8041.59792010403;14199.645008874757;14550.563483095524;15080.849191508054;15098.54704358871;1713.8200488948605;1734.4016314371522;1739.2173521915188;1764;1834.5138538287365;123655.3817230917;130927.6907230925;131193.34403327922;132058.3397083018;133347.28387865043;11569.132315076235;11650.242734222249;11729.530818767324;11744.882551174549;11851.229670071418;15286.312115954808;15376.38494460209;15448.845511544965;15478;15491;8242.464239824392;8483.406161568631;8525.488470691778;8632.438891472035;8758.343124265706;6897.241303456616;8380.413371064089;8390.622421991025;8396.328293736486;8530.914690853137;4577.56513131252;4670;4697.13103075932;4729.385179926588;4744.95255047452;1657.7927759030122;1899.3447260695038;1950.892700901464;1967.5376286572643;2003.3188715836686;791.0625908298684;871.930245580352;902.7517432706059;923.2060428031887;1012.2155329619603;18843.434696959113;19525.414237572895;20611.8969405155;20686.965651717353;20822.687659685118;836.2891542189212;958.1999030809352;966.7873067925045;986.5609803637312;1025.4411345816548;10439.686809395731;10646.680599582025;10664;10674.78650426987;10681.252312338062;257857;644618;649052;658087;673351;111717;135501;139498.30250848885;141343;147707;998.5955687946393;1012.2104758288547;1033.188946676855;1045.5399624165343;1049.9737506562396;17737.37919172823;17914.01472919002;18131.274749009892;18294.90852545729;18696;43930.90172745707;45020;51767.2234916469;53348;54231.72884135554;65823;66062.66968665319;66247;66828.33171668416;78412.60793695995;7857.803554911173;8020.278174964281;8040.39697022714;8065.596720164086;8358;9543.711598934055;11463.770724585629;12001.219920705125;12039.879601204226;12423.440945157308;10689.23627601468;10944.452777361259;10994.450277486254;11139.533954194709;11144.442777860912;9473.478958657064;9880.308378413441;10458.63394781179;10460.633877814544;10676.946615266874;11048.613298534512;11052.834207486734;11072.280301780358;11084.16868734832;11138.108951283715;7870.29167374939;7945.880811787712;8004.27961483446;8010.399220058635;8257.710980115668;9846.113849753556;10945.507452164513;11234.269772464764;11234.494447750034;11286.379249141377 05:16:00 INFO - PROCESS | 1967 | |3;mootools.html;1406.94372225111;1584.2791529853919;1603.6231485600883;1851.5648822526705;1993.8604297699148;7859.6856125754975;8629.69796057138;8878.556072196381;8889.111088891124;8914.687985920486;8423.578821058953;8711.912880871205;8716.651333946651;8722.781930451742;8728.389012769108;2121.618108740426;2363.3028256664325;2409.915652952143;2448.2532827487607;2456.668349772776;2467.950640987179;2491.788198003172;2492.277239600514;2493.950120997579;2498.6876640419946;2403.0748161957686;2458.7787099161073;2461.7415171407015;2466.4573793765344;2466.6300054991716;2422.9151979680714;2435.756424357568;2449.6815413996064;2454.840435371695;2457.1768457566736;2342.039763696876;2346.7653234676395;2351.165336305604;2361.0791791201273;2363.9409014774596;8854.070322616162;8861.069587693264;8904.51025193614;8920.464772113693;8953.910460895373;5253.6322457428;5409.134538473864;5429.728513574306;5439.782408703647;5450.155225939986;3369.747268954838;3403.081168084628;3416.6620918196636;3470.236547959445;3482.5995010573856;934.173256667847;949.136285979762;952.3524003677496;960.9279304052154;973.2749101919045;11137.387443690593;11426.37154956477;11438.885611143865;11446.713832154179;11451.25566838153;4540.387047748512;4567.3377360282575;4634.513376095529;4714.882127946828;4724.858254252378;9061.728148155566;9070.682526111554;9082.18260356571;9086.727398178065;9091.045440228812;5259.868503287448;5262.60530460217;5272.446393128743;5282.577393808486;5301.310829592128;4213.47331583552;4387;4509.526995217958;4543.091381723669;4558.202314594932;3777.1879046005242;3808.1431677872256;3879.84480620772;3897.629725176104;3900.258950799339;1159.1827761428174;1198.748262864808;1201.7596480703894;1211.8606360268507;1217.6529689038582;1105.7622611138643;1135.9204855660025;1138.9772204555863;1280.238258236348;1369.0348304445342;7915.802104947423;8006.159353267823;8060.798480038046;8118.14759450261;8138.348932085419;501.34574380433884;508.14885067511767;517.1647788821102;518.2174915876977;519.7531172692941;6253.374662533801;6394.648294343763;6405.327440618668;6405.615663060231;6411;9830.508474576243;10631.52158152885;10781.08360789326;10786.78426431467;10797.24419290642;10229.795404091876;10497.160227181806;10719.088877445349;10770.138388928866;10773.407462589634;8099;8196.672133114727;8212.014558253048;8261;8265.504069755834;7890.9605451972375;7891.408144389308;8007.599620018859;8012.238837310446;8028.277455028841;9686;9780.168685661798;9890.060444257784;9898.257630677585;9931.950340248253;9719.319647624598;9882.567027780788;10130.949345253226;10137.543810528692;10301.9484902578;5595.524380427709;6394.808155755335;6662.167229096363;6940.7917762467205;6995.160580730345;8229.711960081368;8254.463459875089;8301.83396332058;8306.501609903184;8311.127331630092;7156.892646610409;7248.601326926859;7304;7416.0729908761405;7490.850182996419;7177.533460325062;7229.168645605612;7262.346388825031;7369.336759691653;7404.185539590749;7707.460477766503;7719.3052625264;7749.961250193938;7774.2614451627005;7774.650140743794;6967.860642787217;6988.126484189476;7029.929700702927;7042.366187043191;7044.436445084483;7059.470539709645;7137.429005679637;7218.819529511804;7219;7220.422366210585 05:16:00 INFO - PROCESS | 1967 | |4;prototype.html;313.2232064480089;316.97939633923795;322.9305699274656;325.99348013039753;328.1910091624146;4768.761561921903;4922.310876477296;5786.421357864217;5791.768329266834;5852.09806812786;5232;5693.231413759141;5775.971120144404;5776.913346299798;5777.133429985504;3371.5279860819505;4141.958580414187;4289.420928174688;4389.890252743683;4424.867253982386;4189.518205406372;4432.581573896355;4448.421705178338;4452.955470445303;4468.932966005513;3628.32875917956;3832.5975772543898;4044.373122166069;4432.534583868695;4447.1995040892625;4189.758479213637;4194.601512856289;4385.51759306476;4386.956130438687;4464.218761716703;3772.2832661794173;3782.394816829294;3803.410471376941;3803.5435747710176;3811;5539.169124631298;5541.889162216773;5543.1408131739245;5564.8052318169075;5574.86062848432;4813;5046.772895219724;5058.620603454719;5066.240063990394;5125;4968.925466118011;4976.925346119811;6005.909911351333;6014.75940962361;6031.909521357183;3469.9479507807405;4199.517055538591;4203.957960420387;4206;4222.894427639334;5224.134140735866;5730.36965933747;5754.510866576346;6117.134274046414;6374.776882809079;3896.6103389660807;4236.978815105905;4241.151769646083;4248.642003687983;4252.702310838274;3822.445745366962;4238.23711731885;4417.359482874966;4453.732776033448;4460.899674726099;3691.778493290411;4890.364252647204;4962.759310172457;5112.463191364927;5150.356205474316;5114.820981265638;6103.725332360054;6194.5354098442795;6231.4391704745885;6231.750729970841;1444.6821699226152;1472.3963175098158;1472.8527147285185;1473.5358362115899;1482.3848103037335;892.0499667853715;925.2135684667978;935.9344845860725;978.7308490165119;981.5533932060895;5751.424857514299;5771.192033115367;5810.941890581124;5812.680302583399;5820.417958204231;6444.325604874019;6451.806445806634;6458.545752614071;6463.7091330890225;6524.282328943812;5512.283403157644;5771.59598828078;5922.674252916131;5936.317323507766;5943.286805583358;3213.550102985584;3380.2056516718553;3403.7277017838514;3428.5885693716914;3441.9827900860837;5935.465808077293;6183.103449999725;6798.932010679929;6805.489588280899;6817.409384433883;5724.341700704389;5728;6072.21061262042;6305.369463053658;6576.177977752781;6397.456216221487;6708.127943367331;6795.38841504267;6802.931970680329;6805.523613347018;6474.2878283387845;6532.706028228836;6534.738610455529;6550.574212676161;6600.405963463311;6405.711742971671;6426.935730642634;6432.292447830641;6447.677616119269;6458.903116453163;6513.381228783258;6780.169204399498;6782.287859774653;6807.115075040213;6807.575076200509;3545.769524980868;4202.621764041251;4245.469316335458;4248.93776555861;4268.615824575803;5618.887622247614;5632;6043.939560604338;6462.547621666438;6500.122483464672;5162.741862906914;5424.833660762955;6265.248170219603;6284.4344009039405;6295.9370406297185;5526.41972592888;5680.602357834912;5862.67755273447;5989.730462129128;6206.33826042637;5282.47175282484;5863.296404431496;5982.46157845796;6137.60105593135;6156.722947467464;5435.429279925551;5960.672163031075;5969.73136208863;6258.624482531062;6262.279837818527;5323.653962492581;5920.555958303058;6124.785632502841;6137.662428566472;6139.109829074849 05:16:00 INFO - PROCESS | 1967 | |5;yui.html;649.5680372552252;677.6273049822596;697.3131465506478;721.8664547058795;755.7581573896352;14824.6293842654;15055.77416338753;15312.310946007443;15324.69350612987;15687.921560392182;14701.044432111905;14779.482718104868;14781.630459238524;14788.334524946376;14837.703245935074;707.723987644819;736.5065406177873;904.7331037343982;932.7668082979255;935.163029088965;901.8151278987792;937.5593471068587;938.3244064273712;938.9248860091176;942.4109931292942;974.990250097497;986.0189111833736;986.4081551069337;987.4914419074182;987.9456629885353;737.0970561062683;948.3882895532412;975.5805003848342;977.0620204603589;981.5730157381562;732.8351120997786;733.083645443196;734.7318228846433;737.049206523584;737.2590546500733;15363.615909602238;15409.763949570492;15431;15437.614059648486;15439.382424703112;12277.140600157993;12464.127511074228;12493.312867792269;12675.429605667767;12800.359982000862;10094.141997930185;10132.088112069949;10469;10518.737031574195;10566.31318964265;3504.0539054455407;3545.4150065239464;3600.4239321708665;3637.563492380905;3637.8181090945345;75334.62332688301;76935.23064769336;81856.59071704662;83202.58398707968;83219;9455.858162127573;9464.621415143318;9535.284853636005;9560.808783824285;9621.663241786504;20668.689969650466;22173.667394989086;22177.002034908466;22208;22226.444338891335;7274.418046556263;7395.260473952561;7438.181800001996;7483.989661395751;7636.389088872988;3632.9818350908076;3933.350997085506;4021.4168945503325;4075.3479443289525;4089.795510224477;3457.861685532601;3584.4981702561663;3591.317649646559;3593.137646964762;3594.98202508991;619.7799781077742;636.5766765101156;639.9200099987502;646.253577118429;657.2179106862914;473.65482031032036;568.5877738639454;579.8318487638622;591.5356445190505;602.4126476685196;7171.501069704981;7694.07671079474;7840.215978402114;7901.249381308767;8058.597070146587;502.21654219417826;559.1752165555773;572.8567858035491;582.6271186440681;603.477991537317;3669.5779985301497;3786.5266841644793;3862.6909847212155;3885.5337359516475;3943.171933893857;86218;87102.56448717717;87496;87543;88536.557317213;71964.64017679983;73615.89576156362;74534;74794.25205747981;75353.62323188459;48867.511324887004;50636.98726025459;58554.12168817386;64034;65683.99999999904;7574;8082.232187942136;8090.312323452573;8130.552819594743;8349.290310323691;41651.7917410411;42476.78761606172;43008.35487467628;43820.78089609532;43963.56036439595;56286.71856640854;56568.71715641396;57217.713911430175;57837.132443012546;58534;10741.319116345276;10795.352278863293;10827.242093053726;11049.944750276198;11125.998660120627;11981.700457488632;12060.095492838247;12066.095042871995;12080.456379463121;12794.232346059267;10744.140468762636;10809;10816.188785840935;10934.890651093387;11423.257488263236;11081.944590276997;11330.743920239545;11366.545338186379;11575.131865109983;11828.290302581872;11093.944530277297;11127.833082503606;11234;11501.884981150417;11687.123465739933;9441.669541566012;9481.857772133286;9586.90453201822;9672.806543869225;10019.298649094493;9563;9575.90424095778;9605.663801766905;9636.903630963601;9887.011298870344 05:16:00 INFO - PROCESS | 1967 | __end_tp_report 05:16:00 INFO - PROCESS | 1967 | __start_cc_report 05:16:00 INFO - PROCESS | 1967 | _x_x_mozilla_cycle_collect,1341 05:16:00 INFO - PROCESS | 1967 | __end_cc_report 05:16:00 INFO - PROCESS | 1967 | __startTimestamp1460117760311__endTimestamp 05:16:00 INFO - PROCESS | 1967 | 05:16:00 INFO - PROCESS | 1967 | ------- Summary: start ------- 05:16:00 INFO - PROCESS | 1967 | Number of tests: 6 05:16:00 INFO - PROCESS | 1967 | 05:16:00 INFO - PROCESS | 1967 | [#0] dojo.html Cycles:165 Average:5669.86 Median:5891.88 stddev:663.47 (11.3%) stddev-sans-first:626.01 05:16:00 INFO - PROCESS | 1967 | Values: 2795.2 3376.5 3393.8 3406.7 3460.5 5543.8 5596.2 5605.9 5622.0 5651.7 4109.4 5585.6 5604.8 5616.3 5621.4 5073.4 5079.0 5114.1 5182.5 5182.8 5123.8 5182.8 5185.9 5194.3 5202.5 5149.9 5169.0 5211.3 5219.4 5234.3 5177.6 5244.6 5259.2 5259.4 5315.9 5034.1 5109.5 5153.4 5166.1 5175.0 5545.1 5568.6 5575.6 5580.1 5646.2 6185.8 6196.8 6218.9 6233.1 6237.2 5158.5 6061.8 6100.4 6242.2 6248.8 5767.4 5779.7 5787.3 5794.6 5840.8 6172.9 6235.9 6256.4 6272.8 6296.1 5932.2 6075.6 6102.4 6104.8 6139.9 6174.0 6226.6 6234.8 6247.4 6250.3 5220.5 6170.6 6191.0 6200.8 6205.7 6020.2 6098.4 6142.8 6173.3 6205.8 4864.8 4876.6 4877.3 4909.8 4926.7 4375.6 4376.0 4399.3 4401.7 4440.6 5494.4 5531.6 5612.8 5706.7 5730.6 6199.6 6236.2 6238.1 6240.7 6257.2 4666.6 5596.0 5654.7 5684.2 5696.0 4737.6 5318.9 5342.1 5396.4 5400.4 6287.4 6316.0 6322.7 6328.3 6337.2 6224.7 6228.0 6243.6 6255.7 6277.8 6110.0 6248.8 6282.6 6308.7 6314.9 6091.9 6153.6 6159.1 6162.4 6171.1 5585.6 6111.6 6228.2 6231.5 6249.7 5837.4 5959.8 6005.4 6091.0 6107.0 6062.2 6076.8 6078.0 6092.7 6108.8 5920.9 5934.1 5934.5 5945.7 5972.5 5861.0 5957.9 5970.5 6119.2 6129.8 5849.6 5885.4 5891.9 5895.3 5909.6 05:16:00 INFO - PROCESS | 1967 | 05:16:00 INFO - PROCESS | 1967 | [#1] ext.html Cycles:180 Average:60599.35 Median:216398.72 stddev:127147.69 (58.8%) stddev-sans-first:127424.29 05:16:00 INFO - PROCESS | 1967 | Values: 493.3 507.9 518.8 521.9 563.8 27962.2 36983.9 38219.0 38357.2 38375.8 40529.0 41071.6 41186.4 41317.2 41360.0 9457.7 9666.6 9669.7 9671.2 9675.9 8660.5 9033.7 9356.0 9485.6 9520.0 9614.8 9658.6 9677.7 9679.7 9694.0 9560.0 9611.6 9635.9 9653.8 9663.2 9520.5 9630.8 9641.3 9647.0 9656.2 38917.6 39359.4 39507.0 39567.4 39674.6 3120.8 3318.2 3365.7 3554.5 3595.2 27428.2 27551.0 27822.2 28124.9 28264.6 2704.2 2730.7 2783.5 2809.5 2866.4 396089.0 396731.0 397220.0 397811.0 399781.0 47189.5 57525.7 58001.1 58024.1 58158.1 61333.4 61804.1 66303.0 68055.7 68102.7 16115.5 16250.0 16358.0 16401.7 16457.9 12528.4 12657.6 12670.0 12671.2 12695.9 16556.1 16592.6 17273.7 17371.7 18762.0 7705.4 7907.3 7914.5 7964.0 7981.0 867.3 946.5 947.9 954.0 1051.8 25546.9 29177.3 29327.7 29901.4 30036.8 773.9 957.7 1027.5 1040.7 1069.9 14379.4 14577.7 14601.6 14926.3 14990.0 589886.1 607024.0 609590.0 609858.0 612176.0 57843.4 58766.4 58841.8 58877.0 58910.1 1261.7 1391.5 1401.1 1435.9 1445.3 21526.9 24642.0 28161.0 28808.6 29726.6 47114.3 47124.8 47866.0 47905.3 48004.5 393438.0 395962.0 396274.0 396817.0 397341.0 22869.4 23527.9 25749.5 26069.1 26382.7 41278.8 41503.2 41963.8 42460.6 42765.4 34586.7 34648.7 34909.0 35480.6 35616.0 34213.3 34277.0 34767.0 35403.3 35590.3 35833.0 36305.1 36397.5 36524.6 36799.6 30892.7 32344.0 33124.8 33344.3 33525.8 22558.5 22922.7 23210.4 23214.7 23560.9 05:16:00 INFO - PROCESS | 1967 | 05:16:00 INFO - PROCESS | 1967 | [#2] jquery.html Cycles:180 Average:34609.68 Median:13526.63 stddev:100475.97 (742.8%) stddev-sans-first:100724.96 05:16:00 INFO - PROCESS | 1967 | Values: 380.3 382.2 389.8 393.6 399.2 19495.0 21044.8 21061.9 21363.5 21379.3 19766.4 19869.0 20611.2 20653.1 20695.5 5622.2 5709.8 5942.0 5953.0 5971.3 5931.6 5933.7 5979.7 5980.1 5981.5 5559.5 5841.7 5865.0 5868.6 5882.3 5773.6 5817.2 5819.1 5841.1 5850.3 4460.2 4957.3 5130.9 5139.8 5140.6 24642.4 24698.8 25573.4 25812.7 25902.6 2255.4 2284.6 2348.3 2380.8 2410.9 8041.6 14199.6 14550.6 15080.8 15098.5 1713.8 1734.4 1739.2 1764.0 1834.5 123655.4 130927.7 131193.3 132058.3 133347.3 11569.1 11650.2 11729.5 11744.9 11851.2 15286.3 15376.4 15448.8 15478.0 15491.0 8242.5 8483.4 8525.5 8632.4 8758.3 6897.2 8380.4 8390.6 8396.3 8530.9 4577.6 4670.0 4697.1 4729.4 4745.0 1657.8 1899.3 1950.9 1967.5 2003.3 791.1 871.9 902.8 923.2 1012.2 18843.4 19525.4 20611.9 20687.0 20822.7 836.3 958.2 966.8 986.6 1025.4 10439.7 10646.7 10664.0 10674.8 10681.3 257857.0 644618.0 649052.0 658087.0 673351.0 111717.0 135501.0 139498.3 141343.0 147707.0 998.6 1012.2 1033.2 1045.5 1050.0 17737.4 17914.0 18131.3 18294.9 18696.0 43930.9 45020.0 51767.2 53348.0 54231.7 65823.0 66062.7 66247.0 66828.3 78412.6 7857.8 8020.3 8040.4 8065.6 8358.0 9543.7 11463.8 12001.2 12039.9 12423.4 10689.2 10944.5 10994.5 11139.5 11144.4 9473.5 9880.3 10458.6 10460.6 10676.9 11048.6 11052.8 11072.3 11084.2 11138.1 7870.3 7945.9 8004.3 8010.4 8257.7 9846.1 10945.5 11234.3 11234.5 11286.4 05:16:00 INFO - PROCESS | 1967 | 05:16:00 INFO - PROCESS | 1967 | [#3] mootools.html Cycles:180 Average:5953.09 Median:5444.97 stddev:3182.97 (58.5%) stddev-sans-first:3173.56 05:16:00 INFO - PROCESS | 1967 | Values: 1406.9 1584.3 1603.6 1851.6 1993.9 7859.7 8629.7 8878.6 8889.1 8914.7 8423.6 8711.9 8716.7 8722.8 8728.4 2121.6 2363.3 2409.9 2448.3 2456.7 2468.0 2491.8 2492.3 2494.0 2498.7 2403.1 2458.8 2461.7 2466.5 2466.6 2422.9 2435.8 2449.7 2454.8 2457.2 2342.0 2346.8 2351.2 2361.1 2363.9 8854.1 8861.1 8904.5 8920.5 8953.9 5253.6 5409.1 5429.7 5439.8 5450.2 3369.7 3403.1 3416.7 3470.2 3482.6 934.2 949.1 952.4 960.9 973.3 11137.4 11426.4 11438.9 11446.7 11451.3 4540.4 4567.3 4634.5 4714.9 4724.9 9061.7 9070.7 9082.2 9086.7 9091.0 5259.9 5262.6 5272.4 5282.6 5301.3 4213.5 4387.0 4509.5 4543.1 4558.2 3777.2 3808.1 3879.8 3897.6 3900.3 1159.2 1198.7 1201.8 1211.9 1217.7 1105.8 1135.9 1139.0 1280.2 1369.0 7915.8 8006.2 8060.8 8118.1 8138.3 501.3 508.1 517.2 518.2 519.8 6253.4 6394.6 6405.3 6405.6 6411.0 9830.5 10631.5 10781.1 10786.8 10797.2 10229.8 10497.2 10719.1 10770.1 10773.4 8099.0 8196.7 8212.0 8261.0 8265.5 7891.0 7891.4 8007.6 8012.2 8028.3 9686.0 9780.2 9890.1 9898.3 9932.0 9719.3 9882.6 10130.9 10137.5 10301.9 5595.5 6394.8 6662.2 6940.8 6995.2 8229.7 8254.5 8301.8 8306.5 8311.1 7156.9 7248.6 7304.0 7416.1 7490.9 7177.5 7229.2 7262.3 7369.3 7404.2 7707.5 7719.3 7750.0 7774.3 7774.7 6967.9 6988.1 7029.9 7042.4 7044.4 7059.5 7137.4 7218.8 7219.0 7220.4 05:16:00 INFO - PROCESS | 1967 | 05:16:00 INFO - PROCESS | 1967 | [#4] prototype.html Cycles:180 Average:4998.10 Median:5656.30 stddev:1571.84 (27.8%) stddev-sans-first:1536.42 05:16:00 INFO - PROCESS | 1967 | Values: 313.2 317.0 322.9 326.0 328.2 4768.8 4922.3 5786.4 5791.8 5852.1 5232.0 5693.2 5776.0 5776.9 5777.1 3371.5 4142.0 4289.4 4389.9 4424.9 4189.5 4432.6 4448.4 4453.0 4468.9 3628.3 3832.6 4044.4 4432.5 4447.2 4189.8 4194.6 4385.5 4387.0 4464.2 3772.3 3782.4 3803.4 3803.5 3811.0 5539.2 5541.9 5543.1 5564.8 5574.9 4813.0 5046.8 5058.6 5066.2 5125.0 4968.9 4976.9 6005.9 6014.8 6031.9 3469.9 4199.5 4204.0 4206.0 4222.9 5224.1 5730.4 5754.5 6117.1 6374.8 3896.6 4237.0 4241.2 4248.6 4252.7 3822.4 4238.2 4417.4 4453.7 4460.9 3691.8 4890.4 4962.8 5112.5 5150.4 5114.8 6103.7 6194.5 6231.4 6231.8 1444.7 1472.4 1472.9 1473.5 1482.4 892.0 925.2 935.9 978.7 981.6 5751.4 5771.2 5810.9 5812.7 5820.4 6444.3 6451.8 6458.5 6463.7 6524.3 5512.3 5771.6 5922.7 5936.3 5943.3 3213.6 3380.2 3403.7 3428.6 3442.0 5935.5 6183.1 6798.9 6805.5 6817.4 5724.3 5728.0 6072.2 6305.4 6576.2 6397.5 6708.1 6795.4 6802.9 6805.5 6474.3 6532.7 6534.7 6550.6 6600.4 6405.7 6426.9 6432.3 6447.7 6458.9 6513.4 6780.2 6782.3 6807.1 6807.6 3545.8 4202.6 4245.5 4248.9 4268.6 5618.9 5632.0 6043.9 6462.5 6500.1 5162.7 5424.8 6265.2 6284.4 6295.9 5526.4 5680.6 5862.7 5989.7 6206.3 5282.5 5863.3 5982.5 6137.6 6156.7 5435.4 5960.7 5969.7 6258.6 6262.3 5323.7 5920.6 6124.8 6137.7 6139.1 05:16:00 INFO - PROCESS | 1967 | 05:16:00 INFO - PROCESS | 1967 | [#5] yui.html Cycles:180 Average:17229.75 Median:57527.42 stddev:23606.75 (41.0%) stddev-sans-first:23640.15 05:16:00 INFO - PROCESS | 1967 | Values: 649.6 677.6 697.3 721.9 755.8 14824.6 15055.8 15312.3 15324.7 15687.9 14701.0 14779.5 14781.6 14788.3 14837.7 707.7 736.5 904.7 932.8 935.2 901.8 937.6 938.3 938.9 942.4 975.0 986.0 986.4 987.5 987.9 737.1 948.4 975.6 977.1 981.6 732.8 733.1 734.7 737.0 737.3 15363.6 15409.8 15431.0 15437.6 15439.4 12277.1 12464.1 12493.3 12675.4 12800.4 10094.1 10132.1 10469.0 10518.7 10566.3 3504.1 3545.4 3600.4 3637.6 3637.8 75334.6 76935.2 81856.6 83202.6 83219.0 9455.9 9464.6 9535.3 9560.8 9621.7 20668.7 22173.7 22177.0 22208.0 22226.4 7274.4 7395.3 7438.2 7484.0 7636.4 3633.0 3933.4 4021.4 4075.3 4089.8 3457.9 3584.5 3591.3 3593.1 3595.0 619.8 636.6 639.9 646.3 657.2 473.7 568.6 579.8 591.5 602.4 7171.5 7694.1 7840.2 7901.2 8058.6 502.2 559.2 572.9 582.6 603.5 3669.6 3786.5 3862.7 3885.5 3943.2 86218.0 87102.6 87496.0 87543.0 88536.6 71964.6 73615.9 74534.0 74794.3 75353.6 48867.5 50637.0 58554.1 64034.0 65684.0 7574.0 8082.2 8090.3 8130.6 8349.3 41651.8 42476.8 43008.4 43820.8 43963.6 56286.7 56568.7 57217.7 57837.1 58534.0 10741.3 10795.4 10827.2 11049.9 11126.0 11981.7 12060.1 12066.1 12080.5 12794.2 10744.1 10809.0 10816.2 10934.9 11423.3 11081.9 11330.7 11366.5 11575.1 11828.3 11093.9 11127.8 11234.0 11501.9 11687.1 9441.7 9481.9 9586.9 9672.8 10019.3 9563.0 9575.9 9605.7 9636.9 9887.0 05:16:00 INFO - PROCESS | 1967 | -------- Summary: end -------- 05:16:00 INFO - PROCESS | 1967 | 05:16:00 INFO - TEST-INFO | 1967: exit 0 05:16:00 INFO - TEST-OK | dromaeo_css | took 1113308ms 05:16:00 INFO - TEST-START | kraken 05:16:00 INFO - operating with platform_type : mac_ 05:16:00 INFO - Initialising browser for kraken test... 05:16:00 INFO - TEST-INFO | started process 1970 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/tmpChjEfX/profile http://localhost:49737/getInfo.html) 05:16:03 INFO - PROCESS | 1970 | __metrics Screen width/height:1600/1200 05:16:03 INFO - PROCESS | 1970 | colorDepth:24 05:16:03 INFO - PROCESS | 1970 | Browser inner width/height: 1024/689 05:16:03 INFO - PROCESS | 1970 | __metrics 05:16:03 INFO - PROCESS | 1970 | 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" 05:16:03 ERROR - PROCESS | 1970 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:16:03 INFO - TEST-INFO | 1970: exit 0 05:16:03 INFO - Browser initialized. 05:16:03 INFO - Running cycle 1/1 for kraken test... 05:16:03 INFO - TEST-INFO | started process 1972 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/tmpChjEfX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:16:15 INFO - PROCESS | 1972 | RSS: Main: 237576192 05:16:15 INFO - PROCESS | 1972 | 05:16:18 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49737/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49737/tests/kraken/driver.html?testName=audio-beat-detection) 05:16:18 INFO - PROCESS | 1972 | RSS: Main: 283766784 05:16:18 INFO - PROCESS | 1972 | 05:16:21 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49737/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49737/tests/kraken/driver.html?testName=audio-dft) 05:16:22 INFO - PROCESS | 1972 | RSS: Main: 294318080 05:16:22 INFO - PROCESS | 1972 | 05:16:25 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49737/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49737/tests/kraken/driver.html?testName=audio-fft) 05:16:26 INFO - PROCESS | 1972 | RSS: Main: 280244224 05:16:26 INFO - PROCESS | 1972 | 05:16:28 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49737/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49737/tests/kraken/driver.html?testName=audio-oscillator) 05:16:28 INFO - PROCESS | 1972 | RSS: Main: 283459584 05:16:28 INFO - PROCESS | 1972 | 05:16:30 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49737/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49737/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:16:31 INFO - PROCESS | 1972 | RSS: Main: 283496448 05:16:31 INFO - PROCESS | 1972 | 05:16:34 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49737/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49737/tests/kraken/driver.html?testName=imaging-darkroom) 05:16:34 INFO - PROCESS | 1972 | RSS: Main: 283394048 05:16:34 INFO - PROCESS | 1972 | 05:16:37 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49737/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49737/tests/kraken/driver.html?testName=imaging-desaturate) 05:16:38 INFO - PROCESS | 1972 | RSS: Main: 283648000 05:16:38 INFO - PROCESS | 1972 | 05:16:41 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49737/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49737/tests/kraken/driver.html?testName=json-parse-financial) 05:16:41 INFO - PROCESS | 1972 | RSS: Main: 283918336 05:16:41 INFO - PROCESS | 1972 | 05:16:43 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49737/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49737/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:16:43 INFO - PROCESS | 1972 | RSS: Main: 318574592 05:16:43 INFO - PROCESS | 1972 | 05:16:45 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49737/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49737/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:16:46 INFO - PROCESS | 1972 | RSS: Main: 318443520 05:16:46 INFO - PROCESS | 1972 | 05:16:48 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49737/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49737/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:16:49 INFO - PROCESS | 1972 | RSS: Main: 324726784 05:16:49 INFO - PROCESS | 1972 | 05:16:51 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49737/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49737/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:16:52 INFO - PROCESS | 1972 | RSS: Main: 325763072 05:16:52 INFO - PROCESS | 1972 | 05:16:55 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49737/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49737/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:16:55 INFO - PROCESS | 1972 | RSS: Main: 325808128 05:16:55 INFO - PROCESS | 1972 | 05:16:57 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49737/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49737/tests/kraken/driver.html?testName=ai-astar) 05:16:58 INFO - PROCESS | 1972 | RSS: Main: 390320128 05:16:58 INFO - PROCESS | 1972 | 05:16:58 INFO - PROCESS | 1972 | __start_tp_report 05:16:58 INFO - PROCESS | 1972 | _x_x_mozilla_page_load 05:16:58 INFO - PROCESS | 1972 | _x_x_mozilla_page_load_details 05:16:58 INFO - PROCESS | 1972 | |i|pagename|runs| 05:16:58 INFO - PROCESS | 1972 | |0;ai-astar;113;110;112;113;113;113;119;108;109;110 05:16:58 INFO - PROCESS | 1972 | |1;audio-beat-detection;164;154;146;164;124;145;139;120;164;120 05:16:58 INFO - PROCESS | 1972 | |2;audio-dft;187;186;186;189;189;187;186;183;184;183 05:16:58 INFO - PROCESS | 1972 | |3;audio-fft;75;75;83;88;83;87;85;88;82;59 05:16:58 INFO - PROCESS | 1972 | |4;audio-oscillator;92;88;129;78;78;79;120;79;76;118 05:16:58 INFO - PROCESS | 1972 | |5;imaging-gaussian-blur;89;86;91;88;89;88;90;87;89;86 05:16:58 INFO - PROCESS | 1972 | |6;imaging-darkroom;95;94;93;95;94;95;95;95;95;95 05:16:58 INFO - PROCESS | 1972 | |7;imaging-desaturate;95;145;121;85;87;90;86;84;86;87 05:16:58 INFO - PROCESS | 1972 | |8;json-parse-financial;56;54;53;54;54;53;54;63;55;53 05:16:58 INFO - PROCESS | 1972 | |9;json-stringify-tinderbox;65;64;72;79;72;70;70;68;68;68 05:16:58 INFO - PROCESS | 1972 | |10;stanford-crypto-aes;84;84;84;85;84;86;111;111;112;90 05:16:58 INFO - PROCESS | 1972 | |11;stanford-crypto-ccm;144;142;141;143;150;139;140;141;140;140 05:16:58 INFO - PROCESS | 1972 | |12;stanford-crypto-pbkdf2;169;172;178;170;169;168;168;169;170;171 05:16:58 INFO - PROCESS | 1972 | |13;stanford-crypto-sha256-iterative;71;66;69;68;57;94;101;100;55;72 05:16:58 INFO - PROCESS | 1972 | __end_tp_report 05:16:58 INFO - PROCESS | 1972 | __start_cc_report 05:16:58 INFO - PROCESS | 1972 | _x_x_mozilla_cycle_collect,1280 05:16:58 INFO - PROCESS | 1972 | __end_cc_report 05:16:58 INFO - PROCESS | 1972 | __startTimestamp1460117818045__endTimestamp 05:16:58 INFO - PROCESS | 1972 | 05:16:58 INFO - PROCESS | 1972 | ------- Summary: start ------- 05:16:58 INFO - PROCESS | 1972 | Number of tests: 14 05:16:58 INFO - PROCESS | 1972 | 05:16:58 INFO - PROCESS | 1972 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:3.09 (2.7%) stddev-sans-first:3.26 05:16:58 INFO - PROCESS | 1972 | Values: 113.0 110.0 112.0 113.0 113.0 113.0 119.0 108.0 109.0 110.0 05:16:58 INFO - PROCESS | 1972 | 05:16:58 INFO - PROCESS | 1972 | [#1] audio-beat-detection Cycles:10 Average:144.00 Median:150.00 stddev:17.89 (11.9%) stddev-sans-first:17.46 05:16:58 INFO - PROCESS | 1972 | Values: 164.0 154.0 146.0 164.0 124.0 145.0 139.0 120.0 164.0 120.0 05:16:58 INFO - PROCESS | 1972 | 05:16:58 INFO - PROCESS | 1972 | [#2] audio-dft Cycles:10 Average:186.00 Median:186.50 stddev:2.16 (1.2%) stddev-sans-first:2.26 05:16:58 INFO - PROCESS | 1972 | Values: 187.0 186.0 186.0 189.0 189.0 187.0 186.0 183.0 184.0 183.0 05:16:58 INFO - PROCESS | 1972 | 05:16:58 INFO - PROCESS | 1972 | [#3] audio-fft Cycles:10 Average:80.50 Median:84.00 stddev:8.90 (10.6%) stddev-sans-first:9.21 05:16:58 INFO - PROCESS | 1972 | Values: 75.0 75.0 83.0 88.0 83.0 87.0 85.0 88.0 82.0 59.0 05:16:58 INFO - PROCESS | 1972 | 05:16:58 INFO - PROCESS | 1972 | [#4] audio-oscillator Cycles:10 Average:93.70 Median:78.50 stddev:20.55 (26.2%) stddev-sans-first:21.79 05:16:58 INFO - PROCESS | 1972 | Values: 92.0 88.0 129.0 78.0 78.0 79.0 120.0 79.0 76.0 118.0 05:16:58 INFO - PROCESS | 1972 | 05:16:58 INFO - PROCESS | 1972 | [#5] imaging-gaussian-blur Cycles:10 Average:88.30 Median:89.00 stddev:1.64 (1.8%) stddev-sans-first:1.72 05:16:58 INFO - PROCESS | 1972 | Values: 89.0 86.0 91.0 88.0 89.0 88.0 90.0 87.0 89.0 86.0 05:16:58 INFO - PROCESS | 1972 | 05:16:58 INFO - PROCESS | 1972 | [#6] imaging-darkroom Cycles:10 Average:94.60 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 05:16:58 INFO - PROCESS | 1972 | Values: 95.0 94.0 93.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 05:16:58 INFO - PROCESS | 1972 | 05:16:58 INFO - PROCESS | 1972 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:86.50 stddev:20.24 (23.4%) stddev-sans-first:21.46 05:16:58 INFO - PROCESS | 1972 | Values: 95.0 145.0 121.0 85.0 87.0 90.0 86.0 84.0 86.0 87.0 05:16:58 INFO - PROCESS | 1972 | 05:16:58 INFO - PROCESS | 1972 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:54.00 stddev:3.00 (5.6%) stddev-sans-first:3.15 05:16:58 INFO - PROCESS | 1972 | Values: 56.0 54.0 53.0 54.0 54.0 53.0 54.0 63.0 55.0 53.0 05:16:58 INFO - PROCESS | 1972 | 05:16:58 INFO - PROCESS | 1972 | [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:70.00 stddev:4.22 (6.0%) stddev-sans-first:4.14 05:16:58 INFO - PROCESS | 1972 | Values: 65.0 64.0 72.0 79.0 72.0 70.0 70.0 68.0 68.0 68.0 05:16:58 INFO - PROCESS | 1972 | 05:16:58 INFO - PROCESS | 1972 | [#10] stanford-crypto-aes Cycles:10 Average:93.10 Median:84.00 stddev:12.71 (15.1%) stddev-sans-first:13.05 05:16:58 INFO - PROCESS | 1972 | Values: 84.0 84.0 84.0 85.0 84.0 86.0 111.0 111.0 112.0 90.0 05:16:58 INFO - PROCESS | 1972 | 05:16:58 INFO - PROCESS | 1972 | [#11] stanford-crypto-ccm Cycles:10 Average:142.00 Median:141.50 stddev:3.20 (2.3%) stddev-sans-first:3.31 05:16:58 INFO - PROCESS | 1972 | Values: 144.0 142.0 141.0 143.0 150.0 139.0 140.0 141.0 140.0 140.0 05:16:58 INFO - PROCESS | 1972 | 05:16:58 INFO - PROCESS | 1972 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.40 Median:170.00 stddev:2.95 (1.7%) stddev-sans-first:3.09 05:16:58 INFO - PROCESS | 1972 | Values: 169.0 172.0 178.0 170.0 169.0 168.0 168.0 169.0 170.0 171.0 05:16:58 INFO - PROCESS | 1972 | 05:16:58 INFO - PROCESS | 1972 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.30 Median:68.50 stddev:16.92 (24.7%) stddev-sans-first:17.87 05:16:58 INFO - PROCESS | 1972 | Values: 71.0 66.0 69.0 68.0 57.0 94.0 101.0 100.0 55.0 72.0 05:16:58 INFO - PROCESS | 1972 | -------- Summary: end -------- 05:16:58 INFO - PROCESS | 1972 | 05:16:58 INFO - TEST-INFO | 1972: exit 0 05:16:58 INFO - TEST-OK | kraken | took 57993ms 05:16:58 INFO - SUITE-END | took 1171s 05:16:59 INFO - Completed test suite (00:19:31) 05:16:59 INFO - javascript benchmark 05:16:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2795.231311389368, 3376.459766437369, 3393.8303084845784, 3406.727461803056, 3460.4809278608204, 5543.750531226095, 5596.16057591361, 5605.887882242353, 5621.971890140544, 5651.689157096358, 4109.363048727445, 5585.636933599313, 5604.8038318658855, 5616.269884914956, 5621.381648018714, 5073.365829271341, 5079.009593129332, 5114.053900028488, 5182.455842136578, 5182.844514664566, 5123.795048198086, 5182.818601348954, 5185.896282074356, 5194.298769666103, 5202.531772140506, 5149.922751158736, 5169.043726910515, 5211.270422140903, 5219.42586315505, 5234.319538459995, 5177.637565370425, 5244.554212891909, 5259.184826351921, 5259.421463638997, 5315.946840531584, 5034.09386310464, 5109.489051094898, 5153.3815942087185, 5166.121759300928, 5174.990876779029, 5545.085060964976, 5568.554515638739, 5575.553955683536, 5580.051391263495, 5646.181303710939, 6185.84535386619, 6196.81409557714, 6218.875622487571, 6233.065040243954, 6237.157983672191, 5158.53573178412, 6061.757529698807, 6100.3995136355825, 6242.15730876335, 6248.843778905563, 5767.423257674283, 5779.682117483537, 5787.334456537468, 5794.62334948227, 5840.8247752567495, 6172.9074063889075, 6235.900097825877, 6256.405641464054, 6272.843178920472, 6296.087067375205, 5932.19915311436, 6075.574709770273, 6102.389621759329, 6104.786332478342, 6139.921477737097, 6174.0, 6226.5641405101205, 6234.812955611339, 6247.375262473807, 6250.343713910065, 5220.451852555503, 6170.598911070766, 6191.040388739752, 6200.751969921243, 6205.6586887721605, 6020.217371741645, 6098.371716891094, 6142.754289828356, 6173.290071641819, 6205.751769929152, 4864.78108485119, 4876.634252431082, 4877.317175595419, 4909.754512274372, 4926.729029903318, 4375.606195442426, 4376.015396535754, 4399.296112621965, 4401.713888597231, 4440.600345968878, 5494.423085575957, 5531.640443371168, 5612.831615051555, 5706.71466426677, 5730.570207234474, 6199.628022318585, 6236.18929539157, 6238.064290356483, 6240.687965601702, 6257.217847769029, 4666.62666986647, 5596.0, 5654.660720356792, 5684.204211410406, 5696.0, 4737.597304229179, 5318.867028324323, 5342.1452567589, 5396.3524377075, 5400.378956419983, 6287.402696743802, 6316.0, 6322.683865806691, 6328.335524770017, 6337.176167098248, 6224.688765561795, 6227.96886015567, 6243.625382477066, 6255.655938923221, 6277.780277690442, 6110.012029148408, 6248.781292654735, 6282.623042617458, 6308.747650093945, 6314.905276420949, 6091.939080609137, 6153.600015998945, 6159.106929495288, 6162.352952939877, 6171.105189747372, 5585.636933599303, 6111.602745821508, 6228.22147231596, 6231.470325022243, 6249.687515624291, 5837.445442682938, 5959.791407300723, 6005.429484198994, 6090.969545152246, 6107.0, 6062.151298818081, 6076.787312444043, 6077.969610151921, 6092.69536523181, 6108.755649774137, 5920.911186332122, 5934.080217566284, 5934.465898069195, 5945.672987985702, 5972.492338151305, 5861.0, 5957.940420595739, 5970.492508136857, 6119.2350956130485, 6129.816105516842, 5849.590528662953, 5885.440883116268, 5891.882162356815, 5895.322037965689, 5909.55678324136], "value": 5627.42717114878, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [493.27488591770083, 507.9384087257631, 518.7613697699057, 521.8538809133439, 563.8421242052221, 27962.161135165927, 36983.89048328551, 38219.0, 38357.23285534291, 38375.84872453831, 40529.0, 41071.58928410715, 41186.38220426696, 41317.17365652685, 41359.96600084999, 9457.716268511938, 9666.613335466607, 9669.661561845336, 9671.177949874269, 9675.903240967571, 8660.527710289265, 9033.683821066264, 9356.017618150065, 9485.620575176985, 9520.000399957973, 9614.80770384592, 9658.613655453773, 9677.661281855137, 9679.661211857587, 9694.0, 9560.0, 9611.567479463441, 9635.90364096357, 9653.806923861554, 9663.17862981651, 9520.476373799438, 9630.807383852354, 9641.325107242496, 9646.951765241129, 9656.179224765903, 38917.61082389196, 39359.40960885589, 39507.0, 39567.40648890269, 39674.603253967376, 3120.7503399727966, 3318.1538707629643, 3365.730741540671, 3554.5379100717, 3595.2449985503076, 27428.177154685392, 27551.0, 27822.165335039983, 28124.859375703196, 28264.576031359546, 2704.2157774245643, 2730.7269273072734, 2783.5407157818936, 2809.508336041205, 2866.426714657077, 396089.0, 396731.0, 397220.0, 397811.0, 399781.0, 47189.5281047192, 57525.712371437876, 58001.12998305029, 58024.12963805546, 58158.12762808561, 61333.38666613277, 61804.07293890595, 66303.0, 68055.65972170107, 68102.65948670324, 16115.516534503984, 16250.0, 16358.0, 16401.671966560603, 16457.91771041137, 12528.436220370106, 12657.556985505464, 12670.049746269067, 12671.239725616493, 12695.873041269653, 16556.089415082286, 16592.585185370463, 17273.65452690939, 17371.73942390865, 18761.968091755083, 7705.3914795768715, 7907.288344049063, 7914.485558438683, 7963.960180199062, 7980.960095199487, 867.2541614211773, 946.4841661294473, 947.8672985781996, 953.952302384878, 1051.8422236664408, 25546.872265638554, 29177.27056823554, 29327.706722932926, 29901.40197196044, 30036.846131155915, 773.8568364852521, 957.7214418750906, 1027.5222021759917, 1040.661784919904, 1069.8823129455754, 14379.352929118215, 14577.708445831237, 14601.561953141423, 14926.328315225841, 14990.025648333041, 589886.0505697444, 607024.0, 609590.0, 609857.9507102525, 612176.0, 57843.42156578464, 58766.41233587695, 58841.823163537345, 58877.0, 58910.11634825481, 1261.703499677575, 1391.5199256256576, 1401.1242973141786, 1435.9353829077716, 1445.2773613193403, 21526.892365538697, 24642.0, 28161.014364497143, 28808.567871481526, 29726.554101688926, 47114.293285600055, 47124.76437617927, 47866.0, 47905.28142077802, 48004.5199548, 393438.0328098456, 395962.0, 396274.0, 396817.0, 397341.0, 22869.428264293525, 23527.882360588774, 25749.485010300064, 26069.087581934542, 26382.736172638797, 41278.79360603178, 41503.169936601706, 41963.7901810489, 42460.575394245665, 42765.35851962285, 34586.654133458345, 34648.653513464546, 34909.0, 35480.64519354773, 35616.0, 34213.31573368568, 34277.0, 34767.0, 35403.29193416169, 35590.28819423545, 35833.0, 36305.092372690895, 36397.45403818998, 36524.63475365212, 36799.632003680694, 30892.69107308988, 32344.029679109666, 33124.834375827966, 33344.333113338085, 33525.83237083799, 22558.548829023657, 22922.656160157276, 23210.419739506648, 23214.705279523343, 23560.88219558891], "value": 18889.597501365206, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.27367727640205, 382.17068960356016, 389.81483795197283, 393.55921368067766, 399.2015968063872, 19495.02524873756, 21044.789552104474, 21061.894690526526, 21363.465913352156, 21379.25172618959, 19766.407007789752, 19869.0, 20611.175552977864, 20653.070611822466, 20695.482612934684, 5622.156676498517, 5709.800156994506, 5942.0, 5953.017752070903, 5971.313298970609, 5931.555133364994, 5933.732982015819, 5979.671118088503, 5980.132880732292, 5981.461668449839, 5559.499645031946, 5841.707914604274, 5865.0, 5868.589198756067, 5882.294124705041, 5773.562949738674, 5817.185594016841, 5819.127130930352, 5841.094630332284, 5850.268716410427, 4460.219461594241, 4957.3307603473795, 5130.897382052338, 5139.794408223666, 5140.640155189139, 24642.383940401633, 24698.753012469824, 25573.400735021263, 25812.74187258141, 25902.611460828102, 2255.424866659008, 2284.588774020676, 2348.3072493614254, 2380.833341666084, 2410.866892560494, 8041.59792010403, 14199.645008874757, 14550.563483095524, 15080.849191508054, 15098.54704358871, 1713.8200488948605, 1734.4016314371522, 1739.2173521915188, 1764.0, 1834.5138538287365, 123655.3817230917, 130927.6907230925, 131193.34403327922, 132058.3397083018, 133347.28387865043, 11569.132315076235, 11650.242734222249, 11729.530818767324, 11744.882551174549, 11851.229670071418, 15286.312115954808, 15376.38494460209, 15448.845511544965, 15478.0, 15491.0, 8242.464239824392, 8483.406161568631, 8525.488470691778, 8632.438891472035, 8758.343124265706, 6897.241303456616, 8380.413371064089, 8390.622421991025, 8396.328293736486, 8530.914690853137, 4577.56513131252, 4670.0, 4697.13103075932, 4729.385179926588, 4744.95255047452, 1657.7927759030122, 1899.3447260695038, 1950.892700901464, 1967.5376286572643, 2003.3188715836686, 791.0625908298684, 871.930245580352, 902.7517432706059, 923.2060428031887, 1012.2155329619603, 18843.434696959113, 19525.414237572895, 20611.8969405155, 20686.965651717353, 20822.687659685118, 836.2891542189212, 958.1999030809352, 966.7873067925045, 986.5609803637312, 1025.4411345816548, 10439.686809395731, 10646.680599582025, 10664.0, 10674.78650426987, 10681.252312338062, 257857.0, 644618.0, 649052.0, 658087.0, 673351.0, 111717.0, 135501.0, 139498.30250848885, 141343.0, 147707.0, 998.5955687946393, 1012.2104758288547, 1033.188946676855, 1045.5399624165343, 1049.9737506562396, 17737.37919172823, 17914.01472919002, 18131.274749009892, 18294.90852545729, 18696.0, 43930.90172745707, 45020.0, 51767.2234916469, 53348.0, 54231.72884135554, 65823.0, 66062.66968665319, 66247.0, 66828.33171668416, 78412.60793695995, 7857.803554911173, 8020.278174964281, 8040.39697022714, 8065.596720164086, 8358.0, 9543.711598934055, 11463.770724585629, 12001.219920705125, 12039.879601204226, 12423.440945157308, 10689.23627601468, 10944.452777361259, 10994.450277486254, 11139.533954194709, 11144.442777860912, 9473.478958657064, 9880.308378413441, 10458.63394781179, 10460.633877814544, 10676.946615266874, 11048.613298534512, 11052.834207486734, 11072.280301780358, 11084.16868734832, 11138.108951283715, 7870.29167374939, 7945.880811787712, 8004.27961483446, 8010.399220058635, 8257.710980115668, 9846.113849753556, 10945.507452164513, 11234.269772464764, 11234.494447750034, 11286.379249141377], "value": 9532.588427429031, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1406.94372225111, 1584.2791529853919, 1603.6231485600883, 1851.5648822526705, 1993.8604297699148, 7859.6856125754975, 8629.69796057138, 8878.556072196381, 8889.111088891124, 8914.687985920486, 8423.578821058953, 8711.912880871205, 8716.651333946651, 8722.781930451742, 8728.389012769108, 2121.618108740426, 2363.3028256664325, 2409.915652952143, 2448.2532827487607, 2456.668349772776, 2467.950640987179, 2491.788198003172, 2492.277239600514, 2493.950120997579, 2498.6876640419946, 2403.0748161957686, 2458.7787099161073, 2461.7415171407015, 2466.4573793765344, 2466.6300054991716, 2422.9151979680714, 2435.756424357568, 2449.6815413996064, 2454.840435371695, 2457.1768457566736, 2342.039763696876, 2346.7653234676395, 2351.165336305604, 2361.0791791201273, 2363.9409014774596, 8854.070322616162, 8861.069587693264, 8904.51025193614, 8920.464772113693, 8953.910460895373, 5253.6322457428, 5409.134538473864, 5429.728513574306, 5439.782408703647, 5450.155225939986, 3369.747268954838, 3403.081168084628, 3416.6620918196636, 3470.236547959445, 3482.5995010573856, 934.173256667847, 949.136285979762, 952.3524003677496, 960.9279304052154, 973.2749101919045, 11137.387443690593, 11426.37154956477, 11438.885611143865, 11446.713832154179, 11451.25566838153, 4540.387047748512, 4567.3377360282575, 4634.513376095529, 4714.882127946828, 4724.858254252378, 9061.728148155566, 9070.682526111554, 9082.18260356571, 9086.727398178065, 9091.045440228812, 5259.868503287448, 5262.60530460217, 5272.446393128743, 5282.577393808486, 5301.310829592128, 4213.47331583552, 4387.0, 4509.526995217958, 4543.091381723669, 4558.202314594932, 3777.1879046005242, 3808.1431677872256, 3879.84480620772, 3897.629725176104, 3900.258950799339, 1159.1827761428174, 1198.748262864808, 1201.7596480703894, 1211.8606360268507, 1217.6529689038582, 1105.7622611138643, 1135.9204855660025, 1138.9772204555863, 1280.238258236348, 1369.0348304445342, 7915.802104947423, 8006.159353267823, 8060.798480038046, 8118.14759450261, 8138.348932085419, 501.34574380433884, 508.14885067511767, 517.1647788821102, 518.2174915876977, 519.7531172692941, 6253.374662533801, 6394.648294343763, 6405.327440618668, 6405.615663060231, 6411.0, 9830.508474576243, 10631.52158152885, 10781.08360789326, 10786.78426431467, 10797.24419290642, 10229.795404091876, 10497.160227181806, 10719.088877445349, 10770.138388928866, 10773.407462589634, 8099.0, 8196.672133114727, 8212.014558253048, 8261.0, 8265.504069755834, 7890.9605451972375, 7891.408144389308, 8007.599620018859, 8012.238837310446, 8028.277455028841, 9686.0, 9780.168685661798, 9890.060444257784, 9898.257630677585, 9931.950340248253, 9719.319647624598, 9882.567027780788, 10130.949345253226, 10137.543810528692, 10301.9484902578, 5595.524380427709, 6394.808155755335, 6662.167229096363, 6940.7917762467205, 6995.160580730345, 8229.711960081368, 8254.463459875089, 8301.83396332058, 8306.501609903184, 8311.127331630092, 7156.892646610409, 7248.601326926859, 7304.0, 7416.0729908761405, 7490.850182996419, 7177.533460325062, 7229.168645605612, 7262.346388825031, 7369.336759691653, 7404.185539590749, 7707.460477766503, 7719.3052625264, 7749.961250193938, 7774.2614451627005, 7774.650140743794, 6967.860642787217, 6988.126484189476, 7029.929700702927, 7042.366187043191, 7044.436445084483, 7059.470539709645, 7137.429005679637, 7218.819529511804, 7219.0, 7220.422366210585], "value": 4744.153875990476, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.2232064480089, 316.97939633923795, 322.9305699274656, 325.99348013039753, 328.1910091624146, 4768.761561921903, 4922.310876477296, 5786.421357864217, 5791.768329266834, 5852.09806812786, 5232.0, 5693.231413759141, 5775.971120144404, 5776.913346299798, 5777.133429985504, 3371.5279860819505, 4141.958580414187, 4289.420928174688, 4389.890252743683, 4424.867253982386, 4189.518205406372, 4432.581573896355, 4448.421705178338, 4452.955470445303, 4468.932966005513, 3628.32875917956, 3832.5975772543898, 4044.373122166069, 4432.534583868695, 4447.1995040892625, 4189.758479213637, 4194.601512856289, 4385.51759306476, 4386.956130438687, 4464.218761716703, 3772.2832661794173, 3782.394816829294, 3803.410471376941, 3803.5435747710176, 3811.0, 5539.169124631298, 5541.889162216773, 5543.1408131739245, 5564.8052318169075, 5574.86062848432, 4813.0, 5046.772895219724, 5058.620603454719, 5066.240063990394, 5125.0, 4968.925466118011, 4976.925346119811, 6005.909911351333, 6014.75940962361, 6031.909521357183, 3469.9479507807405, 4199.517055538591, 4203.957960420387, 4206.0, 4222.894427639334, 5224.134140735866, 5730.36965933747, 5754.510866576346, 6117.134274046414, 6374.776882809079, 3896.6103389660807, 4236.978815105905, 4241.151769646083, 4248.642003687983, 4252.702310838274, 3822.445745366962, 4238.23711731885, 4417.359482874966, 4453.732776033448, 4460.899674726099, 3691.778493290411, 4890.364252647204, 4962.759310172457, 5112.463191364927, 5150.356205474316, 5114.820981265638, 6103.725332360054, 6194.5354098442795, 6231.4391704745885, 6231.750729970841, 1444.6821699226152, 1472.3963175098158, 1472.8527147285185, 1473.5358362115899, 1482.3848103037335, 892.0499667853715, 925.2135684667978, 935.9344845860725, 978.7308490165119, 981.5533932060895, 5751.424857514299, 5771.192033115367, 5810.941890581124, 5812.680302583399, 5820.417958204231, 6444.325604874019, 6451.806445806634, 6458.545752614071, 6463.7091330890225, 6524.282328943812, 5512.283403157644, 5771.59598828078, 5922.674252916131, 5936.317323507766, 5943.286805583358, 3213.550102985584, 3380.2056516718553, 3403.7277017838514, 3428.5885693716914, 3441.9827900860837, 5935.465808077293, 6183.103449999725, 6798.932010679929, 6805.489588280899, 6817.409384433883, 5724.341700704389, 5728.0, 6072.21061262042, 6305.369463053658, 6576.177977752781, 6397.456216221487, 6708.127943367331, 6795.38841504267, 6802.931970680329, 6805.523613347018, 6474.2878283387845, 6532.706028228836, 6534.738610455529, 6550.574212676161, 6600.405963463311, 6405.711742971671, 6426.935730642634, 6432.292447830641, 6447.677616119269, 6458.903116453163, 6513.381228783258, 6780.169204399498, 6782.287859774653, 6807.115075040213, 6807.575076200509, 3545.769524980868, 4202.621764041251, 4245.469316335458, 4248.93776555861, 4268.615824575803, 5618.887622247614, 5632.0, 6043.939560604338, 6462.547621666438, 6500.122483464672, 5162.741862906914, 5424.833660762955, 6265.248170219603, 6284.4344009039405, 6295.9370406297185, 5526.41972592888, 5680.602357834912, 5862.67755273447, 5989.730462129128, 6206.33826042637, 5282.47175282484, 5863.296404431496, 5982.46157845796, 6137.60105593135, 6156.722947467464, 5435.429279925551, 5960.672163031075, 5969.73136208863, 6258.624482531062, 6262.279837818527, 5323.653962492581, 5920.555958303058, 6124.785632502841, 6137.662428566472, 6139.109829074849], "value": 4492.366146916134, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [649.5680372552252, 677.6273049822596, 697.3131465506478, 721.8664547058795, 755.7581573896352, 14824.6293842654, 15055.77416338753, 15312.310946007443, 15324.69350612987, 15687.921560392182, 14701.044432111905, 14779.482718104868, 14781.630459238524, 14788.334524946376, 14837.703245935074, 707.723987644819, 736.5065406177873, 904.7331037343982, 932.7668082979255, 935.163029088965, 901.8151278987792, 937.5593471068587, 938.3244064273712, 938.9248860091176, 942.4109931292942, 974.990250097497, 986.0189111833736, 986.4081551069337, 987.4914419074182, 987.9456629885353, 737.0970561062683, 948.3882895532412, 975.5805003848342, 977.0620204603589, 981.5730157381562, 732.8351120997786, 733.083645443196, 734.7318228846433, 737.049206523584, 737.2590546500733, 15363.615909602238, 15409.763949570492, 15431.0, 15437.614059648486, 15439.382424703112, 12277.140600157993, 12464.127511074228, 12493.312867792269, 12675.429605667767, 12800.359982000862, 10094.141997930185, 10132.088112069949, 10469.0, 10518.737031574195, 10566.31318964265, 3504.0539054455407, 3545.4150065239464, 3600.4239321708665, 3637.563492380905, 3637.8181090945345, 75334.62332688301, 76935.23064769336, 81856.59071704662, 83202.58398707968, 83219.0, 9455.858162127573, 9464.621415143318, 9535.284853636005, 9560.808783824285, 9621.663241786504, 20668.689969650466, 22173.667394989086, 22177.002034908466, 22208.0, 22226.444338891335, 7274.418046556263, 7395.260473952561, 7438.181800001996, 7483.989661395751, 7636.389088872988, 3632.9818350908076, 3933.350997085506, 4021.4168945503325, 4075.3479443289525, 4089.795510224477, 3457.861685532601, 3584.4981702561663, 3591.317649646559, 3593.137646964762, 3594.98202508991, 619.7799781077742, 636.5766765101156, 639.9200099987502, 646.253577118429, 657.2179106862914, 473.65482031032036, 568.5877738639454, 579.8318487638622, 591.5356445190505, 602.4126476685196, 7171.501069704981, 7694.07671079474, 7840.215978402114, 7901.249381308767, 8058.597070146587, 502.21654219417826, 559.1752165555773, 572.8567858035491, 582.6271186440681, 603.477991537317, 3669.5779985301497, 3786.5266841644793, 3862.6909847212155, 3885.5337359516475, 3943.171933893857, 86218.0, 87102.56448717717, 87496.0, 87543.0, 88536.557317213, 71964.64017679983, 73615.89576156362, 74534.0, 74794.25205747981, 75353.62323188459, 48867.511324887004, 50636.98726025459, 58554.12168817386, 64034.0, 65683.99999999904, 7574.0, 8082.232187942136, 8090.312323452573, 8130.552819594743, 8349.290310323691, 41651.7917410411, 42476.78761606172, 43008.35487467628, 43820.78089609532, 43963.56036439595, 56286.71856640854, 56568.71715641396, 57217.713911430175, 57837.132443012546, 58534.0, 10741.319116345276, 10795.352278863293, 10827.242093053726, 11049.944750276198, 11125.998660120627, 11981.700457488632, 12060.095492838247, 12066.095042871995, 12080.456379463121, 12794.232346059267, 10744.140468762636, 10809.0, 10816.188785840935, 10934.890651093387, 11423.257488263236, 11081.944590276997, 11330.743920239545, 11366.545338186379, 11575.131865109983, 11828.290302581872, 11093.944530277297, 11127.833082503606, 11234.0, 11501.884981150417, 11687.123465739933, 9441.669541566012, 9481.857772133286, 9586.90453201822, 9672.806543869225, 10019.298649094493, 9563.0, 9575.90424095778, 9605.663801766905, 9636.903630963601, 9887.011298870344], "value": 6775.681267777855, "unit": "score"}], "name": "dromaeo_css", "value": 7259.302550621685, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 110.0, 112.0, 113.0, 113.0, 113.0, 119.0, 108.0, 109.0, 110.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 154.0, 146.0, 164.0, 124.0, 145.0, 139.0, 120.0, 164.0, 120.0], "value": 144.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 186.0, 186.0, 189.0, 189.0, 187.0, 186.0, 183.0, 184.0, 183.0], "value": 186.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 83.0, 88.0, 83.0, 87.0, 85.0, 88.0, 82.0, 59.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 88.0, 129.0, 78.0, 78.0, 79.0, 120.0, 79.0, 76.0, 118.0], "value": 93.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 91.0, 88.0, 89.0, 88.0, 90.0, 87.0, 89.0, 86.0], "value": 88.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 93.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 145.0, 121.0, 85.0, 87.0, 90.0, 86.0, 84.0, 86.0, 87.0], "value": 96.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 53.0, 54.0, 54.0, 53.0, 54.0, 63.0, 55.0, 53.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 72.0, 79.0, 72.0, 70.0, 70.0, 68.0, 68.0, 68.0], "value": 69.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 85.0, 84.0, 86.0, 111.0, 111.0, 112.0, 90.0], "value": 93.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 142.0, 141.0, 143.0, 150.0, 139.0, 140.0, 141.0, 140.0, 140.0], "value": 142.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 172.0, 178.0, 170.0, 169.0, 168.0, 168.0, 169.0, 170.0, 171.0], "value": 170.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 66.0, 69.0, 68.0, 57.0, 94.0, 101.0, 100.0, 55.0, 72.0], "value": 75.3, "unit": "score"}], "name": "kraken", "value": 1501.0, "alertThreshold": 2.0}]} 05:16:59 INFO - Return code: 0 05:16:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:16:59 ERROR - # TBPL SUCCESS # 05:16:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:16:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:16:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:16:59 INFO - 2016-04-08 05:16:59.356 screenresolution[1976:16484] starting screenresolution argv=screenresolution get 05:16:59 INFO - 2016-04-08 05:16:59.358 screenresolution[1976:16484] Display 0: 1600x1200x32@60 05:16:59 INFO - 2016-04-08 05:16:59.364 screenresolution[1977:16487] starting screenresolution argv=screenresolution list 05:16:59 INFO - Available Modes on Display 0 05:16:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:16:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:16:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:16:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:16:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:16:59 INFO - Intel Iris: 05:16:59 INFO - Chipset Model: Intel Iris 05:16:59 INFO - Type: GPU 05:16:59 INFO - Bus: Built-In 05:16:59 INFO - VRAM (Dynamic, Max): 1536 MB 05:16:59 INFO - Vendor: Intel (0x8086) 05:16:59 INFO - Device ID: 0x0a2e 05:16:59 INFO - Revision ID: 0x0009 05:16:59 INFO - Displays: 05:16:59 INFO - Display: 05:16:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:16:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:16:59 INFO - Display Serial Number: 1600x1200 60 05:16:59 INFO - Main Display: Yes 05:16:59 INFO - Mirror: Off 05:16:59 INFO - Online: Yes 05:16:59 INFO - Rotation: Supported 05:16:59 INFO - Return code: 0 05:16:59 INFO - Running post-action listener: _resource_record_post_action 05:16:59 INFO - Running post-run listener: _resource_record_post_run 05:17:00 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 360448; Write bytes: 693226496; Read time: 5; Write time: 2229 05:17:00 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 374831616; Write bytes: 368961024; Read time: 28173; Write time: 757 05:17:00 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 360448; Write bytes: 299238912; Read time: 5; Write time: 1423 05:17:00 INFO - Running post-run listener: _upload_blobber_files 05:17:00 INFO - Blob upload gear active. 05:17:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:17:00 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:17:00 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:17:00 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:17:01 INFO - (blobuploader) - INFO - Open directory for files ... 05:17:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:17:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:17:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:17:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:17:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:17:02 INFO - (blobuploader) - INFO - Done attempting. 05:17:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:17:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:17:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:17:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:17:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:17:03 INFO - (blobuploader) - INFO - Done attempting. 05:17:03 INFO - (blobuploader) - INFO - Iteration through files over. 05:17:03 INFO - Return code: 0 05:17:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:17:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:17:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8465a719b23534bbe91a5313d984e5894c2a8166677a42c723801f7c97b750f86d878a06cd4372151e0e73bc43a5120d2bbf7b464642dd7d31f49c1dc1460f75", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/df509545a50d15072186e13ec88098ee815323ccce74db5889a24665caa09f288c761f2a3ff762fc8ab8ad8d29594a56df94f678de7691421d34c84b1ae8c782"} 05:17:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:17:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:17:03 INFO - Contents: 05:17:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8465a719b23534bbe91a5313d984e5894c2a8166677a42c723801f7c97b750f86d878a06cd4372151e0e73bc43a5120d2bbf7b464642dd7d31f49c1dc1460f75", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/df509545a50d15072186e13ec88098ee815323ccce74db5889a24665caa09f288c761f2a3ff762fc8ab8ad8d29594a56df94f678de7691421d34c84b1ae8c782"} 05:17:03 INFO - Running post-run listener: copy_logs_to_upload_dir 05:17:03 INFO - Copying logs to upload dir... 05:17:03 INFO - mkdir: /builds/slave/test/build/upload/logs 05:17:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.885913 ========= master_lag: 2.58 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-04-08 05:17:05.876820) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-08 05:17:05.881655) ========= 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.SWRcH3TuNp/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.n4sDCcOYsH/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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/Firefox/sha512/8465a719b23534bbe91a5313d984e5894c2a8166677a42c723801f7c97b750f86d878a06cd4372151e0e73bc43a5120d2bbf7b464642dd7d31f49c1dc1460f75", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/df509545a50d15072186e13ec88098ee815323ccce74db5889a24665caa09f288c761f2a3ff762fc8ab8ad8d29594a56df94f678de7691421d34c84b1ae8c782"} build_url:https://queue.taskcluster.net/v1/task/Ruwyq2yrQ8ap6fYt0gl0ug/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011187 build_url: 'https://queue.taskcluster.net/v1/task/Ruwyq2yrQ8ap6fYt0gl0ug/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8465a719b23534bbe91a5313d984e5894c2a8166677a42c723801f7c97b750f86d878a06cd4372151e0e73bc43a5120d2bbf7b464642dd7d31f49c1dc1460f75", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/df509545a50d15072186e13ec88098ee815323ccce74db5889a24665caa09f288c761f2a3ff762fc8ab8ad8d29594a56df94f678de7691421d34c84b1ae8c782"}' ========= master_lag: 0.06 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-08 05:17:05.949057) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 05:17:05.949412) ========= 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.SWRcH3TuNp/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.n4sDCcOYsH/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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.004534 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 05:17:05.999407) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-08 05:17:06.000112) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-08 05:17:06.000469) ========= ========= Total master_lag: 3.09 =========