builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0013 starttime: 1457689222.87 results: success (0) buildid: 20160311003616 builduid: c711429cae614382ab5b04333c307de7 revision: 3bb19c9730afdd2501d08c88cd410fd04bd71c38 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 01:40:22.869694) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 01:40:22.870088) ========= ========= Started set props: basedir (results: 0, elapsed: 1 secs) (at 2016-03-11 01:40:22.870377) ========= 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.VnuCWPGHKv/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.nW2ZGFmwXJ/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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.005579 basedir: '/builds/slave/test' ========= master_lag: 1.10 ========= ========= Finished set props: basedir (results: 0, elapsed: 1 secs) (at 2016-03-11 01:40:23.975889) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 9 secs) (at 2016-03-11 01:40:23.976195) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 9 secs) (at 2016-03-11 01:40:33.472956) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 01:40:33.473247) ========= 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.VnuCWPGHKv/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.nW2ZGFmwXJ/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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.006268 ========= master_lag: 0.20 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 01:40:33.683551) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 01:40:33.683852) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 01:40:33.684234) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2016-03-11 01:40:33.684523) ========= 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.VnuCWPGHKv/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.nW2ZGFmwXJ/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-11 01:40:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.0M=0.001s 2016-03-11 01:40:33 (15.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.204867 ========= master_lag: 5.70 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2016-03-11 01:40:39.587347) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2016-03-11 01:40:39.587685) ========= 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.VnuCWPGHKv/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.nW2ZGFmwXJ/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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.031612 ========= master_lag: 3.31 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2016-03-11 01:40:42.933345) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 17 secs) (at 2016-03-11 01:40:42.933731) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3bb19c9730afdd2501d08c88cd410fd04bd71c38 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3bb19c9730afdd2501d08c88cd410fd04bd71c38 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VnuCWPGHKv/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.nW2ZGFmwXJ/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-11 01:40:43,045 truncating revision to first 12 chars 2016-03-11 01:40:43,045 Setting DEBUG logging. 2016-03-11 01:40:43,045 attempt 1/10 2016-03-11 01:40:43,045 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/3bb19c9730af?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-11 01:40:44,268 unpacking tar archive at: mozilla-aurora-3bb19c9730af/testing/mozharness/ program finished with exit code 0 elapsedTime=1.472691 ========= master_lag: 16.13 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 17 secs) (at 2016-03-11 01:41:00.531567) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 5 secs) (at 2016-03-11 01:41:00.531969) ========= echo 3bb19c9730afdd2501d08c88cd410fd04bd71c38 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'3bb19c9730afdd2501d08c88cd410fd04bd71c38'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VnuCWPGHKv/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.nW2ZGFmwXJ/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 3bb19c9730afdd2501d08c88cd410fd04bd71c38 program finished with exit code 0 elapsedTime=0.006074 script_repo_revision: '3bb19c9730afdd2501d08c88cd410fd04bd71c38' ========= master_lag: 5.59 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 5 secs) (at 2016-03-11 01:41:06.126742) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 17 secs) (at 2016-03-11 01:41:06.130151) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 17 secs) (at 2016-03-11 01:41:23.425423) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 42 secs) (at 2016-03-11 01:41:23.425730) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VnuCWPGHKv/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.nW2ZGFmwXJ/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 01:41:24 INFO - MultiFileLogger online at 20160311 01:41:24 in /builds/slave/test 01:41:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 01:41:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:41:24 INFO - {'append_to_log': False, 01:41:24 INFO - 'base_work_dir': '/builds/slave/test', 01:41:24 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 01:41:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:41:24 INFO - 'branch': 'Mozilla-Aurora', 01:41:24 INFO - 'buildbot_json_path': 'buildprops.json', 01:41:24 INFO - 'config_files': ('talos/mac_config.py',), 01:41:24 INFO - 'default_actions': ('clobber', 01:41:24 INFO - 'read-buildbot-config', 01:41:24 INFO - 'download-and-extract', 01:41:24 INFO - 'populate-webroot', 01:41:24 INFO - 'create-virtualenv', 01:41:24 INFO - 'install', 01:41:24 INFO - 'run-tests'), 01:41:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:41:24 INFO - 'download_minidump_stackwalk': True, 01:41:24 INFO - 'download_symbols': 'ondemand', 01:41:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:41:24 INFO - 'tooltool.py': '/tools/tooltool.py', 01:41:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:41:24 INFO - '/tools/misc-python/virtualenv.py')}, 01:41:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:41:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:41:24 INFO - 'installer_path': 'installer.exe', 01:41:24 INFO - 'log_level': 'info', 01:41:24 INFO - 'log_name': 'talos', 01:41:24 INFO - 'log_to_console': True, 01:41:24 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:41:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:41:24 INFO - 'opt_config_files': (), 01:41:24 INFO - 'pip_index': False, 01:41:24 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:41:24 INFO - 'cmd': ('bash', 01:41:24 INFO - '-c', 01:41:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:41:24 INFO - 'enabled': True, 01:41:24 INFO - 'halt_on_failure': False, 01:41:24 INFO - 'name': 'check_screen_resolution'},), 01:41:24 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:41:24 INFO - 'cmd': ('bash', 01:41:24 INFO - '-c', 01:41:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:41:24 INFO - 'enabled': True, 01:41:24 INFO - 'halt_on_failure': False, 01:41:24 INFO - 'name': 'check_screen_resolution'},), 01:41:24 INFO - 'run_cmd_checks_enabled': True, 01:41:24 INFO - 'sps_profile': False, 01:41:24 INFO - 'sps_profile_interval': 0, 01:41:24 INFO - 'suite': 'dromaeojs', 01:41:24 INFO - 'system_bits': '32', 01:41:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:41:24 INFO - 'title': 't-yosemite-r7-0013', 01:41:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:41:24 INFO - 'use_talos_json': True, 01:41:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:41:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:41:24 INFO - 'work_dir': 'build'} 01:41:24 INFO - ##### 01:41:24 INFO - ##### Running clobber step. 01:41:24 INFO - ##### 01:41:24 INFO - Running pre-action listener: _resource_record_pre_action 01:41:24 INFO - Running main action method: clobber 01:41:24 INFO - rmtree: /builds/slave/test/build 01:41:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:41:25 INFO - Running post-action listener: _resource_record_post_action 01:41:25 INFO - ##### 01:41:25 INFO - ##### Running read-buildbot-config step. 01:41:25 INFO - ##### 01:41:25 INFO - Running pre-action listener: _resource_record_pre_action 01:41:25 INFO - Running main action method: read_buildbot_config 01:41:25 INFO - Using buildbot properties: 01:41:25 INFO - { 01:41:25 INFO - "project": "", 01:41:25 INFO - "product": "firefox", 01:41:25 INFO - "script_repo_revision": "production", 01:41:25 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 01:41:25 INFO - "repository": "", 01:41:25 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 01:41:25 INFO - "buildid": "20160311003616", 01:41:25 INFO - "pgo_build": "False", 01:41:25 INFO - "basedir": "/builds/slave/test", 01:41:25 INFO - "buildnumber": 120, 01:41:25 INFO - "slavename": "t-yosemite-r7-0013", 01:41:25 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 01:41:25 INFO - "platform": "yosemite_r7", 01:41:25 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 01:41:25 INFO - "branch": "mozilla-aurora", 01:41:25 INFO - "repo_path": "releases/mozilla-aurora", 01:41:25 INFO - "revision": "3bb19c9730afdd2501d08c88cd410fd04bd71c38", 01:41:25 INFO - "stage_platform": "macosx64", 01:41:25 INFO - "builduid": "c711429cae614382ab5b04333c307de7", 01:41:25 INFO - "slavebuilddir": "test" 01:41:25 INFO - } 01:41:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/Wg-6U_9IR9y4kEbTbUTFAw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 01:41:25 INFO - Running post-action listener: _resource_record_post_action 01:41:25 INFO - ##### 01:41:25 INFO - ##### Running download-and-extract step. 01:41:25 INFO - ##### 01:41:25 INFO - Running pre-action listener: _resource_record_pre_action 01:41:25 INFO - Running main action method: download_and_extract 01:41:25 INFO - mkdir: /builds/slave/test/build/tests 01:41:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:41:25 INFO - https://queue.taskcluster.net/v1/task/Wg-6U_9IR9y4kEbTbUTFAw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 01:41:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wg-6U_9IR9y4kEbTbUTFAw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 01:41:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wg-6U_9IR9y4kEbTbUTFAw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 01:41:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wg-6U_9IR9y4kEbTbUTFAw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 01:41:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wg-6U_9IR9y4kEbTbUTFAw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json'}, attempt #1 01:41:27 INFO - Downloaded 1277 bytes. 01:41:27 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 01:41:27 INFO - Using the following test package requirements: 01:41:27 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 01:41:27 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 01:41:27 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 01:41:27 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 01:41:27 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 01:41:27 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 01:41:27 INFO - u'jsshell-mac.zip'], 01:41:27 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 01:41:27 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 01:41:27 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 01:41:27 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 01:41:27 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 01:41:27 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 01:41:27 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 01:41:27 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 01:41:27 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 01:41:27 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 01:41:27 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 01:41:27 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 01:41:27 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 01:41:27 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')]} 01:41:27 INFO - https://queue.taskcluster.net/v1/task/Wg-6U_9IR9y4kEbTbUTFAw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:41:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wg-6U_9IR9y4kEbTbUTFAw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 01:41:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wg-6U_9IR9y4kEbTbUTFAw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 01:41:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wg-6U_9IR9y4kEbTbUTFAw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 01:41:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wg-6U_9IR9y4kEbTbUTFAw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 01:41:31 INFO - Downloaded 17864988 bytes. 01:41:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:41:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 01:41:34 INFO - Return code: 0 01:41:34 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip', u'firefox-47.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 01:41: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')]} 01:41:34 INFO - https://queue.taskcluster.net/v1/task/Wg-6U_9IR9y4kEbTbUTFAw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:41:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wg-6U_9IR9y4kEbTbUTFAw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 01:41:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wg-6U_9IR9y4kEbTbUTFAw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 01:41:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wg-6U_9IR9y4kEbTbUTFAw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 01:41:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wg-6U_9IR9y4kEbTbUTFAw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 01:41:36 INFO - Downloaded 17864988 bytes. 01:41:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:41:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 01:41:39 INFO - Return code: 0 01:41:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:41:39 INFO - https://queue.taskcluster.net/v1/task/Wg-6U_9IR9y4kEbTbUTFAw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 01:41:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wg-6U_9IR9y4kEbTbUTFAw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 01:41:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wg-6U_9IR9y4kEbTbUTFAw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 01:41:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wg-6U_9IR9y4kEbTbUTFAw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip 01:41:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wg-6U_9IR9y4kEbTbUTFAw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip'}, attempt #1 01:41:43 INFO - Downloaded 10845161 bytes. 01:41:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:41:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 01:41:44 INFO - Return code: 0 01:41: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')]} 01:41:44 INFO - https://queue.taskcluster.net/v1/task/Wg-6U_9IR9y4kEbTbUTFAw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 01:41:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wg-6U_9IR9y4kEbTbUTFAw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 01:41:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wg-6U_9IR9y4kEbTbUTFAw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 01:41:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wg-6U_9IR9y4kEbTbUTFAw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 01:41:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wg-6U_9IR9y4kEbTbUTFAw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg'}, attempt #1 01:42:04 INFO - Downloaded 114973250 bytes. 01:42:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Wg-6U_9IR9y4kEbTbUTFAw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 01:42:04 INFO - mkdir: /builds/slave/test/properties 01:42:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:42:04 INFO - Writing to file /builds/slave/test/properties/build_url 01:42:04 INFO - Contents: 01:42:04 INFO - build_url:https://queue.taskcluster.net/v1/task/Wg-6U_9IR9y4kEbTbUTFAw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 01:42:05 INFO - Running post-action listener: _resource_record_post_action 01:42:05 INFO - Running post-action listener: set_extra_try_arguments 01:42:05 INFO - ##### 01:42:05 INFO - ##### Running populate-webroot step. 01:42:05 INFO - ##### 01:42:05 INFO - Running pre-action listener: _resource_record_pre_action 01:42:05 INFO - Running main action method: populate_webroot 01:42:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:42:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:42:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:42:05 INFO - '--tppagecycles', 01:42:05 INFO - '7'], 01:42:05 INFO - 'tests': ['tsvgm']}}, 01:42:05 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:42:05 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:42:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:42:05 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 01:42:05 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:42:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:42:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:42:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:42:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:42:05 INFO - 'talos_options': ['--e10s'], 01:42:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:42:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:42:05 INFO - 'tests': ['damp', 'tps']}, 01:42:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:42:05 INFO - 'talos_options': ['--e10s'], 01:42:05 INFO - 'tests': ['damp', 'tps']}, 01:42:05 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:42:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:42:05 INFO - 'other': {'tests': ['a11yr', 01:42:05 INFO - 'ts_paint', 01:42:05 INFO - 'tpaint', 01:42:05 INFO - 'sessionrestore', 01:42:05 INFO - 'sessionrestore_no_auto_restore', 01:42:05 INFO - 'tabpaint']}, 01:42:05 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:42:05 INFO - 'tests': ['a11yr', 01:42:05 INFO - 'ts_paint', 01:42:05 INFO - 'tpaint', 01:42:05 INFO - 'sessionrestore', 01:42:05 INFO - 'sessionrestore_no_auto_restore', 01:42:05 INFO - 'tabpaint']}, 01:42:05 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:42:05 INFO - 'tests': ['a11yr', 01:42:05 INFO - 'ts_paint', 01:42:05 INFO - 'tpaint', 01:42:05 INFO - 'sessionrestore', 01:42:05 INFO - 'sessionrestore_no_auto_restore', 01:42:05 INFO - 'tabpaint']}, 01:42:05 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:42:05 INFO - 'tests': ['a11yr', 01:42:05 INFO - 'ts_paint', 01:42:05 INFO - 'tpaint', 01:42:05 INFO - 'sessionrestore', 01:42:05 INFO - 'sessionrestore_no_auto_restore', 01:42:05 INFO - 'tabpaint']}, 01:42:05 INFO - 'other_l64': {'tests': ['a11yr', 01:42:05 INFO - 'ts_paint', 01:42:05 INFO - 'tpaint', 01:42:05 INFO - 'sessionrestore', 01:42:05 INFO - 'sessionrestore_no_auto_restore', 01:42:05 INFO - 'tabpaint']}, 01:42:05 INFO - 'other_nol64': {'tests': ['a11yr', 01:42:05 INFO - 'ts_paint', 01:42:05 INFO - 'tpaint', 01:42:05 INFO - 'sessionrestore', 01:42:05 INFO - 'sessionrestore_no_auto_restore', 01:42:05 INFO - 'tabpaint']}, 01:42:05 INFO - 'svgr': {'tests': ['tsvgx', 01:42:05 INFO - 'tsvgr_opacity', 01:42:05 INFO - 'tart', 01:42:05 INFO - 'tscrollx', 01:42:05 INFO - 'cart']}, 01:42:05 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:42:05 INFO - 'tests': ['tsvgx', 01:42:05 INFO - 'tsvgr_opacity', 01:42:05 INFO - 'tart', 01:42:05 INFO - 'tscrollx', 01:42:05 INFO - 'cart']}, 01:42:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:42:05 INFO - 'tests': ['tp5o']}, 01:42:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:42:05 INFO - 'talos_options': ['--e10s'], 01:42:05 INFO - 'tests': ['tp5o']}, 01:42:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:42:05 INFO - 'talos_options': ['--xperf_path', 01:42:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:42:05 INFO - 'tests': ['tp5n']}, 01:42:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:42:05 INFO - 'talos_options': ['--e10s', 01:42:05 INFO - '--xperf_path', 01:42:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:42:05 INFO - 'tests': ['tp5n']}}, 01:42:05 INFO - 'talos.zip': {'path': '', 01:42:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:42:05 INFO - Running post-action listener: _resource_record_post_action 01:42:05 INFO - ##### 01:42:05 INFO - ##### Running create-virtualenv step. 01:42:05 INFO - ##### 01:42:05 INFO - Running pre-action listener: _resource_record_pre_action 01:42:05 INFO - Running main action method: create_virtualenv 01:42:05 INFO - Creating virtualenv /builds/slave/test/build/venv 01:42:05 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 01:42:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:42:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:42:05 INFO - Using real prefix '/tools/python27' 01:42:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:42:06 INFO - Installing distribute.............................................................................................................................................................................................done. 01:42:08 INFO - Installing pip.................done. 01:42:08 INFO - Return code: 0 01:42:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:42: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')]} 01:42:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:42:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42: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')]} 01:42:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:42:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:08 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 0x10145da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014644c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f955b470f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101301d30>, '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 0x101165db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012f8b20>, '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.VnuCWPGHKv/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.nW2ZGFmwXJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 01:42:08 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 01:42:08 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 01:42:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VnuCWPGHKv/Render', 01:42:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:42:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:42:08 INFO - 'HOME': '/Users/cltbld', 01:42:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:42:08 INFO - 'LOGNAME': 'cltbld', 01:42:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:42:08 INFO - 'MOZ_NO_REMOTE': '1', 01:42:08 INFO - 'NO_EM_RESTART': '1', 01:42:08 INFO - 'PAGER': '/bin/cat', 01:42:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:42:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:42:08 INFO - 'PWD': '/builds/slave/test', 01:42:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:42:08 INFO - 'SHELL': '/bin/bash', 01:42:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nW2ZGFmwXJ/Listeners', 01:42:08 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 01:42:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:42:08 INFO - 'USER': 'cltbld', 01:42:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:42:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:42:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:42:08 INFO - 'XPC_FLAGS': '0x0', 01:42:08 INFO - 'XPC_SERVICE_NAME': '0', 01:42:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:42:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:42:09 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 01:42:09 INFO - Cleaning up... 01:42:09 INFO - Return code: 0 01:42:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:42:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:42:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:42:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:42:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10145da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014644c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f955b470f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101301d30>, '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 0x101165db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012f8b20>, '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.VnuCWPGHKv/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.nW2ZGFmwXJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 01:42:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 01:42:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 01:42:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VnuCWPGHKv/Render', 01:42:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:42:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:42:09 INFO - 'HOME': '/Users/cltbld', 01:42:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:42:09 INFO - 'LOGNAME': 'cltbld', 01:42:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:42:09 INFO - 'MOZ_NO_REMOTE': '1', 01:42:09 INFO - 'NO_EM_RESTART': '1', 01:42:09 INFO - 'PAGER': '/bin/cat', 01:42:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:42:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:42:09 INFO - 'PWD': '/builds/slave/test', 01:42:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:42:09 INFO - 'SHELL': '/bin/bash', 01:42:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nW2ZGFmwXJ/Listeners', 01:42:09 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 01:42:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:42:09 INFO - 'USER': 'cltbld', 01:42:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:42:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:42:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:42:09 INFO - 'XPC_FLAGS': '0x0', 01:42:09 INFO - 'XPC_SERVICE_NAME': '0', 01:42:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:42:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:42:09 INFO - Downloading/unpacking psutil>=0.7.1 01:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:42:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:42:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:42:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:42:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:42:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:42:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:42:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:42:11 INFO - Installing collected packages: psutil 01:42:11 INFO - Running setup.py install for psutil 01:42:11 INFO - building 'psutil._psutil_osx' extension 01:42:11 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 01:42:12 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 01:42:12 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 01:42:12 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 01:42:12 INFO - building 'psutil._psutil_posix' extension 01:42:12 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 01:42:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:42:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:42:12 INFO - ^ 01:42:12 INFO - 1 warning generated. 01:42:12 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 01:42:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:42:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:42:13 INFO - Successfully installed psutil 01:42:13 INFO - Cleaning up... 01:42:13 INFO - Return code: 0 01:42:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:42:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:42:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:42:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:42:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:42:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:13 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 0x10145da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014644c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f955b470f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101301d30>, '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 0x101165db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012f8b20>, '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.VnuCWPGHKv/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.nW2ZGFmwXJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 01:42:13 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 01:42:13 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 01:42:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VnuCWPGHKv/Render', 01:42:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:42:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:42:13 INFO - 'HOME': '/Users/cltbld', 01:42:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:42:13 INFO - 'LOGNAME': 'cltbld', 01:42:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:42:13 INFO - 'MOZ_NO_REMOTE': '1', 01:42:13 INFO - 'NO_EM_RESTART': '1', 01:42:13 INFO - 'PAGER': '/bin/cat', 01:42:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:42:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:42:13 INFO - 'PWD': '/builds/slave/test', 01:42:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:42:13 INFO - 'SHELL': '/bin/bash', 01:42:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nW2ZGFmwXJ/Listeners', 01:42:13 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 01:42:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:42:13 INFO - 'USER': 'cltbld', 01:42:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:42:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:42:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:42:13 INFO - 'XPC_FLAGS': '0x0', 01:42:13 INFO - 'XPC_SERVICE_NAME': '0', 01:42:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:42:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:42:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:42:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:42:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:42:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:42:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:42:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:42:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:42:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:42:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:42:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:42:15 INFO - Installing collected packages: mozsystemmonitor 01:42:15 INFO - Running setup.py install for mozsystemmonitor 01:42:15 INFO - Successfully installed mozsystemmonitor 01:42:15 INFO - Cleaning up... 01:42:16 INFO - Return code: 0 01:42:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:42:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:42:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:42:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:42:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:42:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10145da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014644c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f955b470f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101301d30>, '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 0x101165db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012f8b20>, '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.VnuCWPGHKv/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.nW2ZGFmwXJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 01:42:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:42:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:42:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VnuCWPGHKv/Render', 01:42:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:42:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:42:16 INFO - 'HOME': '/Users/cltbld', 01:42:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:42:16 INFO - 'LOGNAME': 'cltbld', 01:42:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:42:16 INFO - 'MOZ_NO_REMOTE': '1', 01:42:16 INFO - 'NO_EM_RESTART': '1', 01:42:16 INFO - 'PAGER': '/bin/cat', 01:42:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:42:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:42:16 INFO - 'PWD': '/builds/slave/test', 01:42:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:42:16 INFO - 'SHELL': '/bin/bash', 01:42:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nW2ZGFmwXJ/Listeners', 01:42:16 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 01:42:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:42:16 INFO - 'USER': 'cltbld', 01:42:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:42:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:42:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:42:16 INFO - 'XPC_FLAGS': '0x0', 01:42:16 INFO - 'XPC_SERVICE_NAME': '0', 01:42:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:42:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:42:16 INFO - Downloading/unpacking blobuploader==1.2.4 01:42:16 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 01:42:16 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 01:42:16 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 01:42:16 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 01:42:16 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 01:42:16 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 01:42:18 INFO - Downloading blobuploader-1.2.4.tar.gz 01:42:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:42:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:42:18 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 01:42:18 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 01:42:18 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 01:42:18 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 01:42:18 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 01:42:18 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 01:42:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:42:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:42:19 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 01:42:19 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 01:42:19 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 01:42:19 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 01:42:19 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 01:42:19 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 01:42:19 INFO - Downloading docopt-0.6.1.tar.gz 01:42:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:42:19 INFO - Installing collected packages: blobuploader, requests, docopt 01:42:19 INFO - Running setup.py install for blobuploader 01:42:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:42:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:42:20 INFO - Running setup.py install for requests 01:42:20 INFO - Running setup.py install for docopt 01:42:20 INFO - Successfully installed blobuploader requests docopt 01:42:20 INFO - Cleaning up... 01:42:20 INFO - Return code: 0 01:42:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:42:20 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')]} 01:42:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:42:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:20 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')]} 01:42:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:42:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:20 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 0x10145da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014644c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f955b470f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101301d30>, '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 0x101165db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012f8b20>, '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.VnuCWPGHKv/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.nW2ZGFmwXJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 01:42:20 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 01:42:20 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 01:42:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VnuCWPGHKv/Render', 01:42:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:42:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:42:20 INFO - 'HOME': '/Users/cltbld', 01:42:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:42:20 INFO - 'LOGNAME': 'cltbld', 01:42:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:42:20 INFO - 'MOZ_NO_REMOTE': '1', 01:42:20 INFO - 'NO_EM_RESTART': '1', 01:42:20 INFO - 'PAGER': '/bin/cat', 01:42:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:42:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:42:20 INFO - 'PWD': '/builds/slave/test', 01:42:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:42:20 INFO - 'SHELL': '/bin/bash', 01:42:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nW2ZGFmwXJ/Listeners', 01:42:20 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 01:42:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:42:20 INFO - 'USER': 'cltbld', 01:42:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:42:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:42:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:42:20 INFO - 'XPC_FLAGS': '0x0', 01:42:20 INFO - 'XPC_SERVICE_NAME': '0', 01:42:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:42:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:42:21 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-4dA3d9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:42:21 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-2RNMcS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:42:21 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-mDzL7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:42:21 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-hX5NkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:42:21 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-jnmJDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:42:21 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-3wONNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:42:21 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-2Q6Z3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:42:21 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-9ImtXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:42:21 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-62bMm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:42:22 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-lx50Qj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:42:22 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-vazU3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:42:22 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-9OmOIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:42:22 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-hNs0JX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:42:22 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-FsI058-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:42:22 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-a8sU5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:42:22 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-1GlH_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:42:22 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-77TVmq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:42:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:42:22 INFO - Running setup.py install for manifestparser 01:42:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:42:22 INFO - Running setup.py install for mozcrash 01:42:23 INFO - Running setup.py install for mozdebug 01:42:23 INFO - Running setup.py install for mozdevice 01:42:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:42:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:42:23 INFO - Running setup.py install for mozfile 01:42:23 INFO - Running setup.py install for mozhttpd 01:42:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:42:23 INFO - Running setup.py install for mozinfo 01:42:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:42:23 INFO - Running setup.py install for mozInstall 01:42:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:42:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:42:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:42:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:42:23 INFO - Running setup.py install for mozleak 01:42:24 INFO - Running setup.py install for mozlog 01:42:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:42:24 INFO - Running setup.py install for moznetwork 01:42:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:42:24 INFO - Running setup.py install for mozprocess 01:42:24 INFO - Running setup.py install for mozprofile 01:42:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:42:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:42:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:42:24 INFO - Running setup.py install for mozrunner 01:42:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:42:24 INFO - Running setup.py install for mozscreenshot 01:42:25 INFO - Running setup.py install for moztest 01:42:25 INFO - Running setup.py install for mozversion 01:42:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:42:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:42:25 INFO - Cleaning up... 01:42:25 INFO - Return code: 0 01:42:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:42:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:42:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:42:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:42:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:42:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:25 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 0x10145da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014644c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f955b470f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101301d30>, '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 0x101165db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012f8b20>, '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.VnuCWPGHKv/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.nW2ZGFmwXJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 01:42:25 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 01:42:25 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 01:42:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VnuCWPGHKv/Render', 01:42:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:42:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:42:25 INFO - 'HOME': '/Users/cltbld', 01:42:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:42:25 INFO - 'LOGNAME': 'cltbld', 01:42:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:42:25 INFO - 'MOZ_NO_REMOTE': '1', 01:42:25 INFO - 'NO_EM_RESTART': '1', 01:42:25 INFO - 'PAGER': '/bin/cat', 01:42:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:42:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:42:25 INFO - 'PWD': '/builds/slave/test', 01:42:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:42:25 INFO - 'SHELL': '/bin/bash', 01:42:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nW2ZGFmwXJ/Listeners', 01:42:25 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 01:42:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:42:25 INFO - 'USER': 'cltbld', 01:42:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:42:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:42:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:42:25 INFO - 'XPC_FLAGS': '0x0', 01:42:25 INFO - 'XPC_SERVICE_NAME': '0', 01:42:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:42:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:42:25 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-nokY9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:42:25 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)) 01:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:42:25 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-Oejvvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:42:25 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)) 01:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:42:25 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-dIaH72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:42:25 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)) 01:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:42:26 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-O2eevY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:42:26 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)) 01:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:42:26 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-IjDbZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:42:26 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)) 01:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:42:26 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-nfpzi_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:42:26 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)) 01:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:42:26 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-LP8PV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:42:26 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)) 01:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:42:26 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-n8bM6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:42:26 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)) 01:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:42:26 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-XxyVmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:42:26 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)) 01:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:42:26 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-j3ud6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:42:26 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)) 01:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:42:26 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-46aHWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:42:26 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)) 01:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:42:26 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-iEr5bs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:42:26 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)) 01:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:42:26 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-ep3UnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:42:27 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)) 01:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:42:27 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-nnoLub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:42:27 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)) 01:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:42:27 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-ZXsPHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:42:27 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)) 01:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:42:27 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-U7AUWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:42:27 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)) 01:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:42:27 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-p9XmJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:42:27 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)) 01:42:27 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)) 01:42:27 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)) 01:42:27 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)) 01:42:27 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)) 01:42:27 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)) 01:42:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:42:27 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 01:42:27 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 01:42:27 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 01:42:27 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 01:42:27 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 01:42:27 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 01:42:29 INFO - Downloading blessings-1.6.tar.gz 01:42:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:42:29 INFO - Installing collected packages: blessings 01:42:29 INFO - Running setup.py install for blessings 01:42:30 INFO - Successfully installed blessings 01:42:30 INFO - Cleaning up... 01:42:30 INFO - Return code: 0 01:42:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:42:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:42:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:42:30 INFO - Reading from file tmpfile_stdout 01:42:30 INFO - Current package versions: 01:42:30 INFO - blessings == 1.6 01:42:30 INFO - blobuploader == 1.2.4 01:42:30 INFO - docopt == 0.6.1 01:42:30 INFO - manifestparser == 1.1 01:42:30 INFO - mozInstall == 1.12 01:42:30 INFO - mozcrash == 0.17 01:42:30 INFO - mozdebug == 0.1 01:42:30 INFO - mozdevice == 0.48 01:42:30 INFO - mozfile == 1.2 01:42:30 INFO - mozhttpd == 0.7 01:42:30 INFO - mozinfo == 0.9 01:42:30 INFO - mozleak == 0.1 01:42:30 INFO - mozlog == 3.1 01:42:30 INFO - moznetwork == 0.27 01:42:30 INFO - mozprocess == 0.22 01:42:30 INFO - mozprofile == 0.28 01:42:30 INFO - mozrunner == 6.11 01:42:30 INFO - mozscreenshot == 0.1 01:42:30 INFO - mozsystemmonitor == 0.0 01:42:30 INFO - moztest == 0.7 01:42:30 INFO - mozversion == 1.4 01:42:30 INFO - psutil == 3.1.1 01:42:30 INFO - requests == 1.2.3 01:42:30 INFO - wsgiref == 0.1.2 01:42:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:42:30 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')]} 01:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:42:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:30 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')]} 01:42:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:42:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:30 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 0x10145da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014644c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f955b470f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101301d30>, '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 0x101165db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012f8b20>, '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.VnuCWPGHKv/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.nW2ZGFmwXJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 01:42:30 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 01:42:30 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 01:42:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VnuCWPGHKv/Render', 01:42:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:42:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:42:30 INFO - 'HOME': '/Users/cltbld', 01:42:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:42:30 INFO - 'LOGNAME': 'cltbld', 01:42:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:42:30 INFO - 'MOZ_NO_REMOTE': '1', 01:42:30 INFO - 'NO_EM_RESTART': '1', 01:42:30 INFO - 'PAGER': '/bin/cat', 01:42:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:42:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:42:30 INFO - 'PWD': '/builds/slave/test', 01:42:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:42:30 INFO - 'SHELL': '/bin/bash', 01:42:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nW2ZGFmwXJ/Listeners', 01:42:30 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 01:42:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:42:30 INFO - 'USER': 'cltbld', 01:42:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:42:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:42:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:42:30 INFO - 'XPC_FLAGS': '0x0', 01:42:30 INFO - 'XPC_SERVICE_NAME': '0', 01:42:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:42:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:42:30 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)) 01:42:30 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)) 01:42:30 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)) 01:42:30 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)) 01:42:30 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)) 01:42:30 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)) 01:42:30 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)) 01:42:30 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)) 01:42:30 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)) 01:42:30 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)) 01:42:30 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)) 01:42:30 INFO - Cleaning up... 01:42:30 INFO - Return code: 0 01:42:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:42:30 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')]} 01:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:42:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:30 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')]} 01:42:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:42:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:30 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 0x10145da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014644c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f955b470f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101301d30>, '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 0x101165db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012f8b20>, '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.VnuCWPGHKv/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.nW2ZGFmwXJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 01:42:30 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 01:42:30 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 01:42:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VnuCWPGHKv/Render', 01:42:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:42:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:42:30 INFO - 'HOME': '/Users/cltbld', 01:42:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:42:30 INFO - 'LOGNAME': 'cltbld', 01:42:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:42:30 INFO - 'MOZ_NO_REMOTE': '1', 01:42:30 INFO - 'NO_EM_RESTART': '1', 01:42:30 INFO - 'PAGER': '/bin/cat', 01:42:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:42:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:42:30 INFO - 'PWD': '/builds/slave/test', 01:42:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:42:30 INFO - 'SHELL': '/bin/bash', 01:42:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nW2ZGFmwXJ/Listeners', 01:42:30 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 01:42:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:42:30 INFO - 'USER': 'cltbld', 01:42:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:42:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:42:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:42:30 INFO - 'XPC_FLAGS': '0x0', 01:42:30 INFO - 'XPC_SERVICE_NAME': '0', 01:42:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:42:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:42:30 INFO - Downloading/unpacking jsonschema 01:42:30 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 01:42:30 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 01:42:30 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 01:42:30 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 01:42:30 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 01:42:30 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 01:42:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:42:33 INFO - Downloading/unpacking functools32 (from jsonschema) 01:42: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 01:42: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 01:42: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 01:42: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 01:42: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 01:42: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 01:42:33 INFO - Downloading functools32-3.2.3-2.tar.gz 01:42:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:42:33 INFO - warning: no files found matching '*.txt' 01:42:33 INFO - no previously-included directories found matching 'build' 01:42:33 INFO - no previously-included directories found matching 'dist' 01:42:33 INFO - no previously-included directories found matching '.git*' 01:42:33 INFO - Installing collected packages: jsonschema, functools32 01:42:33 INFO - Running setup.py install for functools32 01:42:33 INFO - warning: no files found matching '*.txt' 01:42:33 INFO - no previously-included directories found matching 'build' 01:42:33 INFO - no previously-included directories found matching 'dist' 01:42:33 INFO - no previously-included directories found matching '.git*' 01:42:33 INFO - Successfully installed jsonschema functools32 01:42:33 INFO - Cleaning up... 01:42:34 INFO - Return code: 0 01:42:34 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:42: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')]} 01:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:42:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42: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')]} 01:42:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:42:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:42:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10145da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014644c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f955b470f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101301d30>, '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 0x101165db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012f8b20>, '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.VnuCWPGHKv/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.nW2ZGFmwXJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 01:42:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 01:42:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 01:42:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VnuCWPGHKv/Render', 01:42:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:42:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:42:34 INFO - 'HOME': '/Users/cltbld', 01:42:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:42:34 INFO - 'LOGNAME': 'cltbld', 01:42:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:42:34 INFO - 'MOZ_NO_REMOTE': '1', 01:42:34 INFO - 'NO_EM_RESTART': '1', 01:42:34 INFO - 'PAGER': '/bin/cat', 01:42:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:42:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:42:34 INFO - 'PWD': '/builds/slave/test', 01:42:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:42:34 INFO - 'SHELL': '/bin/bash', 01:42:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nW2ZGFmwXJ/Listeners', 01:42:34 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 01:42:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:42:34 INFO - 'USER': 'cltbld', 01:42:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:42:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:42:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:42:34 INFO - 'XPC_FLAGS': '0x0', 01:42:34 INFO - 'XPC_SERVICE_NAME': '0', 01:42:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:42:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:42:34 INFO - Downloading/unpacking flake8 01:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:42:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:42:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:42:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:42:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:42:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:42:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:42:36 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 01:42:36 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 01:42:36 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 01:42:36 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 01:42:36 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 01:42:36 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 01:42:36 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:42:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:42:36 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 01:42:36 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 01:42:36 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 01:42:36 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 01:42:36 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 01:42:36 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 01:42:37 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:42:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:42:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:42:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:42:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:42:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:42:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:42:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:42:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:42:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:42:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:42:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:42:37 INFO - no previously-included directories found matching 'docs/_build' 01:42:37 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:42:37 INFO - Running setup.py install for pep8 01:42:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:42:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:42:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:42:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:42:38 INFO - no previously-included directories found matching 'docs/_build' 01:42:38 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:42:38 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:42:38 INFO - Cleaning up... 01:42:38 INFO - Return code: 0 01:42:38 INFO - Running post-action listener: _resource_record_post_action 01:42:38 INFO - Running post-action listener: _start_resource_monitoring 01:42:38 INFO - Starting resource monitoring. 01:42:38 INFO - ##### 01:42:38 INFO - ##### Running install step. 01:42:38 INFO - ##### 01:42:38 INFO - Running pre-action listener: _resource_record_pre_action 01:42:38 INFO - Running main action method: install 01:42:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:42:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:42:38 INFO - Reading from file tmpfile_stdout 01:42:38 INFO - Detecting whether we're running mozinstall >=1.0... 01:42:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:42:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:42:38 INFO - Reading from file tmpfile_stdout 01:42:38 INFO - Output received: 01:42:38 INFO - Usage: mozinstall [options] installer 01:42:38 INFO - Options: 01:42:38 INFO - -h, --help show this help message and exit 01:42:38 INFO - -d DEST, --destination=DEST 01:42:38 INFO - Directory to install application into. [default: 01:42:38 INFO - "/builds/slave/test"] 01:42:38 INFO - --app=APP Application being installed. [default: firefox] 01:42:38 INFO - mkdir: /builds/slave/test/build/application 01:42:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 01:42:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 01:43:10 INFO - Reading from file tmpfile_stdout 01:43:10 INFO - Output received: 01:43:10 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 01:43:10 INFO - Running post-action listener: _resource_record_post_action 01:43:10 INFO - ##### 01:43:10 INFO - ##### Running run-tests step. 01:43:10 INFO - ##### 01:43:10 INFO - Running pre-action listener: _resource_record_pre_action 01:43:10 INFO - Running main action method: run_tests 01:43:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:43:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:43:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:43:10 INFO - 2016-03-11 01:43:10.426 screenresolution[1646:8132] starting screenresolution argv=screenresolution get 01:43:10 INFO - 2016-03-11 01:43:10.429 screenresolution[1646:8132] Display 0: 1600x1200x32@60 01:43:10 INFO - 2016-03-11 01:43:10.436 screenresolution[1647:8134] starting screenresolution argv=screenresolution list 01:43:10 INFO - Available Modes on Display 0 01:43:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:43:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:43:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:43:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:43:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:43:10 INFO - Intel Iris: 01:43:10 INFO - Chipset Model: Intel Iris 01:43:10 INFO - Type: GPU 01:43:10 INFO - Bus: Built-In 01:43:10 INFO - VRAM (Dynamic, Max): 1536 MB 01:43:10 INFO - Vendor: Intel (0x8086) 01:43:10 INFO - Device ID: 0x0a2e 01:43:10 INFO - Revision ID: 0x0009 01:43:10 INFO - Displays: 01:43:10 INFO - Display: 01:43:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:43:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:43:10 INFO - Display Serial Number: 1600x1200 60 01:43:10 INFO - Main Display: Yes 01:43:10 INFO - Mirror: Off 01:43:10 INFO - Online: Yes 01:43:10 INFO - Rotation: Supported 01:43:10 INFO - Return code: 0 01:43:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:43:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:43:10 INFO - Python 2.7.3 01:43:10 INFO - Return code: 0 01:43:10 INFO - grabbing minidump binary from tooltool 01:43:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:43:10 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 0x101301d30>, '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 0x101165db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012f8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:43:10 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 01:43:10 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 01:43:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:43:10 INFO - Return code: 0 01:43:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:43:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:43:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:43:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:43:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:43:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:43:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:43:11 INFO - Return code: 0 01:43:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Wg-6U_9IR9y4kEbTbUTFAw/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0013', '--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 01:43:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Wg-6U_9IR9y4kEbTbUTFAw/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0013 --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 01:43:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VnuCWPGHKv/Render', 01:43:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:43:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:43:11 INFO - 'HOME': '/Users/cltbld', 01:43:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:43:11 INFO - 'LOGNAME': 'cltbld', 01:43:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:43:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:43:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:43:11 INFO - 'MOZ_NO_REMOTE': '1', 01:43:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:43:11 INFO - 'NO_EM_RESTART': '1', 01:43:11 INFO - 'PAGER': '/bin/cat', 01:43:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:43:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:43:11 INFO - 'PWD': '/builds/slave/test', 01:43:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:43:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:43:11 INFO - 'SHELL': '/bin/bash', 01:43:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nW2ZGFmwXJ/Listeners', 01:43:11 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 01:43:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:43:11 INFO - 'USER': 'cltbld', 01:43:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:43:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:43:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:43:11 INFO - 'XPC_FLAGS': '0x0', 01:43:11 INFO - 'XPC_SERVICE_NAME': '0', 01:43:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:43:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Wg-6U_9IR9y4kEbTbUTFAw/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0013', '--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 01:43:12 INFO - mozversion application_buildid: 20160311003616 01:43:12 INFO - mozversion application_changeset: 3bb19c9730afdd2501d08c88cd410fd04bd71c38 01:43:12 INFO - mozversion application_display_name: FirefoxDeveloperEdition 01:43:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:43:12 INFO - mozversion application_name: Firefox 01:43:12 INFO - mozversion application_remotingname: firefox-dev 01:43:12 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:43:12 INFO - mozversion application_vendor: Mozilla 01:43:12 INFO - mozversion application_version: 47.0a2 01:43:12 INFO - mozversion platform_buildid: 20160311003616 01:43:12 INFO - mozversion platform_changeset: 3bb19c9730afdd2501d08c88cd410fd04bd71c38 01:43:12 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:43:12 INFO - mozversion platform_version: 47.0a2 01:43:12 INFO - using testdate: 1457689392 01:43:12 INFO - actual date: 1457689392 01:43:12 INFO - starting webserver on 'localhost:49272' 01:43:12 INFO - SUITE-START | Running 2 tests 01:43:12 INFO - TEST-START | dromaeo_css 01:43:12 INFO - operating with platform_type : mac_ 01:43:12 INFO - Initialising browser for dromaeo_css test... 01:43:12 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpi13fiq/profile http://localhost:49272/getInfo.html) 01:43:14 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 01:43:14 INFO - PROCESS | 1665 | colorDepth:24 01:43:14 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 01:43:14 INFO - PROCESS | 1665 | __metrics 01:43:14 INFO - PROCESS | 1665 | 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" 01:43:14 INFO - PROCESS | 1665 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:43:15 INFO - TEST-INFO | 1665: exit 0 01:43:15 INFO - Browser initialized. 01:43:15 INFO - Running cycle 1/1 for dromaeo_css test... 01:43:15 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpi13fiq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:43:27 INFO - PROCESS | 1668 | RSS: Main: 210477056 01:43:27 INFO - PROCESS | 1668 | 01:44:18 INFO - PROCESS | 1668 | 1457689458241 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] 01:46:28 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 01:46:29 INFO - PROCESS | 1668 | RSS: Main: 319918080 01:46:29 INFO - PROCESS | 1668 | 01:49:31 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 01:49:32 INFO - PROCESS | 1668 | RSS: Main: 343965696 01:49:32 INFO - PROCESS | 1668 | 01:52:34 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 01:52:35 INFO - PROCESS | 1668 | RSS: Main: 349622272 01:52:35 INFO - PROCESS | 1668 | 01:55:37 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 01:55:37 INFO - PROCESS | 1668 | RSS: Main: 303542272 01:55:37 INFO - PROCESS | 1668 | 01:58:40 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 01:58:41 INFO - PROCESS | 1668 | RSS: Main: 307019776 01:58:41 INFO - PROCESS | 1668 | 02:01:44 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 02:01:44 INFO - PROCESS | 1668 | RSS: Main: 356012032 02:01:44 INFO - PROCESS | 1668 | 02:01:44 INFO - PROCESS | 1668 | __start_tp_report 02:01:44 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 02:01:44 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 02:01:44 INFO - PROCESS | 1668 | |i|pagename|runs| 02:01:44 INFO - PROCESS | 1668 | |0;dojo.html;3255.6256030556488;3481.6170221275656;3501.5798104227497;3510.596281427635;3546.946795798062;5666;5682.403347648495;5683.971580142103;5684;5689.0328644130495;5680.261565996415;5687.488126068653;5714.828555143342;5723.856903577413;5725.742341594628;5109.208072748711;5116.334876466063;5156.896862062757;5183.688978661274;5186.118359878829;5163.225516172567;5168.043911876296;5168.948310516903;5174.327337446146;5175.146100893348;5133.076046311662;5166.844994650167;5189.558887494568;5200.531952124308;5212.895742085175;5233.86915327118;5266.394364648077;5268.236105764643;5276.2085687146855;5331.5201631853315;5000.899982000376;5174.922376164361;5181.507756763139;5187.8184263550975;5191.662541934762;5613.859653508654;5657.321121465409;5658.207850900877;5670.489655930986;5674.943250567483;6093.512518998469;6351.491880649537;6373.52198585108;6390.424861762417;6396.42432181106;6297.118403423525;6300.180976473029;6381.1704478417505;6402.775902843378;6437.452816510602;5863.003289440805;5886.411358864122;5886.440788125164;5886.6173698709445;5886.911696324559;6183.350748171467;6240.438360547572;6339.270983836917;6352.14246076783;6373.267074286424;6177.073438984098;6211.81364559064;6212.378762123842;6214.285357183891;6220.377962203744;6311.463525600284;6325.620462772248;6351.015592583065;6354.618722876642;6373.426391624684;6111.5309653553995;6212.596181248295;6218.06728990655;6237.500999919996;6256.374362563707;6197.690115494297;6257.1240026395435;6310.305866354697;6379.936200637934;6403.167588213502;4894.216925291937;4910.558049775537;4914.70511769295;4915.9508404916205;4932.186189278729;3796.2976849282973;4316.611504964569;4424.646028317791;4463.642908567307;4473.3960915276675;5641.774329026875;5704.515116215168;5797.652140871562;5830.271216097988;5835.94164058354;5230.97384513075;6351.2060992375955;6357.523185761086;6369.617822930546;6371.681415929278;5578.470045345685;5677.716114194273;5696.943030569641;5736.282964629421;5760.3951585083805;5351.705656188869;5396.9730151348995;5419.187121931663;5448.700321482277;5456.91814622781;6351.650659213695;6352;6354;6360.9045864313;6380.266269379081;6225.128482012431;6273.153124328157;6352.36476352361;6368.681565921778;6397.680115994275;6323.177986861679;6368.745250189941;6381.329960354096;6381.617102973836;6393.93606063952;6220.253569571681;6269.655168965751;6277.811665650038;6279.058141278845;6301;5406.648337915522;6142.98993493194;6257.43683068526;6372.58578192416;6377.585456945284;5994.490468310068;6162.707413154946;6193.102000210034;6199.876002479835;6200.131981522501;6168.660723660242;6182.567220294716;6185.381461853779;6193.256809182927;6205.379462053758;5872.119182122716;5924.407559244041;5966.671833049224;6035.245594300713;6042.1843051187525;5132.538071573576;6141.232345956755;6182.072689096672;6185.938140618537;6198.0702894566175;6006.309274433322;6026.638401695912;6029.57792954489;6037.758489660365;6038.3357830637715 02:01:44 INFO - PROCESS | 1668 | |1;ext.html;478.4617305531277;526.8856368780031;609.3297372889822;669.1167658690529;669.9966500167499;31822;31870.725170993162;39331.41002884959;39392.62125825597;39790.602093979054;42714.14571708564;43569;43592.3461148083;43659.563404365945;43783.78108109463;9544.856827147581;9766.511674416251;9774.657886973957;9779.364341317792;9815.165710914582;9458.716238512856;9571.138597526222;9591.280653950947;9594;9709.95145024274;9701.320907536476;9755.41467511948;9760.316777825556;9770.218382529381;9774.413535187876;9668.709938701815;9721.756956076084;9726.610935562569;9740.951295243478;9743.12311891926;9512.857307140399;9666.323357364987;9668.323217374787;9677.98381169981;9681.08029737181;41846.37230441546;42099.368509472384;42317.78841105775;42398;42516.57483425157;3203.7116659500757;3338.115399419156;3362.0922350965348;3484.8083355415442;3702.5186725725484;29373;29573.260668483246;29660.8516957416;30019.549706754417;30240.24399390011;2751.917442476729;2786.986065069682;2823;2843.829370237772;2860.313524754044;498897;499993;501207.4939625315;501337;501385;67556.66221668861;67957.64084718277;67958;68026.57827241214;68118.65940670265;72216.277837222;76120;77304.45391092147;77447.61276193583;77455;14869.553913382399;17915.641687166182;18156.91058536492;18162;18166.18252178655;13571.52499662507;13644.113132646346;13655;13698.041137120505;13729.313534323244;21937.34187974363;22300.442488937908;22368.328950131523;22470.76410797389;22507.212247571257;9381.202597779129;9634.518274086407;9647.807043859084;9687.757806054906;9724.173445257233;962.2109869906609;1030.258214085857;1067.9213993866251;1080.508368692243;1178.2518101005924;30318.242043948638;30544.847275763925;30654.233644159074;31215.84392078025;31448.842755786074;1098.8351747237978;1138.3226979947083;1167.5038108803724;1173.0732721150196;1191.773563023023;15366.539003829903;15510.224488775517;15562.377504899678;15733.68532629341;15821;522156;781580;787197;787245;787355;60265.69867150636;60485.0927236083;60822;60906.78186436246;60946;1487.9628009299638;1534.90023148495;1560.2276872947737;1563.6559956809483;1582.2563395204236;29102.417951640426;31227.219319517193;31721.36557268888;31991.520127198575;32522.699092037;41105;51262.48737512726;51340.486595135066;51387;51469.485305147966;399947;402153;402563;402577;402914;33301.33397331991;34790.65209347874;34893.651063490055;34941.126471838405;34967.82516087403;43069.92325191895;45273;45409.545904541854;46834.53165468438;47209;33527.83236083804;37741;37914.8104259477;38180.22278737073;39004;37475.81262093672;37864.05339866525;37925.86222413332;38197.61802381941;38568.807155965165;37180;37604.435933461566;38847;38921.41617875677;38959.805200974944;32745.67254327426;33749.493757594144;33763.662363376054;33765;33800;24815.255542333758;25315.367115822253;25382;25526;25654.743452565235 02:01:44 INFO - PROCESS | 1668 | |2;jquery.html;384.3178358413815;387.9456876037357;388.8075402675675;393.26655786957315;394.40248024243294;16126.435574754885;19940.60118797625;20651.380458586227;20773.584528309424;20884.89557552214;20263.797362026377;20357.592848143027;21112;21319.36041918741;21325.57348853022;5352.598555108363;5507.972460137694;5521.889562208753;5555.749991250404;5556.249906262663;4038.5153781546255;4164.541900390955;5656.434356564352;5898.734556944948;6089.604175728564;6050.515958723292;6079.665618390986;6079.665618390986;6081;6096.298925623566;4002.599740026003;4593.862184134481;5822.475977162076;5844.444777746128;6030.547708921827;4062.7156099073077;5409.891802163974;5637.49262566371;5643.097104463307;5645.491905728504;13290.003249756306;13573.914086873125;16112;24971.00115995358;24994.250172494674;2012.537116463207;2105.8631188972668;2140.678898165272;2232.05137816429;2472.418981539337;9710.854337184948;9756.121949024551;9793.020697930222;10106.747331316703;10244.948775256076;1756.956076098095;1803.5941913069585;1819.9090045497671;1820.0171907170113;1874.8781329213557;87058.6941195889;87285.56357218174;91364;92196;93543;11362.659120226406;11747.88252117485;11752.471138798775;11787.587434439753;11921.821172682417;14278.928605356907;14324.928375358057;14328.068675536057;14373.712525749426;14393.640158995899;8356.289715374262;8440.451370660887;8459.111793261742;8531.658733650584;8548.931383577054;8224.108455055371;8384.161583841567;8421.368397370221;8423.957880210559;8594.312455003585;4514.954850451519;4588.357629931812;4594.448666160082;4602.746848923274;4648.97675511627;1632.4123315606373;1923.6633589121848;1949.7757757858028;1968.8523360748002;1972.684370500713;711.9323664251888;853.3088198559187;919.1911118215927;940.7318914109446;1022.4121130350078;19323.903380483007;19638;19801.702974455395;19938.501537461678;20450.79549204489;954.3945030067954;999.8800143982769;1010.4139599032543;1027.0294571629738;1051.8369652703843;10805.567777288978;11023.724406889893;11079.789679921578;11105.944470277596;11123.388213648326;594423;634945;648039;668714;685553;105882.94117058885;112542;114060.42969785264;114897;115760;935.9157675809209;1047.0524175621076;1047.738065483629;1107.1364335818075;1108.6119858049778;17927.37254196149;18093;18183.909080454512;18225.726614100535;18446.538836529195;51105;51431;51606.74196628993;53254.73372633112;54314.91370172653;77004;77549;78526.6073669628;80311.59844200741;81163.59418202871;8140.75577732669;8224.424290299621;8261.752147435345;8396.748097557083;8444.577771111297;9392.295577831554;12579.245245285312;13063.608091757262;13449;13570.59288221355;11014.063804576701;11193.608223712132;11207.71980700489;11757.941210293893;11793.882061179278;11111.888881111085;11146.05258553032;11264.66206013821;11450.770984580427;11548.364839933884;10081.495925203564;11161.665150045512;11718.648440546796;11836.644900652995;12011;8132.67469301245;8264.669413223644;8289.336853051862;8383.203595658402;8528.147185281423;11256.493457794582;11450.484728187419;11605.6518304451;11798.410079496163;11939.76120477603 02:01:44 INFO - PROCESS | 1668 | |3;mootools.html;1514.3942423030794;1647.324596915265;1679.9748003779941;2006.6588679924412;2075.2217918280635;8296;8525.488470691764;8530;8539.743807685763;8540.402171847973;8718.258947989412;8846.380753347252;8956.283497320215;8978.86531702025;9014.639414423431;2034.959300813979;2461.10169788027;2464.7412021737728;2465.630155476675;2470.888810003554;2238.787315205061;2306.8039216666602;2308.4344335637793;2502.1367628168255;2556;2534.3917459809604;2549.209744979053;2552.1833013435707;2553.195743340851;2560.9615855762177;2485.875706214682;2538.1877799104295;2572.9099481518056;2582.8966841326323;2587.068655284096;2533.518631460017;2569.242073588296;2585.896564137432;2595.5068536977915;2600.180943002948;8981.326400519922;9236.815263694689;9241.445513269158;9244.168024877727;9285.675001374988;4844.467108618049;5638.859028524279;5811.302643682743;5816.040353341694;5816.796412125597;3668.6881615062753;3756.1736417988;3807.0101773538804;3814.0274230071154;3839;1056.5720883042304;1058.1904842795268;1059.1315121600292;1078.1159449251618;1109.3233127792041;12565.371731413392;12579.685507862285;12581.874181258161;12602.873971260353;12611.684707882376;5064.088464076428;5080.974595127001;5137.255098010767;5180.818671346485;5202.557782588522;10570.995755403224;10593.84109238362;10607.204459665556;10611.681649550526;10619.522121504551;5736.885262294731;5754.942450575524;5755.625884317506;5768.192453056491;5770.711464426762;4954.603631709455;5144.819931302386;5183.222516622537;5184.5593124584075;5203.765830537635;3472.2361080562237;3886.68906487486;3953.6244056814558;3991.3214753491975;4124.05146816228;1165.7143999720122;1358.8165597644388;1365.3514580574347;1367.446184295362;1389.7012142389435;1410.1891412437685;1434.2685230532295;1434.2828585707146;1457.7886206499998;1463.656040830404;8270.766061134318;8404.621792019374;8414.410991230556;8441.366897482714;8450.154984501502;1236.9505219791288;1256.8868801807698;1257.4970011995274;1264.3741348032784;1283.0120806978762;6448.000559913221;6485.156929599122;6531.771388001397;6559.24568674599;6568.8357791055605;10758.56965721378;11162.939520745516;11181.944090279496;11255.43722813856;11290.887091128983;9032.548372581345;10812.243142979916;10914.126869850394;11029.283096598696;11082.944585277184;8599.61301741423;8645.178708022728;8647.913520864837;8692.391532592785;8715.607797649121;8152.796180095545;8196.754097377088;8206.261436470746;8281.420300578902;8289;9751.268654850772;9959.850602241117;9966.700998970042;9986.650467233612;10048.296619236584;10164.84752728695;10254.538545765608;10290.3825770454;10410.167186625204;10413.739656508647;7680.231976802275;7786.26030527099;7852.293293603603;7853.764387068397;7871.685132594632;7742.4193185510185;7927.682892684459;8384.161583841567;8580.957095214484;8581.313494920267;7481.4014878808475;7581.50720203185;7588.354989825927;7689.769306920802;7723.266289702469;7369.963150184215;7415.666295016629;7495.213002634645;7506.1743208248145;7590.0891892970985;7863.252990965849;7932.048154221299;7948.443608947318;7953.8409231813885;7964.721234756756;7262.854742905218;7373.668184931584;7379.704811807467;7383.520071195355;7383.741569045058;7204.387627051759;7374.151972523228;7406.000189974285;7417.369523590555;7425.183229844604 02:01:44 INFO - PROCESS | 1668 | |4;prototype.html;335.5889035930984;340.95397121388606;345.0786400311169;345.90487615905613;348.76109864742654;6656.534042617012;6714.294999025105;6776.796696099119;6798.116244888164;6809.829754256146;6668.066470694094;6677.2988836172235;6678.7996360109155;6683.498737594688;6688.699008544615;4700.365450664168;4790.616750659939;4819;4936.3829521309835;4981.0037992401485;4928.507149285078;4930.4330002049865;4932.679375840559;4935.383077115361;4966.230234313669;4895.7062576245535;4907.9263811042865;4909.263610458442;4912.361393018902;4924.581410580105;4721.7639118044135;4772.164871147535;4912.115819152551;4932.284818701268;4935.087008903364;4226.936595951063;4235.470566179228;4237.724547904407;4239.427677263591;4249.150169965988;5213.7393130343335;6442.355764423567;6448.355164483561;6453.419192272718;6453.806385808433;5879.706014699248;5889.381614930414;5893.116032595102;5899.46904778572;5903.439173278532;5833.854153646151;6887.621180835052;7121.074260346122;7122.358987691081;7134.286571342825;4770.952290477086;4784.880377990543;4797.64017698674;4810.158222311116;4810.470848206694;7430.6284685765495;7498.66256018475;7502.924970750277;7506.887396689054;7516.398688104939;4867.951320486821;4874.951885344668;4877.122118018719;4877.853664390074;4884.462709101996;4960.627952903546;4961.355023846877;4965.726885021359;4974.552290293818;4980.302757613937;5611.3266408031295;5850.824475265749;5859.355470898197;5859.619124756877;5866.384029676822;7151.928480715231;7169.247229040876;7171.569705817667;7173.461990350745;7186.676599553032;1431.9785203221752;1686.7132587460162;1723.1901006527162;1724.3188940368484;1730.9394171203946;911.2345629671108;1058.2169194795795;1118.4296009035288;1126.7352172239516;1153.2676750263643;6542.476601871839;6683.6658167091455;6685.364890335508;6687.130673012477;6727.865442691216;7459.291367320096;7473.439492038119;7479.065116860393;7479.177290498041;7486.064241969754;6657.068010478537;6729.798106056826;6829.282925292872;6846.828829279308;6849.315068493211;3762.9435558466644;3905.824237909301;3951.565327813938;3959.7822119783114;3960.742551734186;7738.845223095619;7817.648205830751;7821.765347039598;7830.960845195851;7838.412119090977;7719.536827790351;7725.49784264021;7738.110117336579;7746.18665040174;7750.418718596015;7066.75266365685;7112.359887610037;7770.145284018753;7793.298603125746;7807.648655810616;7269.821470335985;7454.366378857858;7492.70029198826;7497.62511874415;7499.66251518672;7340.559566426032;7371.4102871769055;7385.778426647209;7390.29792169743;7393.593352365671;7782.805429864298;7792;7816.921830781846;7817.296443320129;7821.960890195513;4878.195097808822;4890.095332363524;4907.386576677915;4912.48418916023;4922.433920099091;6105.481034111973;6120.510359171167;6247.468965138014;7168.67740951648;7422.740204092831;6240.53196010292;6798.76204332846;7180.7845764627145;7203.819904502219;7210.96394518024;7167.068281123421;7318.560886346836;7353.742619008309;7359.668814903235;7366.152892417226;6977.95330700399;6995.650217489207;6998.790036298919;7001.124859392576;7022.789316320519;6975.267596902252;7198.316159964795;7213;7216.639168041472;7223.458240632079;5717.856428714357;6742.932570674427;6936.167659880846;6949.965250173716;6951.27011663768 02:01:44 INFO - PROCESS | 1668 | |5;yui.html;715.6994062493752;773.3194788586044;779.4660657449643;785.4344871692387;806.3307454812506;14923.47767828125;15173.468928587501;15221.238938053108;15228.695426091472;15229.4669686561;13831.654208644788;13872.16766993981;13901.374438150282;13906.721865562682;13931.303434828269;791.4143533785016;795.2484901767803;955.1594596754846;962.2398305338774;989.9802003959917;829.1915382502073;976.3117002513246;987.5062468765617;997.2371136080868;997.366672163178;1041.4792603698152;1046.5604446132643;1048.3500229857461;1049.9632512862051;1052.252900440688;840.7183593496155;1032.1742605915238;1059.8357254625546;1060.496264274471;1060.6870973062964;764.0869161352186;765.5138986743402;765.663108232376;765.8162041110149;766.1610536462565;15108.773368399483;15114.470993515284;15184;15187.544373668808;15190.772138417933;12850.614481565568;12983.31298331295;13183.802242966363;13336.933315333457;13469.595912122651;10255.384676919408;10435.895641043568;10466.52900619474;10472.424016679079;10504.317219380791;3528.4530897710897;3559.661832125944;3588.67701906827;3640.1627625645983;3799.7530160539477;83056.58471707664;84362.57818710867;84952.15047849443;85052.57473712592;85086;9874.703758887244;9881.604735810488;10023.899761002442;10028.598856045677;10277.383356998604;23974.28077157688;23986.40033999164;24008.39979000504;24022.15922442741;24024.639630405556;7303.342699157101;7405.740799072007;7463.365613922769;7637.19809420014;7647;4112.732672376286;4113.341865301538;4117.958820411817;4132.483439570054;4155.023569461174;3711.0722319420147;3762.7177961652988;3763.8118094095184;3765.7175711821724;3773.396256598931;596.3499785234116;633.0915136778738;651.2770824384929;664.0736173038584;737.0197637142587;529.3039652856481;572.4790440698944;585.6486108334965;612.4120843989731;640.3756337570924;8326.04250511187;8390.580470976549;8438.282745966539;8490.745277641681;8526.232639062515;578.7713853028031;584.693036156013;604.703695189354;617.5646169450526;617.7436363909018;3560.4481305397703;3850.634189752025;3886.397608370707;3982.38273067675;4026.2010030845304;95445.09109817765;96181;96300.51849740706;97250.02749972409;98328;82982;83847.16152838393;84792;85667.71498427528;86807.56596216979;72444.27555724376;72494;73093.634531827;74315;74671.62664186645;7762.262585054411;7806.219378062148;7991.841183028312;8018.83962320762;8045.235702608243;47347.28979065248;48430.757846211956;48531.27203092027;48734.02531949412;49476.50523494719;67055.66472167608;71724.64137679279;74896;74946;75583.62208188923;11163.88836111661;11263.324200547993;11369.829452558053;11544.307341559534;11661.24201926872;11067.335959842436;11957.461914213707;12167.756644866877;12285.57000504978;12550.246985180553;11646.126540509666;11984.76030479403;11997.40012999364;12072.3360215189;12225.327606981346;11587.826182607436;11695.064394848561;11776.941115294369;11908;12222.572209972608;10991.835122473329;11001.669949901516;11609.88390116088;11833.940830295793;11839.467223975114;9713.902860971582;9912.603495860374;9977.351472154287;10044.54799534008;10191.337563058378;9658.71023869285;9889.901100988898;9953.253505987224;9968.55141518619;10083.14293285079 02:01:44 INFO - PROCESS | 1668 | __end_tp_report 02:01:44 INFO - PROCESS | 1668 | __start_cc_report 02:01:44 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,989 02:01:44 INFO - PROCESS | 1668 | __end_cc_report 02:01:44 INFO - PROCESS | 1668 | __startTimestamp1457690504473__endTimestamp 02:01:44 INFO - PROCESS | 1668 | 02:01:44 INFO - PROCESS | 1668 | ------- Summary: start ------- 02:01:44 INFO - PROCESS | 1668 | Number of tests: 6 02:01:44 INFO - PROCESS | 1668 | 02:01:44 INFO - PROCESS | 1668 | [#0] dojo.html Cycles:165 Average:5766.76 Median:6006.31 stddev:669.73 (11.2%) stddev-sans-first:642.15 02:01:44 INFO - PROCESS | 1668 | Values: 3255.6 3481.6 3501.6 3510.6 3546.9 5666.0 5682.4 5684.0 5684.0 5689.0 5680.3 5687.5 5714.8 5723.9 5725.7 5109.2 5116.3 5156.9 5183.7 5186.1 5163.2 5168.0 5168.9 5174.3 5175.1 5133.1 5166.8 5189.6 5200.5 5212.9 5233.9 5266.4 5268.2 5276.2 5331.5 5000.9 5174.9 5181.5 5187.8 5191.7 5613.9 5657.3 5658.2 5670.5 5674.9 6093.5 6351.5 6373.5 6390.4 6396.4 6297.1 6300.2 6381.2 6402.8 6437.5 5863.0 5886.4 5886.4 5886.6 5886.9 6183.4 6240.4 6339.3 6352.1 6373.3 6177.1 6211.8 6212.4 6214.3 6220.4 6311.5 6325.6 6351.0 6354.6 6373.4 6111.5 6212.6 6218.1 6237.5 6256.4 6197.7 6257.1 6310.3 6379.9 6403.2 4894.2 4910.6 4914.7 4916.0 4932.2 3796.3 4316.6 4424.6 4463.6 4473.4 5641.8 5704.5 5797.7 5830.3 5835.9 5231.0 6351.2 6357.5 6369.6 6371.7 5578.5 5677.7 5696.9 5736.3 5760.4 5351.7 5397.0 5419.2 5448.7 5456.9 6351.7 6352.0 6354.0 6360.9 6380.3 6225.1 6273.2 6352.4 6368.7 6397.7 6323.2 6368.7 6381.3 6381.6 6393.9 6220.3 6269.7 6277.8 6279.1 6301.0 5406.6 6143.0 6257.4 6372.6 6377.6 5994.5 6162.7 6193.1 6199.9 6200.1 6168.7 6182.6 6185.4 6193.3 6205.4 5872.1 5924.4 5966.7 6035.2 6042.2 5132.5 6141.2 6182.1 6185.9 6198.1 6006.3 6026.6 6029.6 6037.8 6038.3 02:01:44 INFO - PROCESS | 1668 | 02:01:44 INFO - PROCESS | 1668 | [#1] ext.html Cycles:180 Average:69280.12 Median:39167.71 stddev:151669.03 (387.2%) stddev-sans-first:152006.53 02:01:44 INFO - PROCESS | 1668 | Values: 478.5 526.9 609.3 669.1 670.0 31822.0 31870.7 39331.4 39392.6 39790.6 42714.1 43569.0 43592.3 43659.6 43783.8 9544.9 9766.5 9774.7 9779.4 9815.2 9458.7 9571.1 9591.3 9594.0 9710.0 9701.3 9755.4 9760.3 9770.2 9774.4 9668.7 9721.8 9726.6 9741.0 9743.1 9512.9 9666.3 9668.3 9678.0 9681.1 41846.4 42099.4 42317.8 42398.0 42516.6 3203.7 3338.1 3362.1 3484.8 3702.5 29373.0 29573.3 29660.9 30019.5 30240.2 2751.9 2787.0 2823.0 2843.8 2860.3 498897.0 499993.0 501207.5 501337.0 501385.0 67556.7 67957.6 67958.0 68026.6 68118.7 72216.3 76120.0 77304.5 77447.6 77455.0 14869.6 17915.6 18156.9 18162.0 18166.2 13571.5 13644.1 13655.0 13698.0 13729.3 21937.3 22300.4 22368.3 22470.8 22507.2 9381.2 9634.5 9647.8 9687.8 9724.2 962.2 1030.3 1067.9 1080.5 1178.3 30318.2 30544.8 30654.2 31215.8 31448.8 1098.8 1138.3 1167.5 1173.1 1191.8 15366.5 15510.2 15562.4 15733.7 15821.0 522156.0 781580.0 787197.0 787245.0 787355.0 60265.7 60485.1 60822.0 60906.8 60946.0 1488.0 1534.9 1560.2 1563.7 1582.3 29102.4 31227.2 31721.4 31991.5 32522.7 41105.0 51262.5 51340.5 51387.0 51469.5 399947.0 402153.0 402563.0 402577.0 402914.0 33301.3 34790.7 34893.7 34941.1 34967.8 43069.9 45273.0 45409.5 46834.5 47209.0 33527.8 37741.0 37914.8 38180.2 39004.0 37475.8 37864.1 37925.9 38197.6 38568.8 37180.0 37604.4 38847.0 38921.4 38959.8 32745.7 33749.5 33763.7 33765.0 33800.0 24815.3 25315.4 25382.0 25526.0 25654.7 02:01:44 INFO - PROCESS | 1668 | 02:01:44 INFO - PROCESS | 1668 | [#2] jquery.html Cycles:180 Average:34925.98 Median:2352.24 stddev:106790.26 (4539.9%) stddev-sans-first:107058.34 02:01:44 INFO - PROCESS | 1668 | Values: 384.3 387.9 388.8 393.3 394.4 16126.4 19940.6 20651.4 20773.6 20884.9 20263.8 20357.6 21112.0 21319.4 21325.6 5352.6 5508.0 5521.9 5555.7 5556.2 4038.5 4164.5 5656.4 5898.7 6089.6 6050.5 6079.7 6079.7 6081.0 6096.3 4002.6 4593.9 5822.5 5844.4 6030.5 4062.7 5409.9 5637.5 5643.1 5645.5 13290.0 13573.9 16112.0 24971.0 24994.3 2012.5 2105.9 2140.7 2232.1 2472.4 9710.9 9756.1 9793.0 10106.7 10244.9 1757.0 1803.6 1819.9 1820.0 1874.9 87058.7 87285.6 91364.0 92196.0 93543.0 11362.7 11747.9 11752.5 11787.6 11921.8 14278.9 14324.9 14328.1 14373.7 14393.6 8356.3 8440.5 8459.1 8531.7 8548.9 8224.1 8384.2 8421.4 8424.0 8594.3 4515.0 4588.4 4594.4 4602.7 4649.0 1632.4 1923.7 1949.8 1968.9 1972.7 711.9 853.3 919.2 940.7 1022.4 19323.9 19638.0 19801.7 19938.5 20450.8 954.4 999.9 1010.4 1027.0 1051.8 10805.6 11023.7 11079.8 11105.9 11123.4 594423.0 634945.0 648039.0 668714.0 685553.0 105882.9 112542.0 114060.4 114897.0 115760.0 935.9 1047.1 1047.7 1107.1 1108.6 17927.4 18093.0 18183.9 18225.7 18446.5 51105.0 51431.0 51606.7 53254.7 54314.9 77004.0 77549.0 78526.6 80311.6 81163.6 8140.8 8224.4 8261.8 8396.7 8444.6 9392.3 12579.2 13063.6 13449.0 13570.6 11014.1 11193.6 11207.7 11757.9 11793.9 11111.9 11146.1 11264.7 11450.8 11548.4 10081.5 11161.7 11718.6 11836.6 12011.0 8132.7 8264.7 8289.3 8383.2 8528.1 11256.5 11450.5 11605.7 11798.4 11939.8 02:01:44 INFO - PROCESS | 1668 | 02:01:44 INFO - PROCESS | 1668 | [#3] mootools.html Cycles:180 Average:6275.72 Median:5162.82 stddev:3290.79 (63.7%) stddev-sans-first:3280.56 02:01:44 INFO - PROCESS | 1668 | Values: 1514.4 1647.3 1680.0 2006.7 2075.2 8296.0 8525.5 8530.0 8539.7 8540.4 8718.3 8846.4 8956.3 8978.9 9014.6 2035.0 2461.1 2464.7 2465.6 2470.9 2238.8 2306.8 2308.4 2502.1 2556.0 2534.4 2549.2 2552.2 2553.2 2561.0 2485.9 2538.2 2572.9 2582.9 2587.1 2533.5 2569.2 2585.9 2595.5 2600.2 8981.3 9236.8 9241.4 9244.2 9285.7 4844.5 5638.9 5811.3 5816.0 5816.8 3668.7 3756.2 3807.0 3814.0 3839.0 1056.6 1058.2 1059.1 1078.1 1109.3 12565.4 12579.7 12581.9 12602.9 12611.7 5064.1 5081.0 5137.3 5180.8 5202.6 10571.0 10593.8 10607.2 10611.7 10619.5 5736.9 5754.9 5755.6 5768.2 5770.7 4954.6 5144.8 5183.2 5184.6 5203.8 3472.2 3886.7 3953.6 3991.3 4124.1 1165.7 1358.8 1365.4 1367.4 1389.7 1410.2 1434.3 1434.3 1457.8 1463.7 8270.8 8404.6 8414.4 8441.4 8450.2 1237.0 1256.9 1257.5 1264.4 1283.0 6448.0 6485.2 6531.8 6559.2 6568.8 10758.6 11162.9 11181.9 11255.4 11290.9 9032.5 10812.2 10914.1 11029.3 11082.9 8599.6 8645.2 8647.9 8692.4 8715.6 8152.8 8196.8 8206.3 8281.4 8289.0 9751.3 9959.9 9966.7 9986.7 10048.3 10164.8 10254.5 10290.4 10410.2 10413.7 7680.2 7786.3 7852.3 7853.8 7871.7 7742.4 7927.7 8384.2 8581.0 8581.3 7481.4 7581.5 7588.4 7689.8 7723.3 7370.0 7415.7 7495.2 7506.2 7590.1 7863.3 7932.0 7948.4 7953.8 7964.7 7262.9 7373.7 7379.7 7383.5 7383.7 7204.4 7374.2 7406.0 7417.4 7425.2 02:01:44 INFO - PROCESS | 1668 | 02:01:44 INFO - PROCESS | 1668 | [#4] prototype.html Cycles:180 Average:5872.52 Median:6681.15 stddev:1857.46 (27.8%) stddev-sans-first:1815.59 02:01:44 INFO - PROCESS | 1668 | Values: 335.6 341.0 345.1 345.9 348.8 6656.5 6714.3 6776.8 6798.1 6809.8 6668.1 6677.3 6678.8 6683.5 6688.7 4700.4 4790.6 4819.0 4936.4 4981.0 4928.5 4930.4 4932.7 4935.4 4966.2 4895.7 4907.9 4909.3 4912.4 4924.6 4721.8 4772.2 4912.1 4932.3 4935.1 4226.9 4235.5 4237.7 4239.4 4249.2 5213.7 6442.4 6448.4 6453.4 6453.8 5879.7 5889.4 5893.1 5899.5 5903.4 5833.9 6887.6 7121.1 7122.4 7134.3 4771.0 4784.9 4797.6 4810.2 4810.5 7430.6 7498.7 7502.9 7506.9 7516.4 4868.0 4875.0 4877.1 4877.9 4884.5 4960.6 4961.4 4965.7 4974.6 4980.3 5611.3 5850.8 5859.4 5859.6 5866.4 7151.9 7169.2 7171.6 7173.5 7186.7 1432.0 1686.7 1723.2 1724.3 1730.9 911.2 1058.2 1118.4 1126.7 1153.3 6542.5 6683.7 6685.4 6687.1 6727.9 7459.3 7473.4 7479.1 7479.2 7486.1 6657.1 6729.8 6829.3 6846.8 6849.3 3762.9 3905.8 3951.6 3959.8 3960.7 7738.8 7817.6 7821.8 7831.0 7838.4 7719.5 7725.5 7738.1 7746.2 7750.4 7066.8 7112.4 7770.1 7793.3 7807.6 7269.8 7454.4 7492.7 7497.6 7499.7 7340.6 7371.4 7385.8 7390.3 7393.6 7782.8 7792.0 7816.9 7817.3 7822.0 4878.2 4890.1 4907.4 4912.5 4922.4 6105.5 6120.5 6247.5 7168.7 7422.7 6240.5 6798.8 7180.8 7203.8 7211.0 7167.1 7318.6 7353.7 7359.7 7366.2 6978.0 6995.7 6998.8 7001.1 7022.8 6975.3 7198.3 7213.0 7216.6 7223.5 5717.9 6742.9 6936.2 6950.0 6951.3 02:01:44 INFO - PROCESS | 1668 | 02:01:44 INFO - PROCESS | 1668 | [#5] yui.html Cycles:180 Average:19101.72 Median:47889.02 stddev:27137.97 (56.7%) stddev-sans-first:27178.98 02:01:44 INFO - PROCESS | 1668 | Values: 715.7 773.3 779.5 785.4 806.3 14923.5 15173.5 15221.2 15228.7 15229.5 13831.7 13872.2 13901.4 13906.7 13931.3 791.4 795.2 955.2 962.2 990.0 829.2 976.3 987.5 997.2 997.4 1041.5 1046.6 1048.4 1050.0 1052.3 840.7 1032.2 1059.8 1060.5 1060.7 764.1 765.5 765.7 765.8 766.2 15108.8 15114.5 15184.0 15187.5 15190.8 12850.6 12983.3 13183.8 13336.9 13469.6 10255.4 10435.9 10466.5 10472.4 10504.3 3528.5 3559.7 3588.7 3640.2 3799.8 83056.6 84362.6 84952.2 85052.6 85086.0 9874.7 9881.6 10023.9 10028.6 10277.4 23974.3 23986.4 24008.4 24022.2 24024.6 7303.3 7405.7 7463.4 7637.2 7647.0 4112.7 4113.3 4118.0 4132.5 4155.0 3711.1 3762.7 3763.8 3765.7 3773.4 596.3 633.1 651.3 664.1 737.0 529.3 572.5 585.6 612.4 640.4 8326.0 8390.6 8438.3 8490.7 8526.2 578.8 584.7 604.7 617.6 617.7 3560.4 3850.6 3886.4 3982.4 4026.2 95445.1 96181.0 96300.5 97250.0 98328.0 82982.0 83847.2 84792.0 85667.7 86807.6 72444.3 72494.0 73093.6 74315.0 74671.6 7762.3 7806.2 7991.8 8018.8 8045.2 47347.3 48430.8 48531.3 48734.0 49476.5 67055.7 71724.6 74896.0 74946.0 75583.6 11163.9 11263.3 11369.8 11544.3 11661.2 11067.3 11957.5 12167.8 12285.6 12550.2 11646.1 11984.8 11997.4 12072.3 12225.3 11587.8 11695.1 11776.9 11908.0 12222.6 10991.8 11001.7 11609.9 11833.9 11839.5 9713.9 9912.6 9977.4 10044.5 10191.3 9658.7 9889.9 9953.3 9968.6 10083.1 02:01:44 INFO - PROCESS | 1668 | -------- Summary: end -------- 02:01:44 INFO - PROCESS | 1668 | 02:01:44 INFO - TEST-INFO | 1668: exit 0 02:01:44 INFO - TEST-OK | dromaeo_css | took 1112798ms 02:01:44 INFO - TEST-START | kraken 02:01:44 INFO - operating with platform_type : mac_ 02:01:44 INFO - Initialising browser for kraken test... 02:01:44 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpuiPtuN/profile http://localhost:49272/getInfo.html) 02:01:46 INFO - PROCESS | 1674 | __metrics Screen width/height:1600/1200 02:01:46 INFO - PROCESS | 1674 | colorDepth:24 02:01:46 INFO - PROCESS | 1674 | Browser inner width/height: 1024/689 02:01:46 INFO - PROCESS | 1674 | __metrics 02:01:47 INFO - PROCESS | 1674 | 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" 02:01:47 INFO - PROCESS | 1674 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:01:47 INFO - TEST-INFO | 1674: exit 0 02:01:47 INFO - Browser initialized. 02:01:47 INFO - Running cycle 1/1 for kraken test... 02:01:47 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpuiPtuN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:01:59 INFO - PROCESS | 1676 | RSS: Main: 210694144 02:01:59 INFO - PROCESS | 1676 | 02:02:02 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 02:02:02 INFO - PROCESS | 1676 | RSS: Main: 265846784 02:02:02 INFO - PROCESS | 1676 | 02:02:05 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 02:02:06 INFO - PROCESS | 1676 | RSS: Main: 274984960 02:02:06 INFO - PROCESS | 1676 | 02:02:09 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 02:02:09 INFO - PROCESS | 1676 | RSS: Main: 265277440 02:02:09 INFO - PROCESS | 1676 | 02:02:11 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 02:02:12 INFO - PROCESS | 1676 | RSS: Main: 267657216 02:02:12 INFO - PROCESS | 1676 | 02:02:14 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:02:14 INFO - PROCESS | 1676 | RSS: Main: 267108352 02:02:14 INFO - PROCESS | 1676 | 02:02:17 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 02:02:18 INFO - PROCESS | 1676 | RSS: Main: 268783616 02:02:18 INFO - PROCESS | 1676 | 02:02:20 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 02:02:21 INFO - PROCESS | 1676 | RSS: Main: 267616256 02:02:21 INFO - PROCESS | 1676 | 02:02:24 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 02:02:24 INFO - PROCESS | 1676 | RSS: Main: 269238272 02:02:24 INFO - PROCESS | 1676 | 02:02:26 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:02:26 INFO - PROCESS | 1676 | RSS: Main: 301150208 02:02:26 INFO - PROCESS | 1676 | 02:02:28 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:02:29 INFO - PROCESS | 1676 | RSS: Main: 301547520 02:02:29 INFO - PROCESS | 1676 | 02:02:31 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:02:32 INFO - PROCESS | 1676 | RSS: Main: 307347456 02:02:32 INFO - PROCESS | 1676 | 02:02:34 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:02:35 INFO - PROCESS | 1676 | RSS: Main: 311185408 02:02:35 INFO - PROCESS | 1676 | 02:02:37 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:02:38 INFO - PROCESS | 1676 | RSS: Main: 310611968 02:02:38 INFO - PROCESS | 1676 | 02:02:40 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 02:02:40 INFO - PROCESS | 1676 | RSS: Main: 369225728 02:02:40 INFO - PROCESS | 1676 | 02:02:40 INFO - PROCESS | 1676 | __start_tp_report 02:02:40 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 02:02:40 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 02:02:40 INFO - PROCESS | 1676 | |i|pagename|runs| 02:02:40 INFO - PROCESS | 1676 | |0;ai-astar;111;110;111;110;157;147;121;154;161;114 02:02:40 INFO - PROCESS | 1676 | |1;audio-beat-detection;150;117;151;146;118;135;115;148;143;116 02:02:40 INFO - PROCESS | 1676 | |2;audio-dft;185;185;188;186;181;186;184;187;184;183 02:02:40 INFO - PROCESS | 1676 | |3;audio-fft;74;71;75;116;56;57;57;58;116;55 02:02:40 INFO - PROCESS | 1676 | |4;audio-oscillator;92;97;129;80;78;84;117;76;80;117 02:02:40 INFO - PROCESS | 1676 | |5;imaging-gaussian-blur;88;86;89;87;88;85;88;86;89;85 02:02:40 INFO - PROCESS | 1676 | |6;imaging-darkroom;93;93;93;96;94;92;93;93;93;92 02:02:40 INFO - PROCESS | 1676 | |7;imaging-desaturate;94;130;84;87;85;87;85;83;85;86 02:02:40 INFO - PROCESS | 1676 | |8;json-parse-financial;53;57;57;56;56;57;57;69;54;51 02:02:40 INFO - PROCESS | 1676 | |9;json-stringify-tinderbox;63;65;71;71;69;65;65;65;66;66 02:02:40 INFO - PROCESS | 1676 | |10;stanford-crypto-aes;80;79;80;81;80;80;79;78;80;83 02:02:40 INFO - PROCESS | 1676 | |11;stanford-crypto-ccm;117;121;127;139;117;119;116;116;127;113 02:02:40 INFO - PROCESS | 1676 | |12;stanford-crypto-pbkdf2;136;143;168;181;118;144;166;170;132;135 02:02:40 INFO - PROCESS | 1676 | |13;stanford-crypto-sha256-iterative;66;65;66;80;93;73;67;66;67;65 02:02:40 INFO - PROCESS | 1676 | __end_tp_report 02:02:40 INFO - PROCESS | 1676 | __start_cc_report 02:02:40 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,1206 02:02:40 INFO - PROCESS | 1676 | __end_cc_report 02:02:40 INFO - PROCESS | 1676 | __startTimestamp1457690560495__endTimestamp 02:02:40 INFO - PROCESS | 1676 | 02:02:40 INFO - PROCESS | 1676 | ------- Summary: start ------- 02:02:40 INFO - PROCESS | 1676 | Number of tests: 14 02:02:40 INFO - PROCESS | 1676 | 02:02:40 INFO - PROCESS | 1676 | [#0] ai-astar Cycles:10 Average:129.60 Median:134.00 stddev:22.14 (16.5%) stddev-sans-first:22.44 02:02:40 INFO - PROCESS | 1676 | Values: 111.0 110.0 111.0 110.0 157.0 147.0 121.0 154.0 161.0 114.0 02:02:40 INFO - PROCESS | 1676 | 02:02:40 INFO - PROCESS | 1676 | [#1] audio-beat-detection Cycles:10 Average:133.90 Median:144.50 stddev:15.62 (10.8%) stddev-sans-first:15.45 02:02:40 INFO - PROCESS | 1676 | Values: 150.0 117.0 151.0 146.0 118.0 135.0 115.0 148.0 143.0 116.0 02:02:40 INFO - PROCESS | 1676 | 02:02:40 INFO - PROCESS | 1676 | [#2] audio-dft Cycles:10 Average:184.90 Median:185.50 stddev:2.02 (1.1%) stddev-sans-first:2.15 02:02:40 INFO - PROCESS | 1676 | Values: 185.0 185.0 188.0 186.0 181.0 186.0 184.0 187.0 184.0 183.0 02:02:40 INFO - PROCESS | 1676 | 02:02:40 INFO - PROCESS | 1676 | [#3] audio-fft Cycles:10 Average:73.50 Median:57.50 stddev:23.70 (41.2%) stddev-sans-first:25.14 02:02:40 INFO - PROCESS | 1676 | Values: 74.0 71.0 75.0 116.0 56.0 57.0 57.0 58.0 116.0 55.0 02:02:40 INFO - PROCESS | 1676 | 02:02:40 INFO - PROCESS | 1676 | [#4] audio-oscillator Cycles:10 Average:95.00 Median:80.00 stddev:19.32 (24.1%) stddev-sans-first:20.46 02:02:40 INFO - PROCESS | 1676 | Values: 92.0 97.0 129.0 80.0 78.0 84.0 117.0 76.0 80.0 117.0 02:02:40 INFO - PROCESS | 1676 | 02:02:40 INFO - PROCESS | 1676 | [#5] imaging-gaussian-blur Cycles:10 Average:87.10 Median:88.00 stddev:1.52 (1.7%) stddev-sans-first:1.58 02:02:40 INFO - PROCESS | 1676 | Values: 88.0 86.0 89.0 87.0 88.0 85.0 88.0 86.0 89.0 85.0 02:02:40 INFO - PROCESS | 1676 | 02:02:40 INFO - PROCESS | 1676 | [#6] imaging-darkroom Cycles:10 Average:93.20 Median:93.00 stddev:1.14 (1.2%) stddev-sans-first:1.20 02:02:40 INFO - PROCESS | 1676 | Values: 93.0 93.0 93.0 96.0 94.0 92.0 93.0 93.0 93.0 92.0 02:02:40 INFO - PROCESS | 1676 | 02:02:40 INFO - PROCESS | 1676 | [#7] imaging-desaturate Cycles:10 Average:90.60 Median:85.50 stddev:14.17 (16.6%) stddev-sans-first:14.97 02:02:40 INFO - PROCESS | 1676 | Values: 94.0 130.0 84.0 87.0 85.0 87.0 85.0 83.0 85.0 86.0 02:02:40 INFO - PROCESS | 1676 | 02:02:40 INFO - PROCESS | 1676 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:57.00 stddev:4.79 (8.4%) stddev-sans-first:4.88 02:02:40 INFO - PROCESS | 1676 | Values: 53.0 57.0 57.0 56.0 56.0 57.0 57.0 69.0 54.0 51.0 02:02:40 INFO - PROCESS | 1676 | 02:02:40 INFO - PROCESS | 1676 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:66.00 stddev:2.76 (4.2%) stddev-sans-first:2.60 02:02:40 INFO - PROCESS | 1676 | Values: 63.0 65.0 71.0 71.0 69.0 65.0 65.0 65.0 66.0 66.0 02:02:40 INFO - PROCESS | 1676 | 02:02:40 INFO - PROCESS | 1676 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:80.00 stddev:1.33 (1.7%) stddev-sans-first:1.41 02:02:40 INFO - PROCESS | 1676 | Values: 80.0 79.0 80.0 81.0 80.0 80.0 79.0 78.0 80.0 83.0 02:02:40 INFO - PROCESS | 1676 | 02:02:40 INFO - PROCESS | 1676 | [#11] stanford-crypto-ccm Cycles:10 Average:121.20 Median:120.00 stddev:7.79 (6.5%) stddev-sans-first:8.11 02:02:40 INFO - PROCESS | 1676 | Values: 117.0 121.0 127.0 139.0 117.0 119.0 116.0 116.0 127.0 113.0 02:02:40 INFO - PROCESS | 1676 | 02:02:40 INFO - PROCESS | 1676 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.30 Median:155.00 stddev:20.52 (13.2%) stddev-sans-first:21.19 02:02:40 INFO - PROCESS | 1676 | Values: 136.0 143.0 168.0 181.0 118.0 144.0 166.0 170.0 132.0 135.0 02:02:40 INFO - PROCESS | 1676 | 02:02:40 INFO - PROCESS | 1676 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:67.00 stddev:9.11 (13.6%) stddev-sans-first:9.50 02:02:40 INFO - PROCESS | 1676 | Values: 66.0 65.0 66.0 80.0 93.0 73.0 67.0 66.0 67.0 65.0 02:02:40 INFO - PROCESS | 1676 | -------- Summary: end -------- 02:02:40 INFO - PROCESS | 1676 | 02:02:41 INFO - TEST-INFO | 1676: exit 0 02:02:41 INFO - TEST-OK | kraken | took 56253ms 02:02:41 INFO - SUITE-END | took 1169s 02:02:41 INFO - Completed test suite (00:19:29) 02:02:41 INFO - javascript benchmark 02:02:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3255.6256030556488, 3481.6170221275656, 3501.5798104227497, 3510.596281427635, 3546.946795798062, 5666.0, 5682.403347648495, 5683.971580142103, 5684.0, 5689.0328644130495, 5680.261565996415, 5687.488126068653, 5714.828555143342, 5723.856903577413, 5725.742341594628, 5109.208072748711, 5116.334876466063, 5156.896862062757, 5183.688978661274, 5186.118359878829, 5163.225516172567, 5168.043911876296, 5168.948310516903, 5174.327337446146, 5175.146100893348, 5133.076046311662, 5166.844994650167, 5189.558887494568, 5200.531952124308, 5212.895742085175, 5233.86915327118, 5266.394364648077, 5268.236105764643, 5276.2085687146855, 5331.5201631853315, 5000.899982000376, 5174.922376164361, 5181.507756763139, 5187.8184263550975, 5191.662541934762, 5613.859653508654, 5657.321121465409, 5658.207850900877, 5670.489655930986, 5674.943250567483, 6093.512518998469, 6351.491880649537, 6373.52198585108, 6390.424861762417, 6396.42432181106, 6297.118403423525, 6300.180976473029, 6381.1704478417505, 6402.775902843378, 6437.452816510602, 5863.003289440805, 5886.411358864122, 5886.440788125164, 5886.6173698709445, 5886.911696324559, 6183.350748171467, 6240.438360547572, 6339.270983836917, 6352.14246076783, 6373.267074286424, 6177.073438984098, 6211.81364559064, 6212.378762123842, 6214.285357183891, 6220.377962203744, 6311.463525600284, 6325.620462772248, 6351.015592583065, 6354.618722876642, 6373.426391624684, 6111.5309653553995, 6212.596181248295, 6218.06728990655, 6237.500999919996, 6256.374362563707, 6197.690115494297, 6257.1240026395435, 6310.305866354697, 6379.936200637934, 6403.167588213502, 4894.216925291937, 4910.558049775537, 4914.70511769295, 4915.9508404916205, 4932.186189278729, 3796.2976849282973, 4316.611504964569, 4424.646028317791, 4463.642908567307, 4473.3960915276675, 5641.774329026875, 5704.515116215168, 5797.652140871562, 5830.271216097988, 5835.94164058354, 5230.97384513075, 6351.2060992375955, 6357.523185761086, 6369.617822930546, 6371.681415929278, 5578.470045345685, 5677.716114194273, 5696.943030569641, 5736.282964629421, 5760.3951585083805, 5351.705656188869, 5396.9730151348995, 5419.187121931663, 5448.700321482277, 5456.91814622781, 6351.650659213695, 6352.0, 6354.0, 6360.9045864313, 6380.266269379081, 6225.128482012431, 6273.153124328157, 6352.36476352361, 6368.681565921778, 6397.680115994275, 6323.177986861679, 6368.745250189941, 6381.329960354096, 6381.617102973836, 6393.93606063952, 6220.253569571681, 6269.655168965751, 6277.811665650038, 6279.058141278845, 6301.0, 5406.648337915522, 6142.98993493194, 6257.43683068526, 6372.58578192416, 6377.585456945284, 5994.490468310068, 6162.707413154946, 6193.102000210034, 6199.876002479835, 6200.131981522501, 6168.660723660242, 6182.567220294716, 6185.381461853779, 6193.256809182927, 6205.379462053758, 5872.119182122716, 5924.407559244041, 5966.671833049224, 6035.245594300713, 6042.1843051187525, 5132.538071573576, 6141.232345956755, 6182.072689096672, 6185.938140618537, 6198.0702894566175, 6006.309274433322, 6026.638401695912, 6029.57792954489, 6037.758489660365, 6038.3357830637715], "unit": "score", "name": "dojo.html", "value": 5723.430208660255}, {"lowerIsBetter": false, "replicates": [478.4617305531277, 526.8856368780031, 609.3297372889822, 669.1167658690529, 669.9966500167499, 31822.0, 31870.725170993162, 39331.41002884959, 39392.62125825597, 39790.602093979054, 42714.14571708564, 43569.0, 43592.3461148083, 43659.563404365945, 43783.78108109463, 9544.856827147581, 9766.511674416251, 9774.657886973957, 9779.364341317792, 9815.165710914582, 9458.716238512856, 9571.138597526222, 9591.280653950947, 9594.0, 9709.95145024274, 9701.320907536476, 9755.41467511948, 9760.316777825556, 9770.218382529381, 9774.413535187876, 9668.709938701815, 9721.756956076084, 9726.610935562569, 9740.951295243478, 9743.12311891926, 9512.857307140399, 9666.323357364987, 9668.323217374787, 9677.98381169981, 9681.08029737181, 41846.37230441546, 42099.368509472384, 42317.78841105775, 42398.0, 42516.57483425157, 3203.7116659500757, 3338.115399419156, 3362.0922350965348, 3484.8083355415442, 3702.5186725725484, 29373.0, 29573.260668483246, 29660.8516957416, 30019.549706754417, 30240.24399390011, 2751.917442476729, 2786.986065069682, 2823.0, 2843.829370237772, 2860.313524754044, 498897.0, 499993.0, 501207.4939625315, 501337.0, 501385.0, 67556.66221668861, 67957.64084718277, 67958.0, 68026.57827241214, 68118.65940670265, 72216.277837222, 76120.0, 77304.45391092147, 77447.61276193583, 77455.0, 14869.553913382399, 17915.641687166182, 18156.91058536492, 18162.0, 18166.18252178655, 13571.52499662507, 13644.113132646346, 13655.0, 13698.041137120505, 13729.313534323244, 21937.34187974363, 22300.442488937908, 22368.328950131523, 22470.76410797389, 22507.212247571257, 9381.202597779129, 9634.518274086407, 9647.807043859084, 9687.757806054906, 9724.173445257233, 962.2109869906609, 1030.258214085857, 1067.9213993866251, 1080.508368692243, 1178.2518101005924, 30318.242043948638, 30544.847275763925, 30654.233644159074, 31215.84392078025, 31448.842755786074, 1098.8351747237978, 1138.3226979947083, 1167.5038108803724, 1173.0732721150196, 1191.773563023023, 15366.539003829903, 15510.224488775517, 15562.377504899678, 15733.68532629341, 15821.0, 522156.0, 781580.0, 787197.0, 787245.0, 787355.0, 60265.69867150636, 60485.0927236083, 60822.0, 60906.78186436246, 60946.0, 1487.9628009299638, 1534.90023148495, 1560.2276872947737, 1563.6559956809483, 1582.2563395204236, 29102.417951640426, 31227.219319517193, 31721.36557268888, 31991.520127198575, 32522.699092037, 41105.0, 51262.48737512726, 51340.486595135066, 51387.0, 51469.485305147966, 399947.0, 402153.0, 402563.0, 402577.0, 402914.0, 33301.33397331991, 34790.65209347874, 34893.651063490055, 34941.126471838405, 34967.82516087403, 43069.92325191895, 45273.0, 45409.545904541854, 46834.53165468438, 47209.0, 33527.83236083804, 37741.0, 37914.8104259477, 38180.22278737073, 39004.0, 37475.81262093672, 37864.05339866525, 37925.86222413332, 38197.61802381941, 38568.807155965165, 37180.0, 37604.435933461566, 38847.0, 38921.41617875677, 38959.805200974944, 32745.67254327426, 33749.493757594144, 33763.662363376054, 33765.0, 33800.0, 24815.255542333758, 25315.367115822253, 25382.0, 25526.0, 25654.743452565235], "unit": "score", "name": "ext.html", "value": 20695.26241225179}, {"lowerIsBetter": false, "replicates": [384.3178358413815, 387.9456876037357, 388.8075402675675, 393.26655786957315, 394.40248024243294, 16126.435574754885, 19940.60118797625, 20651.380458586227, 20773.584528309424, 20884.89557552214, 20263.797362026377, 20357.592848143027, 21112.0, 21319.36041918741, 21325.57348853022, 5352.598555108363, 5507.972460137694, 5521.889562208753, 5555.749991250404, 5556.249906262663, 4038.5153781546255, 4164.541900390955, 5656.434356564352, 5898.734556944948, 6089.604175728564, 6050.515958723292, 6079.665618390986, 6079.665618390986, 6081.0, 6096.298925623566, 4002.599740026003, 4593.862184134481, 5822.475977162076, 5844.444777746128, 6030.547708921827, 4062.7156099073077, 5409.891802163974, 5637.49262566371, 5643.097104463307, 5645.491905728504, 13290.003249756306, 13573.914086873125, 16112.0, 24971.00115995358, 24994.250172494674, 2012.537116463207, 2105.8631188972668, 2140.678898165272, 2232.05137816429, 2472.418981539337, 9710.854337184948, 9756.121949024551, 9793.020697930222, 10106.747331316703, 10244.948775256076, 1756.956076098095, 1803.5941913069585, 1819.9090045497671, 1820.0171907170113, 1874.8781329213557, 87058.6941195889, 87285.56357218174, 91364.0, 92196.0, 93543.0, 11362.659120226406, 11747.88252117485, 11752.471138798775, 11787.587434439753, 11921.821172682417, 14278.928605356907, 14324.928375358057, 14328.068675536057, 14373.712525749426, 14393.640158995899, 8356.289715374262, 8440.451370660887, 8459.111793261742, 8531.658733650584, 8548.931383577054, 8224.108455055371, 8384.161583841567, 8421.368397370221, 8423.957880210559, 8594.312455003585, 4514.954850451519, 4588.357629931812, 4594.448666160082, 4602.746848923274, 4648.97675511627, 1632.4123315606373, 1923.6633589121848, 1949.7757757858028, 1968.8523360748002, 1972.684370500713, 711.9323664251888, 853.3088198559187, 919.1911118215927, 940.7318914109446, 1022.4121130350078, 19323.903380483007, 19638.0, 19801.702974455395, 19938.501537461678, 20450.79549204489, 954.3945030067954, 999.8800143982769, 1010.4139599032543, 1027.0294571629738, 1051.8369652703843, 10805.567777288978, 11023.724406889893, 11079.789679921578, 11105.944470277596, 11123.388213648326, 594423.0, 634945.0, 648039.0, 668714.0, 685553.0, 105882.94117058885, 112542.0, 114060.42969785264, 114897.0, 115760.0, 935.9157675809209, 1047.0524175621076, 1047.738065483629, 1107.1364335818075, 1108.6119858049778, 17927.37254196149, 18093.0, 18183.909080454512, 18225.726614100535, 18446.538836529195, 51105.0, 51431.0, 51606.74196628993, 53254.73372633112, 54314.91370172653, 77004.0, 77549.0, 78526.6073669628, 80311.59844200741, 81163.59418202871, 8140.75577732669, 8224.424290299621, 8261.752147435345, 8396.748097557083, 8444.577771111297, 9392.295577831554, 12579.245245285312, 13063.608091757262, 13449.0, 13570.59288221355, 11014.063804576701, 11193.608223712132, 11207.71980700489, 11757.941210293893, 11793.882061179278, 11111.888881111085, 11146.05258553032, 11264.66206013821, 11450.770984580427, 11548.364839933884, 10081.495925203564, 11161.665150045512, 11718.648440546796, 11836.644900652995, 12011.0, 8132.67469301245, 8264.669413223644, 8289.336853051862, 8383.203595658402, 8528.147185281423, 11256.493457794582, 11450.484728187419, 11605.6518304451, 11798.410079496163, 11939.76120477603], "unit": "score", "name": "jquery.html", "value": 9344.046984307084}, {"lowerIsBetter": false, "replicates": [1514.3942423030794, 1647.324596915265, 1679.9748003779941, 2006.6588679924412, 2075.2217918280635, 8296.0, 8525.488470691764, 8530.0, 8539.743807685763, 8540.402171847973, 8718.258947989412, 8846.380753347252, 8956.283497320215, 8978.86531702025, 9014.639414423431, 2034.959300813979, 2461.10169788027, 2464.7412021737728, 2465.630155476675, 2470.888810003554, 2238.787315205061, 2306.8039216666602, 2308.4344335637793, 2502.1367628168255, 2556.0, 2534.3917459809604, 2549.209744979053, 2552.1833013435707, 2553.195743340851, 2560.9615855762177, 2485.875706214682, 2538.1877799104295, 2572.9099481518056, 2582.8966841326323, 2587.068655284096, 2533.518631460017, 2569.242073588296, 2585.896564137432, 2595.5068536977915, 2600.180943002948, 8981.326400519922, 9236.815263694689, 9241.445513269158, 9244.168024877727, 9285.675001374988, 4844.467108618049, 5638.859028524279, 5811.302643682743, 5816.040353341694, 5816.796412125597, 3668.6881615062753, 3756.1736417988, 3807.0101773538804, 3814.0274230071154, 3839.0, 1056.5720883042304, 1058.1904842795268, 1059.1315121600292, 1078.1159449251618, 1109.3233127792041, 12565.371731413392, 12579.685507862285, 12581.874181258161, 12602.873971260353, 12611.684707882376, 5064.088464076428, 5080.974595127001, 5137.255098010767, 5180.818671346485, 5202.557782588522, 10570.995755403224, 10593.84109238362, 10607.204459665556, 10611.681649550526, 10619.522121504551, 5736.885262294731, 5754.942450575524, 5755.625884317506, 5768.192453056491, 5770.711464426762, 4954.603631709455, 5144.819931302386, 5183.222516622537, 5184.5593124584075, 5203.765830537635, 3472.2361080562237, 3886.68906487486, 3953.6244056814558, 3991.3214753491975, 4124.05146816228, 1165.7143999720122, 1358.8165597644388, 1365.3514580574347, 1367.446184295362, 1389.7012142389435, 1410.1891412437685, 1434.2685230532295, 1434.2828585707146, 1457.7886206499998, 1463.656040830404, 8270.766061134318, 8404.621792019374, 8414.410991230556, 8441.366897482714, 8450.154984501502, 1236.9505219791288, 1256.8868801807698, 1257.4970011995274, 1264.3741348032784, 1283.0120806978762, 6448.000559913221, 6485.156929599122, 6531.771388001397, 6559.24568674599, 6568.8357791055605, 10758.56965721378, 11162.939520745516, 11181.944090279496, 11255.43722813856, 11290.887091128983, 9032.548372581345, 10812.243142979916, 10914.126869850394, 11029.283096598696, 11082.944585277184, 8599.61301741423, 8645.178708022728, 8647.913520864837, 8692.391532592785, 8715.607797649121, 8152.796180095545, 8196.754097377088, 8206.261436470746, 8281.420300578902, 8289.0, 9751.268654850772, 9959.850602241117, 9966.700998970042, 9986.650467233612, 10048.296619236584, 10164.84752728695, 10254.538545765608, 10290.3825770454, 10410.167186625204, 10413.739656508647, 7680.231976802275, 7786.26030527099, 7852.293293603603, 7853.764387068397, 7871.685132594632, 7742.4193185510185, 7927.682892684459, 8384.161583841567, 8580.957095214484, 8581.313494920267, 7481.4014878808475, 7581.50720203185, 7588.354989825927, 7689.769306920802, 7723.266289702469, 7369.963150184215, 7415.666295016629, 7495.213002634645, 7506.1743208248145, 7590.0891892970985, 7863.252990965849, 7932.048154221299, 7948.443608947318, 7953.8409231813885, 7964.721234756756, 7262.854742905218, 7373.668184931584, 7379.704811807467, 7383.520071195355, 7383.741569045058, 7204.387627051759, 7374.151972523228, 7406.000189974285, 7417.369523590555, 7425.183229844604], "unit": "score", "name": "mootools.html", "value": 5133.485722950605}, {"lowerIsBetter": false, "replicates": [335.5889035930984, 340.95397121388606, 345.0786400311169, 345.90487615905613, 348.76109864742654, 6656.534042617012, 6714.294999025105, 6776.796696099119, 6798.116244888164, 6809.829754256146, 6668.066470694094, 6677.2988836172235, 6678.7996360109155, 6683.498737594688, 6688.699008544615, 4700.365450664168, 4790.616750659939, 4819.0, 4936.3829521309835, 4981.0037992401485, 4928.507149285078, 4930.4330002049865, 4932.679375840559, 4935.383077115361, 4966.230234313669, 4895.7062576245535, 4907.9263811042865, 4909.263610458442, 4912.361393018902, 4924.581410580105, 4721.7639118044135, 4772.164871147535, 4912.115819152551, 4932.284818701268, 4935.087008903364, 4226.936595951063, 4235.470566179228, 4237.724547904407, 4239.427677263591, 4249.150169965988, 5213.7393130343335, 6442.355764423567, 6448.355164483561, 6453.419192272718, 6453.806385808433, 5879.706014699248, 5889.381614930414, 5893.116032595102, 5899.46904778572, 5903.439173278532, 5833.854153646151, 6887.621180835052, 7121.074260346122, 7122.358987691081, 7134.286571342825, 4770.952290477086, 4784.880377990543, 4797.64017698674, 4810.158222311116, 4810.470848206694, 7430.6284685765495, 7498.66256018475, 7502.924970750277, 7506.887396689054, 7516.398688104939, 4867.951320486821, 4874.951885344668, 4877.122118018719, 4877.853664390074, 4884.462709101996, 4960.627952903546, 4961.355023846877, 4965.726885021359, 4974.552290293818, 4980.302757613937, 5611.3266408031295, 5850.824475265749, 5859.355470898197, 5859.619124756877, 5866.384029676822, 7151.928480715231, 7169.247229040876, 7171.569705817667, 7173.461990350745, 7186.676599553032, 1431.9785203221752, 1686.7132587460162, 1723.1901006527162, 1724.3188940368484, 1730.9394171203946, 911.2345629671108, 1058.2169194795795, 1118.4296009035288, 1126.7352172239516, 1153.2676750263643, 6542.476601871839, 6683.6658167091455, 6685.364890335508, 6687.130673012477, 6727.865442691216, 7459.291367320096, 7473.439492038119, 7479.065116860393, 7479.177290498041, 7486.064241969754, 6657.068010478537, 6729.798106056826, 6829.282925292872, 6846.828829279308, 6849.315068493211, 3762.9435558466644, 3905.824237909301, 3951.565327813938, 3959.7822119783114, 3960.742551734186, 7738.845223095619, 7817.648205830751, 7821.765347039598, 7830.960845195851, 7838.412119090977, 7719.536827790351, 7725.49784264021, 7738.110117336579, 7746.18665040174, 7750.418718596015, 7066.75266365685, 7112.359887610037, 7770.145284018753, 7793.298603125746, 7807.648655810616, 7269.821470335985, 7454.366378857858, 7492.70029198826, 7497.62511874415, 7499.66251518672, 7340.559566426032, 7371.4102871769055, 7385.778426647209, 7390.29792169743, 7393.593352365671, 7782.805429864298, 7792.0, 7816.921830781846, 7817.296443320129, 7821.960890195513, 4878.195097808822, 4890.095332363524, 4907.386576677915, 4912.48418916023, 4922.433920099091, 6105.481034111973, 6120.510359171167, 6247.468965138014, 7168.67740951648, 7422.740204092831, 6240.53196010292, 6798.76204332846, 7180.7845764627145, 7203.819904502219, 7210.96394518024, 7167.068281123421, 7318.560886346836, 7353.742619008309, 7359.668814903235, 7366.152892417226, 6977.95330700399, 6995.650217489207, 6998.790036298919, 7001.124859392576, 7022.789316320519, 6975.267596902252, 7198.316159964795, 7213.0, 7216.639168041472, 7223.458240632079, 5717.856428714357, 6742.932570674427, 6936.167659880846, 6949.965250173716, 6951.27011663768], "unit": "score", "name": "prototype.html", "value": 5251.409790224624}, {"lowerIsBetter": false, "replicates": [715.6994062493752, 773.3194788586044, 779.4660657449643, 785.4344871692387, 806.3307454812506, 14923.47767828125, 15173.468928587501, 15221.238938053108, 15228.695426091472, 15229.4669686561, 13831.654208644788, 13872.16766993981, 13901.374438150282, 13906.721865562682, 13931.303434828269, 791.4143533785016, 795.2484901767803, 955.1594596754846, 962.2398305338774, 989.9802003959917, 829.1915382502073, 976.3117002513246, 987.5062468765617, 997.2371136080868, 997.366672163178, 1041.4792603698152, 1046.5604446132643, 1048.3500229857461, 1049.9632512862051, 1052.252900440688, 840.7183593496155, 1032.1742605915238, 1059.8357254625546, 1060.496264274471, 1060.6870973062964, 764.0869161352186, 765.5138986743402, 765.663108232376, 765.8162041110149, 766.1610536462565, 15108.773368399483, 15114.470993515284, 15184.0, 15187.544373668808, 15190.772138417933, 12850.614481565568, 12983.31298331295, 13183.802242966363, 13336.933315333457, 13469.595912122651, 10255.384676919408, 10435.895641043568, 10466.52900619474, 10472.424016679079, 10504.317219380791, 3528.4530897710897, 3559.661832125944, 3588.67701906827, 3640.1627625645983, 3799.7530160539477, 83056.58471707664, 84362.57818710867, 84952.15047849443, 85052.57473712592, 85086.0, 9874.703758887244, 9881.604735810488, 10023.899761002442, 10028.598856045677, 10277.383356998604, 23974.28077157688, 23986.40033999164, 24008.39979000504, 24022.15922442741, 24024.639630405556, 7303.342699157101, 7405.740799072007, 7463.365613922769, 7637.19809420014, 7647.0, 4112.732672376286, 4113.341865301538, 4117.958820411817, 4132.483439570054, 4155.023569461174, 3711.0722319420147, 3762.7177961652988, 3763.8118094095184, 3765.7175711821724, 3773.396256598931, 596.3499785234116, 633.0915136778738, 651.2770824384929, 664.0736173038584, 737.0197637142587, 529.3039652856481, 572.4790440698944, 585.6486108334965, 612.4120843989731, 640.3756337570924, 8326.04250511187, 8390.580470976549, 8438.282745966539, 8490.745277641681, 8526.232639062515, 578.7713853028031, 584.693036156013, 604.703695189354, 617.5646169450526, 617.7436363909018, 3560.4481305397703, 3850.634189752025, 3886.397608370707, 3982.38273067675, 4026.2010030845304, 95445.09109817765, 96181.0, 96300.51849740706, 97250.02749972409, 98328.0, 82982.0, 83847.16152838393, 84792.0, 85667.71498427528, 86807.56596216979, 72444.27555724376, 72494.0, 73093.634531827, 74315.0, 74671.62664186645, 7762.262585054411, 7806.219378062148, 7991.841183028312, 8018.83962320762, 8045.235702608243, 47347.28979065248, 48430.757846211956, 48531.27203092027, 48734.02531949412, 49476.50523494719, 67055.66472167608, 71724.64137679279, 74896.0, 74946.0, 75583.62208188923, 11163.88836111661, 11263.324200547993, 11369.829452558053, 11544.307341559534, 11661.24201926872, 11067.335959842436, 11957.461914213707, 12167.756644866877, 12285.57000504978, 12550.246985180553, 11646.126540509666, 11984.76030479403, 11997.40012999364, 12072.3360215189, 12225.327606981346, 11587.826182607436, 11695.064394848561, 11776.941115294369, 11908.0, 12222.572209972608, 10991.835122473329, 11001.669949901516, 11609.88390116088, 11833.940830295793, 11839.467223975114, 9713.902860971582, 9912.603495860374, 9977.351472154287, 10044.54799534008, 10191.337563058378, 9658.71023869285, 9889.901100988898, 9953.253505987224, 9968.55141518619, 10083.14293285079], "unit": "score", "name": "yui.html", "value": 7150.074813729223}], "name": "dromaeo_css", "value": 7730.05492045109}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 110.0, 111.0, 110.0, 157.0, 147.0, 121.0, 154.0, 161.0, 114.0], "unit": "score", "name": "ai-astar", "value": 129.6}, {"lowerIsBetter": true, "replicates": [150.0, 117.0, 151.0, 146.0, 118.0, 135.0, 115.0, 148.0, 143.0, 116.0], "unit": "score", "name": "audio-beat-detection", "value": 133.9}, {"lowerIsBetter": true, "replicates": [185.0, 185.0, 188.0, 186.0, 181.0, 186.0, 184.0, 187.0, 184.0, 183.0], "unit": "score", "name": "audio-dft", "value": 184.9}, {"lowerIsBetter": true, "replicates": [74.0, 71.0, 75.0, 116.0, 56.0, 57.0, 57.0, 58.0, 116.0, 55.0], "unit": "score", "name": "audio-fft", "value": 73.5}, {"lowerIsBetter": true, "replicates": [92.0, 97.0, 129.0, 80.0, 78.0, 84.0, 117.0, 76.0, 80.0, 117.0], "unit": "score", "name": "audio-oscillator", "value": 95.0}, {"lowerIsBetter": true, "replicates": [88.0, 86.0, 89.0, 87.0, 88.0, 85.0, 88.0, 86.0, 89.0, 85.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 87.1}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 93.0, 96.0, 94.0, 92.0, 93.0, 93.0, 93.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 93.2}, {"lowerIsBetter": true, "replicates": [94.0, 130.0, 84.0, 87.0, 85.0, 87.0, 85.0, 83.0, 85.0, 86.0], "unit": "score", "name": "imaging-desaturate", "value": 90.6}, {"lowerIsBetter": true, "replicates": [53.0, 57.0, 57.0, 56.0, 56.0, 57.0, 57.0, 69.0, 54.0, 51.0], "unit": "score", "name": "json-parse-financial", "value": 56.7}, {"lowerIsBetter": true, "replicates": [63.0, 65.0, 71.0, 71.0, 69.0, 65.0, 65.0, 65.0, 66.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.6}, {"lowerIsBetter": true, "replicates": [80.0, 79.0, 80.0, 81.0, 80.0, 80.0, 79.0, 78.0, 80.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.0}, {"lowerIsBetter": true, "replicates": [117.0, 121.0, 127.0, 139.0, 117.0, 119.0, 116.0, 116.0, 127.0, 113.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.2}, {"lowerIsBetter": true, "replicates": [136.0, 143.0, 168.0, 181.0, 118.0, 144.0, 166.0, 170.0, 132.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.3}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 66.0, 80.0, 93.0, 73.0, 67.0, 66.0, 67.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.8}], "name": "kraken", "value": 1432.4}]} 02:02:41 INFO - Return code: 0 02:02:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:02:41 INFO - # TBPL SUCCESS # 02:02:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:02:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:02:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:02:41 INFO - 2016-03-11 02:02:41.792 screenresolution[1680:10421] starting screenresolution argv=screenresolution get 02:02:41 INFO - 2016-03-11 02:02:41.794 screenresolution[1680:10421] Display 0: 1600x1200x32@60 02:02:41 INFO - 2016-03-11 02:02:41.800 screenresolution[1681:10424] starting screenresolution argv=screenresolution list 02:02:41 INFO - Available Modes on Display 0 02:02:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:02:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:02:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:02:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:02:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:02:42 INFO - Intel Iris: 02:02:42 INFO - Chipset Model: Intel Iris 02:02:42 INFO - Type: GPU 02:02:42 INFO - Bus: Built-In 02:02:42 INFO - VRAM (Dynamic, Max): 1536 MB 02:02:42 INFO - Vendor: Intel (0x8086) 02:02:42 INFO - Device ID: 0x0a2e 02:02:42 INFO - Revision ID: 0x0009 02:02:42 INFO - Displays: 02:02:42 INFO - Display: 02:02:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:02:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:02:42 INFO - Display Serial Number: 1600x1200 60 02:02:42 INFO - Main Display: Yes 02:02:42 INFO - Mirror: Off 02:02:42 INFO - Online: Yes 02:02:42 INFO - Rotation: Supported 02:02:42 INFO - Return code: 0 02:02:42 INFO - Running post-action listener: _resource_record_post_action 02:02:42 INFO - Running post-run listener: _resource_record_post_run 02:02:43 INFO - Total resource usage - Wall time: 1203s; CPU: 52.0%; Read bytes: 32226816; Write bytes: 668690944; Read time: 323; Write time: 2028 02:02:43 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 361286144; Write bytes: 366894592; Read time: 28211; Write time: 719 02:02:43 INFO - run-tests - Wall time: 1172s; CPU: 52.0%; Read bytes: 30436864; Write bytes: 300264448; Read time: 303; Write time: 1304 02:02:43 INFO - Running post-run listener: _upload_blobber_files 02:02:43 INFO - Blob upload gear active. 02:02:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:02:43 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 02:02:43 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:02:43 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:02:43 INFO - (blobuploader) - INFO - Open directory for files ... 02:02:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:02:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:02:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:02:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:02:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:02:44 INFO - (blobuploader) - INFO - Done attempting. 02:02:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:02:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:02:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:02:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:02:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:02:45 INFO - (blobuploader) - INFO - Done attempting. 02:02:45 INFO - (blobuploader) - INFO - Iteration through files over. 02:02:45 INFO - Return code: 0 02:02:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:02:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:02:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7fa488f22b97162f26f07154e07773f6ed5244150386708b6efbb7154e7be1447fb9a3c97215bc0b1dfd4a57480e391955bf02f35c0599e54c0ba6df75958d6e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/08b887cde13497d239ee7132830390aa60e3e791a7dcf9dc544694db21a770a5144b0594032055958188a19d5ce2cd822ffb50df3735caa5070c1b1258500615"} 02:02:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:02:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:02:45 INFO - Contents: 02:02:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7fa488f22b97162f26f07154e07773f6ed5244150386708b6efbb7154e7be1447fb9a3c97215bc0b1dfd4a57480e391955bf02f35c0599e54c0ba6df75958d6e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/08b887cde13497d239ee7132830390aa60e3e791a7dcf9dc544694db21a770a5144b0594032055958188a19d5ce2cd822ffb50df3735caa5070c1b1258500615"} 02:02:45 INFO - Running post-run listener: copy_logs_to_upload_dir 02:02:45 INFO - Copying logs to upload dir... 02:02:45 INFO - mkdir: /builds/slave/test/build/upload/logs 02:02:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.050063 ========= master_lag: 81.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 42 secs) (at 2016-03-11 02:04:05.480797) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-03-11 02:04:05.490350) ========= 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.VnuCWPGHKv/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.nW2ZGFmwXJ/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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/Mozilla-Aurora/sha512/7fa488f22b97162f26f07154e07773f6ed5244150386708b6efbb7154e7be1447fb9a3c97215bc0b1dfd4a57480e391955bf02f35c0599e54c0ba6df75958d6e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/08b887cde13497d239ee7132830390aa60e3e791a7dcf9dc544694db21a770a5144b0594032055958188a19d5ce2cd822ffb50df3735caa5070c1b1258500615"} build_url:https://queue.taskcluster.net/v1/task/Wg-6U_9IR9y4kEbTbUTFAw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011726 build_url: 'https://queue.taskcluster.net/v1/task/Wg-6U_9IR9y4kEbTbUTFAw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7fa488f22b97162f26f07154e07773f6ed5244150386708b6efbb7154e7be1447fb9a3c97215bc0b1dfd4a57480e391955bf02f35c0599e54c0ba6df75958d6e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/08b887cde13497d239ee7132830390aa60e3e791a7dcf9dc544694db21a770a5144b0594032055958188a19d5ce2cd822ffb50df3735caa5070c1b1258500615"}' ========= master_lag: 1.47 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-03-11 02:04:06.970149) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 12 secs) (at 2016-03-11 02:04:06.970566) ========= 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.VnuCWPGHKv/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.nW2ZGFmwXJ/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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.005401 ========= master_lag: 12.66 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 12 secs) (at 2016-03-11 02:04:19.636831) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-11 02:04:19.637155) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-11 02:04:19.854189) ========= ========= Total master_lag: 127.16 =========