builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0120 starttime: 1457693892.28 results: success (0) buildid: 20160311004048 builduid: 1320f116008643de8d75923e9a2dc470 revision: 3bb19c9730afdd2501d08c88cd410fd04bd71c38 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 02:58:12.279396) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 02:58:12.306293) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-11 02:58:12.306735) ========= 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.VyBqeQXpct/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.bZ9MPa1mr0/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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.005453 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-11 02:58:12.333195) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-11 02:58:12.333507) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-11 02:58:12.355498) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 02:58:12.355768) ========= 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.VyBqeQXpct/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.bZ9MPa1mr0/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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.005339 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 02:58:12.404071) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 02:58:12.404334) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 02:58:12.407667) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 02:58:12.407946) ========= 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.VyBqeQXpct/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.bZ9MPa1mr0/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 02:58:12-- 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% 18.4M=0.001s 2016-03-11 02:58:12 (18.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110654 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 02:58:12.533514) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 02:58:12.536814) ========= 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.VyBqeQXpct/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.bZ9MPa1mr0/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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.020131 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 02:58:12.585000) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 02:58:12.585303) ========= 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.VyBqeQXpct/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.bZ9MPa1mr0/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 02:58:12,665 truncating revision to first 12 chars 2016-03-11 02:58:12,665 Setting DEBUG logging. 2016-03-11 02:58:12,665 attempt 1/10 2016-03-11 02:58:12,665 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 02:58:13,389 unpacking tar archive at: mozilla-aurora-3bb19c9730af/testing/mozharness/ program finished with exit code 0 elapsedTime=0.978757 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 02:58:13.584886) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 02:58:13.585234) ========= 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.VyBqeQXpct/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.bZ9MPa1mr0/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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.005104 script_repo_revision: '3bb19c9730afdd2501d08c88cd410fd04bd71c38' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 02:58:13.637036) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-11 02:58:13.637328) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-11 02:58:13.651431) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-03-11 02:58:13.651710) ========= /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.VyBqeQXpct/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.bZ9MPa1mr0/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 02:58:13 INFO - MultiFileLogger online at 20160311 02:58:13 in /builds/slave/test 02:58:13 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 02:58:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:58:13 INFO - {'append_to_log': False, 02:58:13 INFO - 'base_work_dir': '/builds/slave/test', 02:58:13 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:58:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:58:13 INFO - 'branch': 'Mozilla-Aurora', 02:58:13 INFO - 'buildbot_json_path': 'buildprops.json', 02:58:13 INFO - 'config_files': ('talos/mac_config.py',), 02:58:13 INFO - 'default_actions': ('clobber', 02:58:13 INFO - 'read-buildbot-config', 02:58:13 INFO - 'download-and-extract', 02:58:13 INFO - 'populate-webroot', 02:58:13 INFO - 'create-virtualenv', 02:58:13 INFO - 'install', 02:58:13 INFO - 'run-tests'), 02:58:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:58:13 INFO - 'download_minidump_stackwalk': True, 02:58:13 INFO - 'download_symbols': 'ondemand', 02:58:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:58:13 INFO - 'tooltool.py': '/tools/tooltool.py', 02:58:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:58:13 INFO - '/tools/misc-python/virtualenv.py')}, 02:58:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:58:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:58:13 INFO - 'installer_path': 'installer.exe', 02:58:13 INFO - 'log_level': 'info', 02:58:13 INFO - 'log_name': 'talos', 02:58:13 INFO - 'log_to_console': True, 02:58:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:58:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:58:13 INFO - 'opt_config_files': (), 02:58:13 INFO - 'pip_index': False, 02:58:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:58:13 INFO - 'cmd': ('bash', 02:58:13 INFO - '-c', 02:58:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:58:13 INFO - 'enabled': True, 02:58:13 INFO - 'halt_on_failure': False, 02:58:13 INFO - 'name': 'check_screen_resolution'},), 02:58:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:58:13 INFO - 'cmd': ('bash', 02:58:13 INFO - '-c', 02:58:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:58:13 INFO - 'enabled': True, 02:58:13 INFO - 'halt_on_failure': False, 02:58:13 INFO - 'name': 'check_screen_resolution'},), 02:58:13 INFO - 'run_cmd_checks_enabled': True, 02:58:13 INFO - 'sps_profile': False, 02:58:13 INFO - 'sps_profile_interval': 0, 02:58:13 INFO - 'suite': 'dromaeojs', 02:58:13 INFO - 'system_bits': '32', 02:58:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:58:13 INFO - 'title': 't-yosemite-r7-0120', 02:58:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:58:13 INFO - 'use_talos_json': True, 02:58:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:58:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:58:13 INFO - 'work_dir': 'build'} 02:58:13 INFO - ##### 02:58:13 INFO - ##### Running clobber step. 02:58:13 INFO - ##### 02:58:13 INFO - Running pre-action listener: _resource_record_pre_action 02:58:13 INFO - Running main action method: clobber 02:58:13 INFO - rmtree: /builds/slave/test/build 02:58:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:58:15 INFO - Running post-action listener: _resource_record_post_action 02:58:15 INFO - ##### 02:58:15 INFO - ##### Running read-buildbot-config step. 02:58:15 INFO - ##### 02:58:15 INFO - Running pre-action listener: _resource_record_pre_action 02:58:15 INFO - Running main action method: read_buildbot_config 02:58:15 INFO - Using buildbot properties: 02:58:15 INFO - { 02:58:15 INFO - "project": "", 02:58:15 INFO - "product": "firefox", 02:58:15 INFO - "script_repo_revision": "production", 02:58:15 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 02:58:15 INFO - "repository": "", 02:58:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 02:58:15 INFO - "buildid": "20160311004048", 02:58:15 INFO - "stage_platform": "macosx64", 02:58:15 INFO - "basedir": "/builds/slave/test", 02:58:15 INFO - "nightly_build": "True", 02:58:15 INFO - "buildnumber": 213, 02:58:15 INFO - "slavename": "t-yosemite-r7-0120", 02:58:15 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 02:58:15 INFO - "platform": "yosemite_r7", 02:58:15 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:58:15 INFO - "branch": "mozilla-aurora", 02:58:15 INFO - "repo_path": "releases/mozilla-aurora", 02:58:15 INFO - "revision": "3bb19c9730afdd2501d08c88cd410fd04bd71c38", 02:58:15 INFO - "pgo_build": "False", 02:58:15 INFO - "builduid": "1320f116008643de8d75923e9a2dc470", 02:58:15 INFO - "slavebuilddir": "test" 02:58:15 INFO - } 02:58:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/SA84dTW_Skaua555nkqQPQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 02:58:15 INFO - Running post-action listener: _resource_record_post_action 02:58:15 INFO - ##### 02:58:15 INFO - ##### Running download-and-extract step. 02:58:15 INFO - ##### 02:58:15 INFO - Running pre-action listener: _resource_record_pre_action 02:58:15 INFO - Running main action method: download_and_extract 02:58:15 INFO - mkdir: /builds/slave/test/build/tests 02:58:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:58:15 INFO - https://queue.taskcluster.net/v1/task/SA84dTW_Skaua555nkqQPQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 02:58:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SA84dTW_Skaua555nkqQPQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 02:58:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SA84dTW_Skaua555nkqQPQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 02:58:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SA84dTW_Skaua555nkqQPQ/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 02:58:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SA84dTW_Skaua555nkqQPQ/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 02:58:21 INFO - Downloaded 1277 bytes. 02:58:21 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 02:58:21 INFO - Using the following test package requirements: 02:58:21 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 02:58:21 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:58:21 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 02:58:21 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:58:21 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 02:58:21 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:58:21 INFO - u'jsshell-mac.zip'], 02:58:21 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:58:21 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 02:58:21 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 02:58:21 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:58:21 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 02:58:21 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:58:21 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 02:58:21 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:58:21 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 02:58:21 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 02:58:21 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:58:21 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 02:58:21 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:58:21 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')]} 02:58:21 INFO - https://queue.taskcluster.net/v1/task/SA84dTW_Skaua555nkqQPQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:58:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SA84dTW_Skaua555nkqQPQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:58:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SA84dTW_Skaua555nkqQPQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:58:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SA84dTW_Skaua555nkqQPQ/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 02:58:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SA84dTW_Skaua555nkqQPQ/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 02:58:25 INFO - Downloaded 17865118 bytes. 02:58:25 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'] 02:58:25 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 02:58:28 INFO - Return code: 0 02:58:28 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 02:58:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:58:28 INFO - https://queue.taskcluster.net/v1/task/SA84dTW_Skaua555nkqQPQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:58:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SA84dTW_Skaua555nkqQPQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:58:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SA84dTW_Skaua555nkqQPQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:58:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SA84dTW_Skaua555nkqQPQ/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 02:58:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SA84dTW_Skaua555nkqQPQ/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 02:58:30 INFO - Downloaded 17865118 bytes. 02:58:30 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'] 02:58:30 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 02:58:34 INFO - Return code: 0 02:58: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')]} 02:58:34 INFO - https://queue.taskcluster.net/v1/task/SA84dTW_Skaua555nkqQPQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:58:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SA84dTW_Skaua555nkqQPQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 02:58:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SA84dTW_Skaua555nkqQPQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 02:58:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SA84dTW_Skaua555nkqQPQ/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 02:58:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SA84dTW_Skaua555nkqQPQ/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 02:58:35 INFO - Downloaded 10845161 bytes. 02:58:35 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'] 02:58:35 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 02:58:36 INFO - Return code: 0 02:58:36 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')]} 02:58:36 INFO - https://queue.taskcluster.net/v1/task/SA84dTW_Skaua555nkqQPQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 02:58:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SA84dTW_Skaua555nkqQPQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:58:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SA84dTW_Skaua555nkqQPQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:58:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SA84dTW_Skaua555nkqQPQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 02:58:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SA84dTW_Skaua555nkqQPQ/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 02:58:42 INFO - Downloaded 115000571 bytes. 02:58:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SA84dTW_Skaua555nkqQPQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:58:42 INFO - mkdir: /builds/slave/test/properties 02:58:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:58:42 INFO - Writing to file /builds/slave/test/properties/build_url 02:58:42 INFO - Contents: 02:58:42 INFO - build_url:https://queue.taskcluster.net/v1/task/SA84dTW_Skaua555nkqQPQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:58:43 INFO - Running post-action listener: _resource_record_post_action 02:58:43 INFO - Running post-action listener: set_extra_try_arguments 02:58:43 INFO - ##### 02:58:43 INFO - ##### Running populate-webroot step. 02:58:43 INFO - ##### 02:58:43 INFO - Running pre-action listener: _resource_record_pre_action 02:58:43 INFO - Running main action method: populate_webroot 02:58:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:58:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:58:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:58:43 INFO - '--tppagecycles', 02:58:43 INFO - '7'], 02:58:43 INFO - 'tests': ['tsvgm']}}, 02:58:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:58:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:58:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:58:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 02:58:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:58:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:58:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:58:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:58:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:58:43 INFO - 'talos_options': ['--e10s'], 02:58:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:58:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:58:43 INFO - 'tests': ['damp', 'tps']}, 02:58:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:58:43 INFO - 'talos_options': ['--e10s'], 02:58:43 INFO - 'tests': ['damp', 'tps']}, 02:58:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:58:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:58:43 INFO - 'other': {'tests': ['a11yr', 02:58:43 INFO - 'ts_paint', 02:58:43 INFO - 'tpaint', 02:58:43 INFO - 'sessionrestore', 02:58:43 INFO - 'sessionrestore_no_auto_restore', 02:58:43 INFO - 'tabpaint']}, 02:58:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:58:43 INFO - 'tests': ['a11yr', 02:58:43 INFO - 'ts_paint', 02:58:43 INFO - 'tpaint', 02:58:43 INFO - 'sessionrestore', 02:58:43 INFO - 'sessionrestore_no_auto_restore', 02:58:43 INFO - 'tabpaint']}, 02:58:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:58:43 INFO - 'tests': ['a11yr', 02:58:43 INFO - 'ts_paint', 02:58:43 INFO - 'tpaint', 02:58:43 INFO - 'sessionrestore', 02:58:43 INFO - 'sessionrestore_no_auto_restore', 02:58:43 INFO - 'tabpaint']}, 02:58:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:58:43 INFO - 'tests': ['a11yr', 02:58:43 INFO - 'ts_paint', 02:58:43 INFO - 'tpaint', 02:58:43 INFO - 'sessionrestore', 02:58:43 INFO - 'sessionrestore_no_auto_restore', 02:58:43 INFO - 'tabpaint']}, 02:58:43 INFO - 'other_l64': {'tests': ['a11yr', 02:58:43 INFO - 'ts_paint', 02:58:43 INFO - 'tpaint', 02:58:43 INFO - 'sessionrestore', 02:58:43 INFO - 'sessionrestore_no_auto_restore', 02:58:43 INFO - 'tabpaint']}, 02:58:43 INFO - 'other_nol64': {'tests': ['a11yr', 02:58:43 INFO - 'ts_paint', 02:58:43 INFO - 'tpaint', 02:58:43 INFO - 'sessionrestore', 02:58:43 INFO - 'sessionrestore_no_auto_restore', 02:58:43 INFO - 'tabpaint']}, 02:58:43 INFO - 'svgr': {'tests': ['tsvgx', 02:58:43 INFO - 'tsvgr_opacity', 02:58:43 INFO - 'tart', 02:58:43 INFO - 'tscrollx', 02:58:43 INFO - 'cart']}, 02:58:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:58:43 INFO - 'tests': ['tsvgx', 02:58:43 INFO - 'tsvgr_opacity', 02:58:43 INFO - 'tart', 02:58:43 INFO - 'tscrollx', 02:58:43 INFO - 'cart']}, 02:58:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:58:43 INFO - 'tests': ['tp5o']}, 02:58:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:58:43 INFO - 'talos_options': ['--e10s'], 02:58:43 INFO - 'tests': ['tp5o']}, 02:58:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:58:43 INFO - 'talos_options': ['--xperf_path', 02:58:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:58:43 INFO - 'tests': ['tp5n']}, 02:58:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:58:43 INFO - 'talos_options': ['--e10s', 02:58:43 INFO - '--xperf_path', 02:58:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:58:43 INFO - 'tests': ['tp5n']}}, 02:58:43 INFO - 'talos.zip': {'path': '', 02:58:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:58:43 INFO - Running post-action listener: _resource_record_post_action 02:58:43 INFO - ##### 02:58:43 INFO - ##### Running create-virtualenv step. 02:58:43 INFO - ##### 02:58:43 INFO - Running pre-action listener: _resource_record_pre_action 02:58:43 INFO - Running main action method: create_virtualenv 02:58:43 INFO - Creating virtualenv /builds/slave/test/build/venv 02:58:43 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 02:58:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:58:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:58:43 INFO - Using real prefix '/tools/python27' 02:58:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:58:44 INFO - Installing distribute.............................................................................................................................................................................................done. 02:58:47 INFO - Installing pip.................done. 02:58:47 INFO - Return code: 0 02:58:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:58:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:58:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e152a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1594c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa838cb9810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dff6d30>, '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 0x10de5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfedb20>, '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.VyBqeQXpct/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.bZ9MPa1mr0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 02:58:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:58:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:58:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VyBqeQXpct/Render', 02:58:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:58:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:58:47 INFO - 'HOME': '/Users/cltbld', 02:58:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:58:47 INFO - 'LOGNAME': 'cltbld', 02:58:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:47 INFO - 'MOZ_NO_REMOTE': '1', 02:58:47 INFO - 'NO_EM_RESTART': '1', 02:58:47 INFO - 'PAGER': '/bin/cat', 02:58:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:58:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:47 INFO - 'PWD': '/builds/slave/test', 02:58:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:58:47 INFO - 'SHELL': '/bin/bash', 02:58:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bZ9MPa1mr0/Listeners', 02:58:47 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 02:58:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:58:47 INFO - 'USER': 'cltbld', 02:58:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:58:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:58:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:47 INFO - 'XPC_FLAGS': '0x0', 02:58:47 INFO - 'XPC_SERVICE_NAME': '0', 02:58:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:58:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:47 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 02:58:47 INFO - Cleaning up... 02:58:47 INFO - Return code: 0 02:58:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:58:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:58:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e152a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1594c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa838cb9810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dff6d30>, '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 0x10de5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfedb20>, '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.VyBqeQXpct/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.bZ9MPa1mr0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 02:58:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:58:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:58:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VyBqeQXpct/Render', 02:58:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:58:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:58:47 INFO - 'HOME': '/Users/cltbld', 02:58:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:58:47 INFO - 'LOGNAME': 'cltbld', 02:58:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:47 INFO - 'MOZ_NO_REMOTE': '1', 02:58:47 INFO - 'NO_EM_RESTART': '1', 02:58:47 INFO - 'PAGER': '/bin/cat', 02:58:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:58:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:47 INFO - 'PWD': '/builds/slave/test', 02:58:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:58:47 INFO - 'SHELL': '/bin/bash', 02:58:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bZ9MPa1mr0/Listeners', 02:58:47 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 02:58:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:58:47 INFO - 'USER': 'cltbld', 02:58:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:58:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:58:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:47 INFO - 'XPC_FLAGS': '0x0', 02:58:47 INFO - 'XPC_SERVICE_NAME': '0', 02:58:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:58:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:47 INFO - Downloading/unpacking psutil>=0.7.1 02:58:47 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 02:58:47 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 02:58:47 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 02:58:47 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 02:58:47 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 02:58:47 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 02:58:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:58:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:58:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:58:50 INFO - Installing collected packages: psutil 02:58:50 INFO - Running setup.py install for psutil 02:58:50 INFO - building 'psutil._psutil_osx' extension 02:58:50 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 02:58:50 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 02:58:50 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 02:58:51 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 02:58:51 INFO - building 'psutil._psutil_posix' extension 02:58:51 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 02:58:51 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:58:51 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:58:51 INFO - ^ 02:58:51 INFO - 1 warning generated. 02:58:51 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 02:58:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:58:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:58:51 INFO - Successfully installed psutil 02:58:51 INFO - Cleaning up... 02:58:51 INFO - Return code: 0 02:58:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:58:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:58:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e152a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1594c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa838cb9810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dff6d30>, '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 0x10de5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfedb20>, '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.VyBqeQXpct/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.bZ9MPa1mr0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 02:58:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:58:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 02:58:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VyBqeQXpct/Render', 02:58:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:58:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:58:51 INFO - 'HOME': '/Users/cltbld', 02:58:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:58:51 INFO - 'LOGNAME': 'cltbld', 02:58:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:51 INFO - 'MOZ_NO_REMOTE': '1', 02:58:51 INFO - 'NO_EM_RESTART': '1', 02:58:51 INFO - 'PAGER': '/bin/cat', 02:58:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:58:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:51 INFO - 'PWD': '/builds/slave/test', 02:58:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:58:51 INFO - 'SHELL': '/bin/bash', 02:58:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bZ9MPa1mr0/Listeners', 02:58:51 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 02:58:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:58:51 INFO - 'USER': 'cltbld', 02:58:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:58:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:58:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:51 INFO - 'XPC_FLAGS': '0x0', 02:58:51 INFO - 'XPC_SERVICE_NAME': '0', 02:58:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:58:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:58:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:58:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:58:54 INFO - Installing collected packages: mozsystemmonitor 02:58:54 INFO - Running setup.py install for mozsystemmonitor 02:58:54 INFO - Successfully installed mozsystemmonitor 02:58:54 INFO - Cleaning up... 02:58:54 INFO - Return code: 0 02:58:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:58:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:58:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e152a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1594c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa838cb9810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dff6d30>, '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 0x10de5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfedb20>, '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.VyBqeQXpct/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.bZ9MPa1mr0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 02:58:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:58:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:58:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VyBqeQXpct/Render', 02:58:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:58:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:58:54 INFO - 'HOME': '/Users/cltbld', 02:58:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:58:54 INFO - 'LOGNAME': 'cltbld', 02:58:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:54 INFO - 'MOZ_NO_REMOTE': '1', 02:58:54 INFO - 'NO_EM_RESTART': '1', 02:58:54 INFO - 'PAGER': '/bin/cat', 02:58:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:58:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:54 INFO - 'PWD': '/builds/slave/test', 02:58:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:58:54 INFO - 'SHELL': '/bin/bash', 02:58:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bZ9MPa1mr0/Listeners', 02:58:54 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 02:58:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:58:54 INFO - 'USER': 'cltbld', 02:58:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:58:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:58:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:54 INFO - 'XPC_FLAGS': '0x0', 02:58:54 INFO - 'XPC_SERVICE_NAME': '0', 02:58:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:58:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:54 INFO - Downloading/unpacking blobuploader==1.2.4 02:58:54 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 02:58:54 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 02:58:54 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 02:58:54 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 02:58:54 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 02:58:54 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 02:58:56 INFO - Downloading blobuploader-1.2.4.tar.gz 02:58:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:58:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:58:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:57 INFO - Downloading docopt-0.6.1.tar.gz 02:58:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:58:58 INFO - Installing collected packages: blobuploader, requests, docopt 02:58:58 INFO - Running setup.py install for blobuploader 02:58:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:58:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:58:58 INFO - Running setup.py install for requests 02:58:58 INFO - Running setup.py install for docopt 02:58:58 INFO - Successfully installed blobuploader requests docopt 02:58:58 INFO - Cleaning up... 02:58:58 INFO - Return code: 0 02:58:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:58:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:58:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:58 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 0x10e152a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1594c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa838cb9810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dff6d30>, '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 0x10de5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfedb20>, '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.VyBqeQXpct/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.bZ9MPa1mr0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 02:58:58 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 02:58:58 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 02:58:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VyBqeQXpct/Render', 02:58:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:58:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:58:58 INFO - 'HOME': '/Users/cltbld', 02:58:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:58:58 INFO - 'LOGNAME': 'cltbld', 02:58:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:58 INFO - 'MOZ_NO_REMOTE': '1', 02:58:58 INFO - 'NO_EM_RESTART': '1', 02:58:58 INFO - 'PAGER': '/bin/cat', 02:58:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:58:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:58 INFO - 'PWD': '/builds/slave/test', 02:58:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:58:58 INFO - 'SHELL': '/bin/bash', 02:58:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bZ9MPa1mr0/Listeners', 02:58:58 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 02:58:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:58:58 INFO - 'USER': 'cltbld', 02:58:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:58:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:58:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:58 INFO - 'XPC_FLAGS': '0x0', 02:58:58 INFO - 'XPC_SERVICE_NAME': '0', 02:58:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:58:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:58:59 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-t4f0Zl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:58:59 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-cez4za-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:58:59 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-nnB18O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:58:59 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-ywUxM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:58:59 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-opjwgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:58:59 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-ldRnLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:58:59 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-23g9Ey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:58:59 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-fyctGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:59:00 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-YWYxPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:59:00 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-tPQfiB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:59:00 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-fH3bJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:59:00 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-iOGO92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:59:00 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-jUPg1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:59:00 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-j64xkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:59:00 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-elfFTv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:59:00 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-DmbrD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:59:00 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-kt8W8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:59:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:59:00 INFO - Running setup.py install for manifestparser 02:59:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:59:01 INFO - Running setup.py install for mozcrash 02:59:01 INFO - Running setup.py install for mozdebug 02:59:01 INFO - Running setup.py install for mozdevice 02:59:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:59:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:59:01 INFO - Running setup.py install for mozfile 02:59:01 INFO - Running setup.py install for mozhttpd 02:59:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:59:01 INFO - Running setup.py install for mozinfo 02:59:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:59:01 INFO - Running setup.py install for mozInstall 02:59:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:59:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:59:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:59:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:59:02 INFO - Running setup.py install for mozleak 02:59:02 INFO - Running setup.py install for mozlog 02:59:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:59:02 INFO - Running setup.py install for moznetwork 02:59:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:59:02 INFO - Running setup.py install for mozprocess 02:59:02 INFO - Running setup.py install for mozprofile 02:59:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:59:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:59:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:59:02 INFO - Running setup.py install for mozrunner 02:59:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:59:03 INFO - Running setup.py install for mozscreenshot 02:59:03 INFO - Running setup.py install for moztest 02:59:03 INFO - Running setup.py install for mozversion 02:59:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:59:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:59:03 INFO - Cleaning up... 02:59:03 INFO - Return code: 0 02:59:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:59:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:59:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:03 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 0x10e152a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1594c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa838cb9810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dff6d30>, '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 0x10de5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfedb20>, '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.VyBqeQXpct/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.bZ9MPa1mr0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 02:59:03 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 02:59:03 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 02:59:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VyBqeQXpct/Render', 02:59:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:59:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:59:03 INFO - 'HOME': '/Users/cltbld', 02:59:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:59:03 INFO - 'LOGNAME': 'cltbld', 02:59:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:03 INFO - 'MOZ_NO_REMOTE': '1', 02:59:03 INFO - 'NO_EM_RESTART': '1', 02:59:03 INFO - 'PAGER': '/bin/cat', 02:59:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:59:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:03 INFO - 'PWD': '/builds/slave/test', 02:59:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:59:03 INFO - 'SHELL': '/bin/bash', 02:59:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bZ9MPa1mr0/Listeners', 02:59:03 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 02:59:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:59:03 INFO - 'USER': 'cltbld', 02:59:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:59:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:59:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:03 INFO - 'XPC_FLAGS': '0x0', 02:59:03 INFO - 'XPC_SERVICE_NAME': '0', 02:59:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:59:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:59:03 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-z6Mb1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:59:03 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)) 02:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:59:03 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-TWtrmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:59:03 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)) 02:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:59:03 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-Ikb0u8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:59:04 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-6903KX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:59:04 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-jRRCK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:59:04 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-Pw0423-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:59:04 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-08P23z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:59:04 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)) 02:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:59:04 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-72E4vf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:59:04 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)) 02:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:59:04 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-DIIjSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:59:04 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)) 02:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:59:04 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-wslMnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:59:04 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)) 02:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:59:04 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-l1SCm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:59:04 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)) 02:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:59:04 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-qzUtFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:59:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:59:05 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-L0JFbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:59:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:59:05 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-x4jdQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:59:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:59:05 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-B9eNH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:59:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:59:05 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-VZIbGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:59:05 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)) 02:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:59:05 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-7gwkn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:59:05 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)) 02:59:05 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)) 02:59:05 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)) 02:59:05 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)) 02:59:05 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)) 02:59:05 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)) 02:59:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:59:05 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 02:59:05 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 02:59:05 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 02:59:05 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 02:59:05 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 02:59:05 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 02:59:07 INFO - Downloading blessings-1.6.tar.gz 02:59:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:59:08 INFO - Installing collected packages: blessings 02:59:08 INFO - Running setup.py install for blessings 02:59:08 INFO - Successfully installed blessings 02:59:08 INFO - Cleaning up... 02:59:08 INFO - Return code: 0 02:59:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:59:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:59:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:59:08 INFO - Reading from file tmpfile_stdout 02:59:08 INFO - Current package versions: 02:59:08 INFO - blessings == 1.6 02:59:08 INFO - blobuploader == 1.2.4 02:59:08 INFO - docopt == 0.6.1 02:59:08 INFO - manifestparser == 1.1 02:59:08 INFO - mozInstall == 1.12 02:59:08 INFO - mozcrash == 0.17 02:59:08 INFO - mozdebug == 0.1 02:59:08 INFO - mozdevice == 0.48 02:59:08 INFO - mozfile == 1.2 02:59:08 INFO - mozhttpd == 0.7 02:59:08 INFO - mozinfo == 0.9 02:59:08 INFO - mozleak == 0.1 02:59:08 INFO - mozlog == 3.1 02:59:08 INFO - moznetwork == 0.27 02:59:08 INFO - mozprocess == 0.22 02:59:08 INFO - mozprofile == 0.28 02:59:08 INFO - mozrunner == 6.11 02:59:08 INFO - mozscreenshot == 0.1 02:59:08 INFO - mozsystemmonitor == 0.0 02:59:08 INFO - moztest == 0.7 02:59:08 INFO - mozversion == 1.4 02:59:08 INFO - psutil == 3.1.1 02:59:08 INFO - requests == 1.2.3 02:59:08 INFO - wsgiref == 0.1.2 02:59:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:59: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')]} 02:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59: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')]} 02:59:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:08 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 0x10e152a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1594c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa838cb9810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dff6d30>, '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 0x10de5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfedb20>, '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.VyBqeQXpct/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.bZ9MPa1mr0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 02:59:08 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 02:59:08 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 02:59:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VyBqeQXpct/Render', 02:59:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:59:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:59:08 INFO - 'HOME': '/Users/cltbld', 02:59:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:59:08 INFO - 'LOGNAME': 'cltbld', 02:59:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:08 INFO - 'MOZ_NO_REMOTE': '1', 02:59:08 INFO - 'NO_EM_RESTART': '1', 02:59:08 INFO - 'PAGER': '/bin/cat', 02:59:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:59:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:08 INFO - 'PWD': '/builds/slave/test', 02:59:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:59:08 INFO - 'SHELL': '/bin/bash', 02:59:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bZ9MPa1mr0/Listeners', 02:59:08 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 02:59:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:59:08 INFO - 'USER': 'cltbld', 02:59:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:59:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:59:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:08 INFO - 'XPC_FLAGS': '0x0', 02:59:08 INFO - 'XPC_SERVICE_NAME': '0', 02:59:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:59:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:08 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)) 02:59:08 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)) 02:59:08 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)) 02:59:08 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)) 02:59:08 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)) 02:59:08 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)) 02:59:08 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)) 02:59:08 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)) 02:59:08 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)) 02:59:08 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)) 02:59:08 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)) 02:59:08 INFO - Cleaning up... 02:59:08 INFO - Return code: 0 02:59:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:59: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')]} 02:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59: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')]} 02:59:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e152a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1594c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa838cb9810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dff6d30>, '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 0x10de5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfedb20>, '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.VyBqeQXpct/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.bZ9MPa1mr0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 02:59: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', 'jsonschema'] in /builds/slave/test/build 02:59: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 jsonschema 02:59:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VyBqeQXpct/Render', 02:59:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:59:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:59:08 INFO - 'HOME': '/Users/cltbld', 02:59:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:59:08 INFO - 'LOGNAME': 'cltbld', 02:59:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:08 INFO - 'MOZ_NO_REMOTE': '1', 02:59:08 INFO - 'NO_EM_RESTART': '1', 02:59:08 INFO - 'PAGER': '/bin/cat', 02:59:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:59:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:08 INFO - 'PWD': '/builds/slave/test', 02:59:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:59:08 INFO - 'SHELL': '/bin/bash', 02:59:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bZ9MPa1mr0/Listeners', 02:59:08 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 02:59:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:59:08 INFO - 'USER': 'cltbld', 02:59:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:59:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:59:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:08 INFO - 'XPC_FLAGS': '0x0', 02:59:08 INFO - 'XPC_SERVICE_NAME': '0', 02:59:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:59:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:09 INFO - Downloading/unpacking jsonschema 02:59: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 02:59: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 02:59: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 02:59: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 02:59: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 02:59: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 02:59:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:59:11 INFO - Downloading/unpacking functools32 (from jsonschema) 02:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:12 INFO - Downloading functools32-3.2.3-2.tar.gz 02:59:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:59:12 INFO - warning: no files found matching '*.txt' 02:59:12 INFO - no previously-included directories found matching 'build' 02:59:12 INFO - no previously-included directories found matching 'dist' 02:59:12 INFO - no previously-included directories found matching '.git*' 02:59:12 INFO - Installing collected packages: jsonschema, functools32 02:59:12 INFO - Running setup.py install for functools32 02:59:12 INFO - warning: no files found matching '*.txt' 02:59:12 INFO - no previously-included directories found matching 'build' 02:59:12 INFO - no previously-included directories found matching 'dist' 02:59:12 INFO - no previously-included directories found matching '.git*' 02:59:12 INFO - Successfully installed jsonschema functools32 02:59:12 INFO - Cleaning up... 02:59:12 INFO - Return code: 0 02:59:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:59:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:59:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59: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')]} 02:59:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e152a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1594c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa838cb9810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dff6d30>, '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 0x10de5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfedb20>, '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.VyBqeQXpct/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.bZ9MPa1mr0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 02:59: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', 'flake8'] in /builds/slave/test/build 02:59: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 flake8 02:59:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VyBqeQXpct/Render', 02:59:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:59:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:59:13 INFO - 'HOME': '/Users/cltbld', 02:59:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:59:13 INFO - 'LOGNAME': 'cltbld', 02:59:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:13 INFO - 'MOZ_NO_REMOTE': '1', 02:59:13 INFO - 'NO_EM_RESTART': '1', 02:59:13 INFO - 'PAGER': '/bin/cat', 02:59:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:59:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:13 INFO - 'PWD': '/builds/slave/test', 02:59:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:59:13 INFO - 'SHELL': '/bin/bash', 02:59:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bZ9MPa1mr0/Listeners', 02:59:13 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 02:59:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:59:13 INFO - 'USER': 'cltbld', 02:59:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:59:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:59:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:13 INFO - 'XPC_FLAGS': '0x0', 02:59:13 INFO - 'XPC_SERVICE_NAME': '0', 02:59:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:59:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:13 INFO - Downloading/unpacking flake8 02:59: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 02:59: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 02:59: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 02:59: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 02:59: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 02:59: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 02:59:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:59:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:59:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:59: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 02:59: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 02:59: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 02:59: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 02:59: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 02:59: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 02:59:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:59: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 02:59: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 02:59: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 02:59: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 02:59: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 02:59: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 02:59:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:59:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:59:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:59:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:59:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:59:17 INFO - no previously-included directories found matching 'docs/_build' 02:59:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:59:17 INFO - Running setup.py install for pep8 02:59:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:59:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:59:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:59:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:59:17 INFO - no previously-included directories found matching 'docs/_build' 02:59:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:59:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:59:17 INFO - Cleaning up... 02:59:17 INFO - Return code: 0 02:59:17 INFO - Running post-action listener: _resource_record_post_action 02:59:17 INFO - Running post-action listener: _start_resource_monitoring 02:59:17 INFO - Starting resource monitoring. 02:59:17 INFO - ##### 02:59:17 INFO - ##### Running install step. 02:59:17 INFO - ##### 02:59:17 INFO - Running pre-action listener: _resource_record_pre_action 02:59:17 INFO - Running main action method: install 02:59:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:59:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:59:17 INFO - Reading from file tmpfile_stdout 02:59:17 INFO - Detecting whether we're running mozinstall >=1.0... 02:59:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:59:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:59:17 INFO - Reading from file tmpfile_stdout 02:59:17 INFO - Output received: 02:59:17 INFO - Usage: mozinstall [options] installer 02:59:17 INFO - Options: 02:59:17 INFO - -h, --help show this help message and exit 02:59:17 INFO - -d DEST, --destination=DEST 02:59:17 INFO - Directory to install application into. [default: 02:59:17 INFO - "/builds/slave/test"] 02:59:17 INFO - --app=APP Application being installed. [default: firefox] 02:59:17 INFO - mkdir: /builds/slave/test/build/application 02:59:17 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'] 02:59:17 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 02:59:49 INFO - Reading from file tmpfile_stdout 02:59:49 INFO - Output received: 02:59:49 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:59:49 INFO - Running post-action listener: _resource_record_post_action 02:59:49 INFO - ##### 02:59:49 INFO - ##### Running run-tests step. 02:59:49 INFO - ##### 02:59:49 INFO - Running pre-action listener: _resource_record_pre_action 02:59:49 INFO - Running main action method: run_tests 02:59:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:59:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:59:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:59:49 INFO - 2016-03-11 02:59:49.962 screenresolution[1920:12891] starting screenresolution argv=screenresolution get 02:59:49 INFO - 2016-03-11 02:59:49.965 screenresolution[1920:12891] Display 0: 1600x1200x32@60 02:59:49 INFO - 2016-03-11 02:59:49.971 screenresolution[1921:12893] starting screenresolution argv=screenresolution list 02:59:49 INFO - Available Modes on Display 0 02:59:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:59:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:59:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:59:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:59:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:59:50 INFO - Intel Iris: 02:59:50 INFO - Chipset Model: Intel Iris 02:59:50 INFO - Type: GPU 02:59:50 INFO - Bus: Built-In 02:59:50 INFO - VRAM (Dynamic, Max): 1536 MB 02:59:50 INFO - Vendor: Intel (0x8086) 02:59:50 INFO - Device ID: 0x0a2e 02:59:50 INFO - Revision ID: 0x0009 02:59:50 INFO - Displays: 02:59:50 INFO - Display: 02:59:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:59:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:59:50 INFO - Display Serial Number: 1600x1200 60 02:59:50 INFO - Main Display: Yes 02:59:50 INFO - Mirror: Off 02:59:50 INFO - Online: Yes 02:59:50 INFO - Rotation: Supported 02:59:50 INFO - Return code: 0 02:59:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:59:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:59:50 INFO - Python 2.7.3 02:59:50 INFO - Return code: 0 02:59:50 INFO - grabbing minidump binary from tooltool 02:59:50 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')]} 02:59:50 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 0x10dff6d30>, '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 0x10de5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfedb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:59:50 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 02:59:50 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 02:59:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:59:50 INFO - Return code: 0 02:59:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:59:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:59:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:59:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:59:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:59:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:59:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:59:51 INFO - Return code: 0 02:59:51 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/SA84dTW_Skaua555nkqQPQ/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0120', '--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 02:59:51 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/SA84dTW_Skaua555nkqQPQ/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0120 --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 02:59:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VyBqeQXpct/Render', 02:59:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:59:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:59:51 INFO - 'HOME': '/Users/cltbld', 02:59:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:59:51 INFO - 'LOGNAME': 'cltbld', 02:59:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:59:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:51 INFO - 'MOZ_NO_REMOTE': '1', 02:59:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:59:51 INFO - 'NO_EM_RESTART': '1', 02:59:51 INFO - 'PAGER': '/bin/cat', 02:59:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:51 INFO - 'PWD': '/builds/slave/test', 02:59:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:59:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:59:51 INFO - 'SHELL': '/bin/bash', 02:59:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bZ9MPa1mr0/Listeners', 02:59:51 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 02:59:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:59:51 INFO - 'USER': 'cltbld', 02:59:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:59:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:51 INFO - 'XPC_FLAGS': '0x0', 02:59:51 INFO - 'XPC_SERVICE_NAME': '0', 02:59:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:59:51 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/SA84dTW_Skaua555nkqQPQ/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0120', '--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 02:59:51 INFO - mozversion application_buildid: 20160311004048 02:59:51 INFO - mozversion application_changeset: 3bb19c9730afdd2501d08c88cd410fd04bd71c38 02:59:51 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:59:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:59:51 INFO - mozversion application_name: Firefox 02:59:51 INFO - mozversion application_remotingname: firefox-dev 02:59:51 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:59:51 INFO - mozversion application_vendor: Mozilla 02:59:51 INFO - mozversion application_version: 47.0a2 02:59:51 INFO - mozversion platform_buildid: 20160311004048 02:59:51 INFO - mozversion platform_changeset: 3bb19c9730afdd2501d08c88cd410fd04bd71c38 02:59:51 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:59:51 INFO - mozversion platform_version: 47.0a2 02:59:51 INFO - using testdate: 1457693991 02:59:51 INFO - actual date: 1457693991 02:59:51 INFO - starting webserver on 'localhost:49857' 02:59:51 INFO - SUITE-START | Running 2 tests 02:59:51 INFO - TEST-START | dromaeo_css 02:59:51 INFO - operating with platform_type : mac_ 02:59:51 INFO - Initialising browser for dromaeo_css test... 02:59:51 INFO - TEST-INFO | started process 1939 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/tmpdKfSV7/profile http://localhost:49857/getInfo.html) 02:59:54 INFO - PROCESS | 1939 | __metrics Screen width/height:1600/1200 02:59:54 INFO - PROCESS | 1939 | colorDepth:24 02:59:54 INFO - PROCESS | 1939 | Browser inner width/height: 1024/689 02:59:54 INFO - PROCESS | 1939 | __metrics 02:59:54 INFO - PROCESS | 1939 | 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:59:54 INFO - PROCESS | 1939 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:59:54 INFO - TEST-INFO | 1939: exit 0 02:59:54 INFO - Browser initialized. 02:59:54 INFO - Running cycle 1/1 for dromaeo_css test... 02:59:54 INFO - TEST-INFO | started process 1942 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/tmpdKfSV7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:00:06 INFO - PROCESS | 1942 | RSS: Main: 210366464 03:00:06 INFO - PROCESS | 1942 | 03:00:58 INFO - PROCESS | 1942 | 1457694058211 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] 03:03:08 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:49857/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49857/tests/dromaeo/cssquery-ext.html) 03:03:09 INFO - PROCESS | 1942 | RSS: Main: 329482240 03:03:09 INFO - PROCESS | 1942 | 03:06:12 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:49857/tests/dromaeo/cssquery-ext.html (next: http://localhost:49857/tests/dromaeo/cssquery-jquery.html) 03:06:12 INFO - PROCESS | 1942 | RSS: Main: 345722880 03:06:12 INFO - PROCESS | 1942 | 03:09:14 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:49857/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49857/tests/dromaeo/cssquery-mootools.html) 03:09:15 INFO - PROCESS | 1942 | RSS: Main: 347377664 03:09:15 INFO - PROCESS | 1942 | 03:12:17 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:49857/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49857/tests/dromaeo/cssquery-prototype.html) 03:12:17 INFO - PROCESS | 1942 | RSS: Main: 303636480 03:12:17 INFO - PROCESS | 1942 | 03:15:20 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:49857/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49857/tests/dromaeo/cssquery-yui.html) 03:15:21 INFO - PROCESS | 1942 | RSS: Main: 307712000 03:15:21 INFO - PROCESS | 1942 | 03:18:24 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:49857/tests/dromaeo/cssquery-yui.html (next: http://localhost:49857/tests/dromaeo/cssquery-dojo.html) 03:18:24 INFO - PROCESS | 1942 | RSS: Main: 419897344 03:18:24 INFO - PROCESS | 1942 | 03:18:24 INFO - PROCESS | 1942 | __start_tp_report 03:18:24 INFO - PROCESS | 1942 | _x_x_mozilla_page_load 03:18:24 INFO - PROCESS | 1942 | _x_x_mozilla_page_load_details 03:18:24 INFO - PROCESS | 1942 | |i|pagename|runs| 03:18:24 INFO - PROCESS | 1942 | |0;dojo.html;2912.635920509936;3521.2957408518287;3546.1843775931534;3552.1474846036926;3600.649756341372;5895.0862616294435;5897.705114744262;5906.114082887569;5921.052631578948;5975.103734439836;5875.676837773921;5908.1433192187105;5926.4073592640825;5935.258092738408;5947.970260148704;5176.016556854186;5220.425753167148;5232.241325007872;5255.527002569768;5308.283381743473;5291.894162116755;5305.1776974569;5311.389190243113;5320.654157479771;5326.946730532703;5092.541671249587;5123.205903085028;5137.434882162959;5163.948360516403;5305.973470132644;5320.441353657869;5339.172428273643;5355.946440535584;5361.2226227197225;5406.297181366436;5075.5939524838295;5267.683938963636;5269.1569348903995;5302.045631786277;5308.681479111227;5678.829635110953;5777.306723193244;5781.075027995501;5782.826515204509;5802.535797136219;6156.538259630545;6250.6874656267455;6256.749730010794;6257.906131408033;6265.71804268809;6241.438270555626;6280.78017269398;6303.275123360826;6317.810465686037;6322.87354252917;6014.007688731398;6017.428344307284;6030.698465076729;6037.4566289033755;6043.184170137063;6282.905756413657;6335.873282534323;6369.585976911486;6379.71291291893;6407.423331900151;6205.131281620576;6236.970899801482;6239.0953311770445;6257.906131408033;6262.1546091278005;6285.59143655661;6297.086922396227;6301.6219026858535;6303.180586523814;6307.400796924377;6168.982117950578;6181.907271390933;6208.00671892495;6242.719077641517;6269.498440124779;6176.66028368435;6249.406306400884;6254.280757712831;6275.96862015687;6281.371862813682;4965.90068198634;4969.981153863449;4989.600831933437;4996.975015124901;5001.074801161797;4446.577575130357;4465.977670111629;4515.887102822456;4532.524084971096;4557.020240648277;5927.555433342516;5931.11033344993;5945.910811337833;5957.702114894325;5962.552808539377;6275.623462592259;6290.245170579468;6294.496440284766;6304.747810087545;6314.873702525923;5803.506701930299;5865.061590145641;5876.853078673067;5960.970195149083;5966.612170208922;5434.755436005389;5478.45215478449;5494.313210848644;5498.5876059295715;5517.475839795213;6457.644829534421;6469.741210351627;6488.091667166506;6495.935040649628;6538.83652908662;5486.945130548803;6174.536909731698;6266.122742815918;6302.779402720883;6328.177336946167;6463.353664633687;6470.741170353322;6475.902861456988;6485;6487.156669632917;6107.886786452593;6220.284667263141;6245.375462453719;6257.092721555258;6281.52888533371;6158.938410615837;6228.688565571794;6235.282942461675;6268.686565671607;6305.495560355069;6110.358412366815;6131.202943617302;6140.723667434887;6140.815775526741;6154;6039.4262545058145;6110.236220472441;6130.50955923534;6136.018237082046;6147.692615369303;6060.333363330118;6115.6330620162935;6120.908186377297;6128.717018009349;6130.214697154933;6143.262808463013;6145.293291271561;6145.508359331332;6145.84635384119;6156.29202641702;6042.456178943916;6043.607165534227;6103.23709536308;6131.264248290056;6144.986077297196 03:18:24 INFO - PROCESS | 1942 | |1;ext.html;523.5654406842322;578.4909279833747;601.8955217176479;620.6400287833058;659.8053574195612;31803;32264.87072952447;32297;32317.67682323179;32348.67651323486;27854.442911141767;39179.21641567174;41969;42010.78994605023;42098.57901420985;9615.56729947154;9795.167410770093;9832.06595373442;9834.31159818813;9840;9685.564149613248;9815.067568580973;9831;9836.458994755285;9865.802683946316;9762.170215531689;9838.950805245964;9847.90152098477;9855.408675479459;9861.852072218922;9740.853887191697;9868.309218354718;9869.753256168582;9871.506424678737;9912.15746661531;9664.420134791935;9804.411735295906;9805.117539421415;9807.607695692164;9809.705708828747;41505;41837;41879.953001175214;41882.37176442356;41943.370849437284;3220.339830334776;3387.983060084684;3418.2308980479443;3689.9815500922323;3849.557300910375;28590.428191436262;29344.559831602543;29504.70495295041;29675.554866677016;30075.248118797204;2762.557990721475;2766.958495622567;2804.7939386063986;2805.957910631342;2818.224988128281;489034.1096589024;548116;551994;552925;553180;65749.67125164343;65901.01148482776;66454.33545664481;66583.33416665772;66717.33282667208;76384.61807690926;77480;78288.60855695799;78348.60825695835;78532.60733696294;18328.908355458138;18559.814401856078;18615.255389784255;18618.627627447375;18623.06884655789;13859.168449893039;13879.514217002357;13929.024968252124;13965.371558279901;14062.226577538333;18107.45677629673;22457.663135052662;22868.31395058151;22909.312720618407;22967;8010.639521221442;9317.44095354281;9576.473293968898;9584.428670480916;9644.517774111266;825.5830805443213;1024.0834453164375;1038.937663740178;1112.1269803204445;1118.0552433193939;29716.85141574278;29827.85086074556;30312.242193945327;30551.08346749601;30591.541126883116;1156.7108222944264;1163.650904728578;1191.237607930925;1218.9512419503299;1240.9007279417624;15068.020578662352;15282;15318.234088295541;15516.922415388077;15652.530424087296;512278;512546;516071;517423;518640;62077.27536347834;62536.687316563126;62788.37211627916;62848.68575657092;62857.74284514284;1421.3461807568635;1519.6960607878468;1523.8019057522451;1550.395345815133;1551.4957638767446;23827.642585360885;24003.27990160298;28404.715952840208;28971.7102828969;29371.7062829369;48239.5176048235;48521.27218091661;48584.271235930784;48592.75703621459;48679;314980;325139;325170;325955;325964;28625.42749145047;29661.5550766743;33796.662033379354;34089.147771305914;35208.823955880056;42472.36291455569;42603;44203.11593768171;44417.55582444134;44572.33141502815;30713.846430767702;36142.8192859034;36275.81862090673;36592.26815463623;36632;31675.52486712747;32952.67047329496;35989.92030239097;36189.63810361968;38140;36953.63046369609;37388.5044598213;37724.62275377211;37746.81126594349;38031;31983.68016319807;32698.34603307873;32789;32806.83596582002;32817.34365312633;24727.752722473266;24732.629010565215;24922.875385622956;25277.241682749547;25296.367590810376 03:18:24 INFO - PROCESS | 1942 | |2;jquery.html;328.980261184329;384.2085304273197;385.04508818131023;391.896147520907;395.7862754112779;20010;20192.192312307507;20965.895170524163;21056.99999999998;21095.15619375227;11936;12391.69020774481;12512.562060327891;12513.49946002161;12526.56157034504;4949.554540091391;5265.262863199156;6165.537584681145;6173.938260617404;6174.135621013039;6109.266887973449;6152.230971128609;6163.907541386883;6174.629522228658;6179.19670442844;5450.727463626823;5656.830295091154;6000.8499787505225;6097.20736304282;6151.538634602401;5971.402859713994;6035.305939816912;6064.211652485193;6070.423309785585;6071.817845464643;5208.947910520884;5321.148616221386;5335.1730481775385;5358.97320513395;5362.946370536322;14331.140131592138;14338.068025578408;14344.42622295107;20689.379318620464;26243;2112.524681946565;2211.436083798621;2231.6875637410776;2325.9651105233434;2369.9881500592387;8262.884510591113;10095.192384609214;10479.423631700254;10579.73550661232;10630.840537391945;1605.715427657869;1759.832815882489;1772;1864.3526192806248;1876.9906150469296;97526;104289.43565846518;105934;108759;109531.90468095297;10745.51645175969;11288.492017859217;11947;11958.58144964922;12120.515179392725;14632.561023169323;14696.044757090755;14743.705125897422;14751.40994360235;14778.926105369404;8766.824663506693;9070.501122438329;9095;9169.266458683289;9189.954050229706;9232;9232.240137836281;9254.074592540692;9363.0168832273;9483.810323793485;4619.722816631013;4705.576498115118;4709.599684026827;4739.549742774431;4754.833580824655;1975.101328895349;1980.9405717828488;1983.6627773278578;1998.6802111662064;2024.5343570978757;864.6757465950269;916.7662246127195;989.5601899236593;999.5801763259449;1001.8747656542932;19401.611967760848;19744.30894918671;20374.388768336677;20376.796232037785;20530.87080210573;991.3011327014437;1009.248110157937;1014.4876837197169;1015.5277795824977;1025.487256371814;8805.911940880509;9006.819863602692;10929.016388525071;11034.613788517363;11091.55633774656;646675;656688;667982;680758;683112;69149.65425172843;85794;105440;108157;122172.38913805374;1008.9495525223709;1012.8025035118228;1039.953202105907;1042.7653777899911;1045.947702614866;18209.726854097466;18569.44291671252;18633.627327453647;18660.440186794418;18852.905735471235;44339;50786.746066269436;50969;51049.744751276005;52002;73436.63281683557;73592.26407735854;74351;75144.62427687827;75204.24795751972;8101.10887802353;8113.472624279403;8151.347892168731;8197.508149511048;8484.066752657327;12259.509619615472;12856.357182141042;12995.935020324838;13155.53955611549;13328.866711332763;11148.275362101762;11274.041706455044;11455.255408398427;11504;11554.248973816675;5276.261323414648;9359.766005849908;9629.614815407305;11079.944600276947;11310.434478275889;11501.309921404743;11586.826197606873;11618.76762464763;11624.476898539417;11650.708732281422;8133.593320333841;8153.877691834746;8179.263866252066;8187.877181842397;8261.38039647041;9907.910129885851;10674.199435042558;11019.889801102207;11750.647480575597;11751.412429378326 03:18:24 INFO - PROCESS | 1942 | |3;mootools.html;1337.7792664210406;1625.796775403075;1649.4721689059502;2005.6991451282306;2098.6851972204167;8320.167983201676;8862;8976.237019853312;8976.416532925356;8985.371024028304;7526.5484070955645;8678.566071696421;8881.80095687082;8962.148595883396;8973.95513022434;2217.8225741940687;2279.4871153990384;2279.886005699717;2530.0891678995595;2573.7812285955715;2390.4740956989435;2460.089766786283;2460.778529932306;2464.125235541384;2469.074097213545;2509.7866681332016;2544.109561653425;2555.910543130991;2559.053150334379;2560.10396361273;2500.5374005808985;2523.5583772839773;2530;2539.961900571493;2546.4907018596264;2492.9750702492925;2518.534071196816;2551.017858124617;2560.116759717894;2565.961510577343;9009.963854156791;9042.502662353569;9055.366124371296;9063.864042039375;9092.408993415473;5494.917576236359;5598.300212473441;5647.971760141214;5657.8585535361535;5662.17898404729;3615.6565126312958;3674.779513229188;3748.9625103748886;3757.1734218472166;3758.267137908109;1053.2258789789498;1074.8763892152424;1077.1275267033727;1085.7339951711801;1110.5613282753268;10173;12045.879541204564;12187.451564679523;12218.389080546027;12260.632181034583;4983;5054.69671819692;5141.305923700327;5145.562627176732;5152.02111598795;10573.788524229627;10611;10613.204009699304;10629;10636.89363106359;5640.266765320482;5688.459596338341;5693.060644993612;5696.743646535916;5700.458456446631;4585.633149348044;4701.929471057937;4903.141950158708;5023.949760502422;5130.127878260705;4145.336746120666;4176.519700234451;4194.517630472535;4230.386593943861;4232.3016702243785;1332.7201287729686;1356.9185848849102;1367.6649220940735;1369.1442848219863;1371.389731569462;1139.7663478986788;1158.5423757615695;1161.5992482593492;1341.8591047940022;1430.2920054573053;8328.916710832935;8413.242808147295;8434.072252052269;8461.45000574973;8468.788280293042;524.9763760630781;540.3569751995113;540.4433433563436;544.7603054655939;546.6747285365201;5365.007473617393;5920.585559010914;6060.878782424327;6147.170132032208;6170.167027451326;10462.790744185073;10792.51433685486;10814.621488247874;10961.506732197071;10965.342079475256;10467.895321046844;10591.894081059245;10823.350598964087;10828.458577071115;10840.970107839743;8308.418410711312;8410.78973025667;8446.704365347307;8504.829903401896;8557.572121393905;6748.628825414649;8229.300509456523;8241.711540096068;8329.29201017896;8365.66537338524;9617.134457898543;9756.609735610497;9860.457674827954;10001.199904007808;10091.24315676342;10042.347247428894;10225.539850706884;10232.3116685749;10398.324108932895;10469.319494233156;6860.588364698134;7405.518641288299;7659.655315510927;7765.844683106193;7875.133735288999;8418.284445822173;8431.789205269672;8471.66113355459;8481.83036339282;8496.320294376312;7342.632868356454;7494.17564067963;7566.583837888969;7608;7621.428392870446;6334.651594162181;7328.890066648898;7331.973523706792;7384.076990376203;7469.327760501581;7885.960570197112;7902.288794008567;7944.920550794649;7969.561674107979;7988.440809143304;5755.223044888887;6969.965150174216;7006.649667516705;7013.05323781283;7076.71693132269;7325.926740732524;7358;7389.150247721581;7395.8151046224275;7399.741009064657 03:18:24 INFO - PROCESS | 1942 | |4;prototype.html;331.1819805081448;331.3902419548031;339.68579064365457;340.1496259351621;346.2002773592999;6493.415592596665;6564.409203171714;6569;6572.507061970347;6590.637514936682;6511.609303441785;6523.412892839643;6561.934380656192;6575.9013614795695;6576.473882089434;4549.931751023721;4657.720536767804;4671.696339737923;4792.544708252711;4855.174620314555;4305.6124948754605;4353.064091220387;4768.427788665365;4769.546893045155;4820.493848145947;3821.789801560913;4765.523447655241;4783.880402989918;4786.808527658889;4787.569118779309;3842.3660096084113;4468.374427580141;4602.12559613674;4737.573618374363;4743.264793956908;4068.5117785865887;4071.9592804071876;4081.9795901020602;4082.530508991474;4094.549599544048;6138.693065346715;6165.784197553109;6168;6195.5663103582765;6207.441330280297;5590.832275031715;5601.243832082698;5608.971955140199;5628.971855140739;5630.746616402272;5571.693556854371;6890.827729306758;6896.413804826596;6907.827304317432;6945.0971373721595;4319.654427645781;4444.11117776446;4462.241418958753;4468.5531446855375;4482.865514034552;6969.128858892638;7089.078419805443;7103.82240443993;7104.25405332443;7134.571925684424;4509.887252818706;4511.503734589192;4536.455625324982;4560.201964656172;4560.566746159109;4598.034412773288;4609.976950115295;4610.3084537319;4628.490866004737;4630.629549636021;4713.750856023156;5001.149804533238;5457.5633949283965;5502.367227768777;5506.421825708323;5626.212330273765;6636.469082473391;6854.2117656469145;6875.0718652982205;6960.547564408297;1594.6810637872472;1599.4881637876001;1614.7335689611318;1622.7809245751907;1624.6263359427398;973.2214228617078;1000.6697789729371;1027.671145233533;1031.3914790273775;1043.5773511727762;6324.146240257598;6417.294097649255;6537.5750576212395;6544.149260596188;6555.3772391622715;7157.785266442015;7283.817904552428;7300.452466065067;7307.707691692272;7326.450516211199;6496.447801936793;6498.740050397932;6514.022896565553;6535.411812936859;6539.934600653933;3788.3749181385315;3808.257389809016;3841.615838416136;3841.769493830379;3851.171998020439;7288.6720097595735;7589.9374087627775;7600.8479830404185;7604.619769011527;7620.885686714703;7477.663505142173;7491.925080749232;7523.623818809147;7540.208278130827;7548.433867459962;7537.2085930977555;7576.545407275471;7579.734709285149;7587.734429294948;7588.924110758932;7007.7249355439035;7171.175314838861;7231.8553628928175;7276.017737605355;7300.707971681073;6191.721372538156;7057.929420705727;7086.0433841432805;7135.250798666066;7137.536060156073;7524.887126693214;7545.886811697719;7547.73582924595;7548.698052077855;7549.471536992358;4728.905421891474;4764.571188593043;4774.092922344744;4780.6175505958745;4783.928241076456;6899.379055884994;7098.25468325839;7114.679839407136;7147.356737893615;7151.106111736033;6833.897491537531;6860.6912688930115;6875.518713689994;6876.896846547406;6885.380315771405;6782.491313151435;6825.624590647562;6833.863322733617;6858.108445902001;6870.072540207208;6716.697748601422;6726.98190542845;6731.562448440835;6733.360330768569;6750.763723269662;6618.172728408949;6845.041694162722;6872.312768723088;6881.483888708267;6908.3437073477935;5380.515753582196;5896.233489646319;6478.99575565788;6708.02733603615;6751.966240168767 03:18:24 INFO - PROCESS | 1942 | |5;yui.html;711.285158415792;722.6386806596702;722.9783106506807;743.8809790433528;802.6067227058743;15111.697766044686;15343.386264549405;15358.078515289091;15365.692686146283;15378.46175383859;14140.92929535351;14338.856611433883;14339.569812905629;14360.497382591611;14370.281485925714;770.6069904348766;773.5745340062942;927.4481683398401;929.0477260807659;941.2846236860001;918.7840857398506;928.4893308680232;931.2643012020495;931.7297983584753;959.3236768078488;830.5224495914842;997.6508222122271;1006.2503434940979;1006.4866917871901;1042.3329069395593;987.4618333008527;1015.6343716262177;1016.2682868334787;1016.9033941775593;1017.5675337981365;750.5009168902673;755.0825746717709;756.6935391166531;756.71623141322;758.3743411685326;15245.313960871676;15345.156016419092;15345.30946107428;15357.539273821803;15362.539123826304;13125.540606078837;13212.735745285137;13244.337783110806;13353.86646133536;13517.797233041512;8486.405951583392;10167.23745719074;10282.434466104361;10382.117520010808;10477.21420893436;3522.947155792665;3541.0058451533073;3600.6039335673054;3608.025833025095;3714.9969508232625;60987.69506152485;77081;86346;86584.13415865824;86653.56673216594;9473;9496.857547136799;9565.760855978517;9983.450910200008;10225.977402259863;21881.781182188293;21941.561168776854;22142.667859982113;22229.444263893532;22238.888805555867;7717.382609391348;7739.651715672696;7796.259355361231;7804;7909.1299957004685;4143.627073563393;4210.157968406331;4270.252705776539;4284.76433796138;4324.0919406924895;3632.636736326346;3643.6720695137565;3656.3601369760186;3658.378075727133;3663.8351274192723;646.7380710812129;666.5534092158266;674.7132468700783;675.9628220447922;677.9050932869402;573.8135106090538;597.333972620525;610.2402508876477;615.8299231460261;616.0851136062943;8351.24838764514;8356.331493480508;8490.660373585111;8566.3146948244;8677.869831952527;522.2479629333748;525.984849240961;567.8097837224576;577.5725962787591;598.8532809461623;3931.3513270310077;4106.486689163855;4237.618614324664;4261.659067274611;4340.826366945287;94722.0527794727;94832;98515.50742246243;103371.96628033774;104188.47905760574;79866.6006669963;81438.77841832259;83656;83920;85072;59626.40373596295;70097;75324.62337688386;75465;75607.62196188983;6891.862162756817;8389.875390964751;8474.915250847413;8600.483970961763;8609.870851937101;31029.379412412076;50388.99222015466;52233.47766522438;52321.47678523166;52825.73587132194;70655;73942;74303;74408.62795685987;74536.62731686307;11195;11433.256838305817;11546.59586914454;11743.94304512598;11746.236494627821;11994.280343179436;12033.63899083029;12046.578369757017;12106.273623582612;12815.679608009501;11392.373419461677;11557.01765349921;11831.704207394883;11948.940255299016;12105.75788484243;11537.926788090625;12000.39998000079;12172.513099475922;12181.269123852242;12392.62822115338;11161.776764464828;11628.418579070843;11636.185467017227;11658.417079146178;11847.170698051053;8544.829103418022;10064.496775161359;10295.17638588896;10389.48052597352;10402.063814256451;9444.338896277195;9552.85670714926;9963;10034.849477257992;10061.446620435947 03:18:24 INFO - PROCESS | 1942 | __end_tp_report 03:18:24 INFO - PROCESS | 1942 | __start_cc_report 03:18:24 INFO - PROCESS | 1942 | _x_x_mozilla_cycle_collect,1096 03:18:24 INFO - PROCESS | 1942 | __end_cc_report 03:18:24 INFO - PROCESS | 1942 | __startTimestamp1457695104353__endTimestamp 03:18:24 INFO - PROCESS | 1942 | 03:18:24 INFO - PROCESS | 1942 | ------- Summary: start ------- 03:18:24 INFO - PROCESS | 1942 | Number of tests: 6 03:18:24 INFO - PROCESS | 1942 | 03:18:24 INFO - PROCESS | 1942 | [#0] dojo.html Cycles:165 Average:5833.58 Median:6110.24 stddev:642.66 (10.5%) stddev-sans-first:602.40 03:18:24 INFO - PROCESS | 1942 | Values: 2912.6 3521.3 3546.2 3552.1 3600.6 5895.1 5897.7 5906.1 5921.1 5975.1 5875.7 5908.1 5926.4 5935.3 5948.0 5176.0 5220.4 5232.2 5255.5 5308.3 5291.9 5305.2 5311.4 5320.7 5326.9 5092.5 5123.2 5137.4 5163.9 5306.0 5320.4 5339.2 5355.9 5361.2 5406.3 5075.6 5267.7 5269.2 5302.0 5308.7 5678.8 5777.3 5781.1 5782.8 5802.5 6156.5 6250.7 6256.7 6257.9 6265.7 6241.4 6280.8 6303.3 6317.8 6322.9 6014.0 6017.4 6030.7 6037.5 6043.2 6282.9 6335.9 6369.6 6379.7 6407.4 6205.1 6237.0 6239.1 6257.9 6262.2 6285.6 6297.1 6301.6 6303.2 6307.4 6169.0 6181.9 6208.0 6242.7 6269.5 6176.7 6249.4 6254.3 6276.0 6281.4 4965.9 4970.0 4989.6 4997.0 5001.1 4446.6 4466.0 4515.9 4532.5 4557.0 5927.6 5931.1 5945.9 5957.7 5962.6 6275.6 6290.2 6294.5 6304.7 6314.9 5803.5 5865.1 5876.9 5961.0 5966.6 5434.8 5478.5 5494.3 5498.6 5517.5 6457.6 6469.7 6488.1 6495.9 6538.8 5486.9 6174.5 6266.1 6302.8 6328.2 6463.4 6470.7 6475.9 6485.0 6487.2 6107.9 6220.3 6245.4 6257.1 6281.5 6158.9 6228.7 6235.3 6268.7 6305.5 6110.4 6131.2 6140.7 6140.8 6154.0 6039.4 6110.2 6130.5 6136.0 6147.7 6060.3 6115.6 6120.9 6128.7 6130.2 6143.3 6145.3 6145.5 6145.8 6156.3 6042.5 6043.6 6103.2 6131.3 6145.0 03:18:24 INFO - PROCESS | 1942 | 03:18:24 INFO - PROCESS | 1942 | [#1] ext.html Cycles:180 Average:61453.06 Median:36612.13 stddev:125007.40 (341.4%) stddev-sans-first:125274.38 03:18:24 INFO - PROCESS | 1942 | Values: 523.6 578.5 601.9 620.6 659.8 31803.0 32264.9 32297.0 32317.7 32348.7 27854.4 39179.2 41969.0 42010.8 42098.6 9615.6 9795.2 9832.1 9834.3 9840.0 9685.6 9815.1 9831.0 9836.5 9865.8 9762.2 9839.0 9847.9 9855.4 9861.9 9740.9 9868.3 9869.8 9871.5 9912.2 9664.4 9804.4 9805.1 9807.6 9809.7 41505.0 41837.0 41880.0 41882.4 41943.4 3220.3 3388.0 3418.2 3690.0 3849.6 28590.4 29344.6 29504.7 29675.6 30075.2 2762.6 2767.0 2804.8 2806.0 2818.2 489034.1 548116.0 551994.0 552925.0 553180.0 65749.7 65901.0 66454.3 66583.3 66717.3 76384.6 77480.0 78288.6 78348.6 78532.6 18328.9 18559.8 18615.3 18618.6 18623.1 13859.2 13879.5 13929.0 13965.4 14062.2 18107.5 22457.7 22868.3 22909.3 22967.0 8010.6 9317.4 9576.5 9584.4 9644.5 825.6 1024.1 1038.9 1112.1 1118.1 29716.9 29827.9 30312.2 30551.1 30591.5 1156.7 1163.7 1191.2 1219.0 1240.9 15068.0 15282.0 15318.2 15516.9 15652.5 512278.0 512546.0 516071.0 517423.0 518640.0 62077.3 62536.7 62788.4 62848.7 62857.7 1421.3 1519.7 1523.8 1550.4 1551.5 23827.6 24003.3 28404.7 28971.7 29371.7 48239.5 48521.3 48584.3 48592.8 48679.0 314980.0 325139.0 325170.0 325955.0 325964.0 28625.4 29661.6 33796.7 34089.1 35208.8 42472.4 42603.0 44203.1 44417.6 44572.3 30713.8 36142.8 36275.8 36592.3 36632.0 31675.5 32952.7 35989.9 36189.6 38140.0 36953.6 37388.5 37724.6 37746.8 38031.0 31983.7 32698.3 32789.0 32806.8 32817.3 24727.8 24732.6 24922.9 25277.2 25296.4 03:18:24 INFO - PROCESS | 1942 | 03:18:24 INFO - PROCESS | 1942 | [#2] jquery.html Cycles:180 Average:35139.83 Median:2221.56 stddev:109997.36 (4951.4%) stddev-sans-first:110274.88 03:18:24 INFO - PROCESS | 1942 | Values: 329.0 384.2 385.0 391.9 395.8 20010.0 20192.2 20965.9 21057.0 21095.2 11936.0 12391.7 12512.6 12513.5 12526.6 4949.6 5265.3 6165.5 6173.9 6174.1 6109.3 6152.2 6163.9 6174.6 6179.2 5450.7 5656.8 6000.8 6097.2 6151.5 5971.4 6035.3 6064.2 6070.4 6071.8 5208.9 5321.1 5335.2 5359.0 5362.9 14331.1 14338.1 14344.4 20689.4 26243.0 2112.5 2211.4 2231.7 2326.0 2370.0 8262.9 10095.2 10479.4 10579.7 10630.8 1605.7 1759.8 1772.0 1864.4 1877.0 97526.0 104289.4 105934.0 108759.0 109531.9 10745.5 11288.5 11947.0 11958.6 12120.5 14632.6 14696.0 14743.7 14751.4 14778.9 8766.8 9070.5 9095.0 9169.3 9190.0 9232.0 9232.2 9254.1 9363.0 9483.8 4619.7 4705.6 4709.6 4739.5 4754.8 1975.1 1980.9 1983.7 1998.7 2024.5 864.7 916.8 989.6 999.6 1001.9 19401.6 19744.3 20374.4 20376.8 20530.9 991.3 1009.2 1014.5 1015.5 1025.5 8805.9 9006.8 10929.0 11034.6 11091.6 646675.0 656688.0 667982.0 680758.0 683112.0 69149.7 85794.0 105440.0 108157.0 122172.4 1008.9 1012.8 1040.0 1042.8 1045.9 18209.7 18569.4 18633.6 18660.4 18852.9 44339.0 50786.7 50969.0 51049.7 52002.0 73436.6 73592.3 74351.0 75144.6 75204.2 8101.1 8113.5 8151.3 8197.5 8484.1 12259.5 12856.4 12995.9 13155.5 13328.9 11148.3 11274.0 11455.3 11504.0 11554.2 5276.3 9359.8 9629.6 11079.9 11310.4 11501.3 11586.8 11618.8 11624.5 11650.7 8133.6 8153.9 8179.3 8187.9 8261.4 9907.9 10674.2 11019.9 11750.6 11751.4 03:18:24 INFO - PROCESS | 1942 | 03:18:24 INFO - PROCESS | 1942 | [#3] mootools.html Cycles:180 Average:6156.16 Median:5148.79 stddev:3264.45 (63.4%) stddev-sans-first:3253.51 03:18:24 INFO - PROCESS | 1942 | Values: 1337.8 1625.8 1649.5 2005.7 2098.7 8320.2 8862.0 8976.2 8976.4 8985.4 7526.5 8678.6 8881.8 8962.1 8974.0 2217.8 2279.5 2279.9 2530.1 2573.8 2390.5 2460.1 2460.8 2464.1 2469.1 2509.8 2544.1 2555.9 2559.1 2560.1 2500.5 2523.6 2530.0 2540.0 2546.5 2493.0 2518.5 2551.0 2560.1 2566.0 9010.0 9042.5 9055.4 9063.9 9092.4 5494.9 5598.3 5648.0 5657.9 5662.2 3615.7 3674.8 3749.0 3757.2 3758.3 1053.2 1074.9 1077.1 1085.7 1110.6 10173.0 12045.9 12187.5 12218.4 12260.6 4983.0 5054.7 5141.3 5145.6 5152.0 10573.8 10611.0 10613.2 10629.0 10636.9 5640.3 5688.5 5693.1 5696.7 5700.5 4585.6 4701.9 4903.1 5023.9 5130.1 4145.3 4176.5 4194.5 4230.4 4232.3 1332.7 1356.9 1367.7 1369.1 1371.4 1139.8 1158.5 1161.6 1341.9 1430.3 8328.9 8413.2 8434.1 8461.5 8468.8 525.0 540.4 540.4 544.8 546.7 5365.0 5920.6 6060.9 6147.2 6170.2 10462.8 10792.5 10814.6 10961.5 10965.3 10467.9 10591.9 10823.4 10828.5 10841.0 8308.4 8410.8 8446.7 8504.8 8557.6 6748.6 8229.3 8241.7 8329.3 8365.7 9617.1 9756.6 9860.5 10001.2 10091.2 10042.3 10225.5 10232.3 10398.3 10469.3 6860.6 7405.5 7659.7 7765.8 7875.1 8418.3 8431.8 8471.7 8481.8 8496.3 7342.6 7494.2 7566.6 7608.0 7621.4 6334.7 7328.9 7332.0 7384.1 7469.3 7886.0 7902.3 7944.9 7969.6 7988.4 5755.2 6970.0 7006.6 7013.1 7076.7 7325.9 7358.0 7389.2 7395.8 7399.7 03:18:24 INFO - PROCESS | 1942 | 03:18:24 INFO - PROCESS | 1942 | [#4] prototype.html Cycles:180 Average:5644.14 Median:6512.82 stddev:1819.84 (27.9%) stddev-sans-first:1780.72 03:18:24 INFO - PROCESS | 1942 | Values: 331.2 331.4 339.7 340.1 346.2 6493.4 6564.4 6569.0 6572.5 6590.6 6511.6 6523.4 6561.9 6575.9 6576.5 4549.9 4657.7 4671.7 4792.5 4855.2 4305.6 4353.1 4768.4 4769.5 4820.5 3821.8 4765.5 4783.9 4786.8 4787.6 3842.4 4468.4 4602.1 4737.6 4743.3 4068.5 4072.0 4082.0 4082.5 4094.5 6138.7 6165.8 6168.0 6195.6 6207.4 5590.8 5601.2 5609.0 5629.0 5630.7 5571.7 6890.8 6896.4 6907.8 6945.1 4319.7 4444.1 4462.2 4468.6 4482.9 6969.1 7089.1 7103.8 7104.3 7134.6 4509.9 4511.5 4536.5 4560.2 4560.6 4598.0 4610.0 4610.3 4628.5 4630.6 4713.8 5001.1 5457.6 5502.4 5506.4 5626.2 6636.5 6854.2 6875.1 6960.5 1594.7 1599.5 1614.7 1622.8 1624.6 973.2 1000.7 1027.7 1031.4 1043.6 6324.1 6417.3 6537.6 6544.1 6555.4 7157.8 7283.8 7300.5 7307.7 7326.5 6496.4 6498.7 6514.0 6535.4 6539.9 3788.4 3808.3 3841.6 3841.8 3851.2 7288.7 7589.9 7600.8 7604.6 7620.9 7477.7 7491.9 7523.6 7540.2 7548.4 7537.2 7576.5 7579.7 7587.7 7588.9 7007.7 7171.2 7231.9 7276.0 7300.7 6191.7 7057.9 7086.0 7135.3 7137.5 7524.9 7545.9 7547.7 7548.7 7549.5 4728.9 4764.6 4774.1 4780.6 4783.9 6899.4 7098.3 7114.7 7147.4 7151.1 6833.9 6860.7 6875.5 6876.9 6885.4 6782.5 6825.6 6833.9 6858.1 6870.1 6716.7 6727.0 6731.6 6733.4 6750.8 6618.2 6845.0 6872.3 6881.5 6908.3 5380.5 5896.2 6479.0 6708.0 6752.0 03:18:24 INFO - PROCESS | 1942 | 03:18:24 INFO - PROCESS | 1942 | [#5] yui.html Cycles:180 Average:18894.25 Median:27364.91 stddev:26869.99 (98.2%) stddev-sans-first:26910.68 03:18:24 INFO - PROCESS | 1942 | Values: 711.3 722.6 723.0 743.9 802.6 15111.7 15343.4 15358.1 15365.7 15378.5 14140.9 14338.9 14339.6 14360.5 14370.3 770.6 773.6 927.4 929.0 941.3 918.8 928.5 931.3 931.7 959.3 830.5 997.7 1006.3 1006.5 1042.3 987.5 1015.6 1016.3 1016.9 1017.6 750.5 755.1 756.7 756.7 758.4 15245.3 15345.2 15345.3 15357.5 15362.5 13125.5 13212.7 13244.3 13353.9 13517.8 8486.4 10167.2 10282.4 10382.1 10477.2 3522.9 3541.0 3600.6 3608.0 3715.0 60987.7 77081.0 86346.0 86584.1 86653.6 9473.0 9496.9 9565.8 9983.5 10226.0 21881.8 21941.6 22142.7 22229.4 22238.9 7717.4 7739.7 7796.3 7804.0 7909.1 4143.6 4210.2 4270.3 4284.8 4324.1 3632.6 3643.7 3656.4 3658.4 3663.8 646.7 666.6 674.7 676.0 677.9 573.8 597.3 610.2 615.8 616.1 8351.2 8356.3 8490.7 8566.3 8677.9 522.2 526.0 567.8 577.6 598.9 3931.4 4106.5 4237.6 4261.7 4340.8 94722.1 94832.0 98515.5 103372.0 104188.5 79866.6 81438.8 83656.0 83920.0 85072.0 59626.4 70097.0 75324.6 75465.0 75607.6 6891.9 8389.9 8474.9 8600.5 8609.9 31029.4 50389.0 52233.5 52321.5 52825.7 70655.0 73942.0 74303.0 74408.6 74536.6 11195.0 11433.3 11546.6 11743.9 11746.2 11994.3 12033.6 12046.6 12106.3 12815.7 11392.4 11557.0 11831.7 11948.9 12105.8 11537.9 12000.4 12172.5 12181.3 12392.6 11161.8 11628.4 11636.2 11658.4 11847.2 8544.8 10064.5 10295.2 10389.5 10402.1 9444.3 9552.9 9963.0 10034.8 10061.4 03:18:24 INFO - PROCESS | 1942 | -------- Summary: end -------- 03:18:24 INFO - PROCESS | 1942 | 03:18:24 INFO - TEST-INFO | 1942: exit 0 03:18:24 INFO - TEST-OK | dromaeo_css | took 1113202ms 03:18:24 INFO - TEST-START | kraken 03:18:24 INFO - operating with platform_type : mac_ 03:18:24 INFO - Initialising browser for kraken test... 03:18:24 INFO - TEST-INFO | started process 1946 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/tmpZIg2uH/profile http://localhost:49857/getInfo.html) 03:18:27 INFO - PROCESS | 1946 | __metrics Screen width/height:1600/1200 03:18:27 INFO - PROCESS | 1946 | colorDepth:24 03:18:27 INFO - PROCESS | 1946 | Browser inner width/height: 1024/689 03:18:27 INFO - PROCESS | 1946 | __metrics 03:18:27 INFO - PROCESS | 1946 | 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" 03:18:27 INFO - PROCESS | 1946 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:18:27 INFO - TEST-INFO | 1946: exit 0 03:18:27 INFO - Browser initialized. 03:18:27 INFO - Running cycle 1/1 for kraken test... 03:18:27 INFO - TEST-INFO | started process 1949 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/tmpZIg2uH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:18:39 INFO - PROCESS | 1949 | RSS: Main: 210366464 03:18:39 INFO - PROCESS | 1949 | 03:18:42 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49857/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49857/tests/kraken/driver.html?testName=audio-beat-detection) 03:18:43 INFO - PROCESS | 1949 | RSS: Main: 264556544 03:18:43 INFO - PROCESS | 1949 | 03:18:45 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49857/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49857/tests/kraken/driver.html?testName=audio-dft) 03:18:46 INFO - PROCESS | 1949 | RSS: Main: 275673088 03:18:46 INFO - PROCESS | 1949 | 03:18:49 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49857/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49857/tests/kraken/driver.html?testName=audio-fft) 03:18:50 INFO - PROCESS | 1949 | RSS: Main: 264753152 03:18:50 INFO - PROCESS | 1949 | 03:18:51 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49857/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49857/tests/kraken/driver.html?testName=audio-oscillator) 03:18:52 INFO - PROCESS | 1949 | RSS: Main: 266772480 03:18:52 INFO - PROCESS | 1949 | 03:18:54 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49857/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49857/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:18:55 INFO - PROCESS | 1949 | RSS: Main: 265056256 03:18:55 INFO - PROCESS | 1949 | 03:18:57 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49857/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49857/tests/kraken/driver.html?testName=imaging-darkroom) 03:18:58 INFO - PROCESS | 1949 | RSS: Main: 268382208 03:18:58 INFO - PROCESS | 1949 | 03:19:01 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49857/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49857/tests/kraken/driver.html?testName=imaging-desaturate) 03:19:01 INFO - PROCESS | 1949 | RSS: Main: 266579968 03:19:01 INFO - PROCESS | 1949 | 03:19:04 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49857/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49857/tests/kraken/driver.html?testName=json-parse-financial) 03:19:05 INFO - PROCESS | 1949 | RSS: Main: 269037568 03:19:05 INFO - PROCESS | 1949 | 03:19:06 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49857/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49857/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:19:07 INFO - PROCESS | 1949 | RSS: Main: 301305856 03:19:07 INFO - PROCESS | 1949 | 03:19:09 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49857/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49857/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:19:09 INFO - PROCESS | 1949 | RSS: Main: 301273088 03:19:09 INFO - PROCESS | 1949 | 03:19:11 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49857/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49857/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:19:12 INFO - PROCESS | 1949 | RSS: Main: 308031488 03:19:12 INFO - PROCESS | 1949 | 03:19:14 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49857/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49857/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:19:15 INFO - PROCESS | 1949 | RSS: Main: 310579200 03:19:15 INFO - PROCESS | 1949 | 03:19:17 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49857/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49857/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:19:18 INFO - PROCESS | 1949 | RSS: Main: 309727232 03:19:18 INFO - PROCESS | 1949 | 03:19:20 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49857/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49857/tests/kraken/driver.html?testName=ai-astar) 03:19:20 INFO - PROCESS | 1949 | RSS: Main: 370012160 03:19:20 INFO - PROCESS | 1949 | 03:19:20 INFO - PROCESS | 1949 | __start_tp_report 03:19:20 INFO - PROCESS | 1949 | _x_x_mozilla_page_load 03:19:20 INFO - PROCESS | 1949 | _x_x_mozilla_page_load_details 03:19:20 INFO - PROCESS | 1949 | |i|pagename|runs| 03:19:20 INFO - PROCESS | 1949 | |0;ai-astar;110;108;110;109;111;115;164;162;113;108 03:19:20 INFO - PROCESS | 1949 | |1;audio-beat-detection;156;119;154;147;116;141;136;117;157;117 03:19:20 INFO - PROCESS | 1949 | |2;audio-dft;184;185;183;188;189;184;186;184;187;184 03:19:20 INFO - PROCESS | 1949 | |3;audio-fft;76;71;76;117;55;56;57;57;120;57 03:19:20 INFO - PROCESS | 1949 | |4;audio-oscillator;91;94;128;80;78;84;118;76;78;116 03:19:20 INFO - PROCESS | 1949 | |5;imaging-gaussian-blur;89;85;88;85;88;84;89;85;88;91 03:19:20 INFO - PROCESS | 1949 | |6;imaging-darkroom;93;93;94;93;93;94;94;93;92;93 03:19:20 INFO - PROCESS | 1949 | |7;imaging-desaturate;86;85;84;84;85;86;86;87;84;88 03:19:20 INFO - PROCESS | 1949 | |8;json-parse-financial;57;59;59;58;57;57;58;67;55;51 03:19:20 INFO - PROCESS | 1949 | |9;json-stringify-tinderbox;64;62;68;70;76;73;67;66;65;68 03:19:20 INFO - PROCESS | 1949 | |10;stanford-crypto-aes;79;80;81;80;80;79;80;77;80;84 03:19:20 INFO - PROCESS | 1949 | |11;stanford-crypto-ccm;117;115;119;116;118;116;120;118;117;122 03:19:20 INFO - PROCESS | 1949 | |12;stanford-crypto-pbkdf2;128;123;133;133;135;121;135;133;130;132 03:19:20 INFO - PROCESS | 1949 | |13;stanford-crypto-sha256-iterative;65;68;69;91;93;96;94;97;74;64 03:19:20 INFO - PROCESS | 1949 | __end_tp_report 03:19:20 INFO - PROCESS | 1949 | __start_cc_report 03:19:20 INFO - PROCESS | 1949 | _x_x_mozilla_cycle_collect,1230 03:19:20 INFO - PROCESS | 1949 | __end_cc_report 03:19:20 INFO - PROCESS | 1949 | __startTimestamp1457695160582__endTimestamp 03:19:20 INFO - PROCESS | 1949 | 03:19:20 INFO - PROCESS | 1949 | ------- Summary: start ------- 03:19:20 INFO - PROCESS | 1949 | Number of tests: 14 03:19:20 INFO - PROCESS | 1949 | 03:19:20 INFO - PROCESS | 1949 | [#0] ai-astar Cycles:10 Average:121.00 Median:112.00 stddev:22.25 (19.9%) stddev-sans-first:23.24 03:19:20 INFO - PROCESS | 1949 | Values: 110.0 108.0 110.0 109.0 111.0 115.0 164.0 162.0 113.0 108.0 03:19:20 INFO - PROCESS | 1949 | 03:19:20 INFO - PROCESS | 1949 | [#1] audio-beat-detection Cycles:10 Average:136.00 Median:144.00 stddev:17.39 (12.1%) stddev-sans-first:16.87 03:19:20 INFO - PROCESS | 1949 | Values: 156.0 119.0 154.0 147.0 116.0 141.0 136.0 117.0 157.0 117.0 03:19:20 INFO - PROCESS | 1949 | 03:19:20 INFO - PROCESS | 1949 | [#2] audio-dft Cycles:10 Average:185.40 Median:185.50 stddev:2.01 (1.1%) stddev-sans-first:2.07 03:19:20 INFO - PROCESS | 1949 | Values: 184.0 185.0 183.0 188.0 189.0 184.0 186.0 184.0 187.0 184.0 03:19:20 INFO - PROCESS | 1949 | 03:19:20 INFO - PROCESS | 1949 | [#3] audio-fft Cycles:10 Average:74.20 Median:57.00 stddev:24.80 (43.5%) stddev-sans-first:26.29 03:19:20 INFO - PROCESS | 1949 | Values: 76.0 71.0 76.0 117.0 55.0 56.0 57.0 57.0 120.0 57.0 03:19:20 INFO - PROCESS | 1949 | 03:19:20 INFO - PROCESS | 1949 | [#4] audio-oscillator Cycles:10 Average:94.30 Median:79.00 stddev:19.31 (24.4%) stddev-sans-first:20.45 03:19:20 INFO - PROCESS | 1949 | Values: 91.0 94.0 128.0 80.0 78.0 84.0 118.0 76.0 78.0 116.0 03:19:20 INFO - PROCESS | 1949 | 03:19:20 INFO - PROCESS | 1949 | [#5] imaging-gaussian-blur Cycles:10 Average:87.20 Median:88.00 stddev:2.30 (2.6%) stddev-sans-first:2.35 03:19:20 INFO - PROCESS | 1949 | Values: 89.0 85.0 88.0 85.0 88.0 84.0 89.0 85.0 88.0 91.0 03:19:20 INFO - PROCESS | 1949 | 03:19:20 INFO - PROCESS | 1949 | [#6] imaging-darkroom Cycles:10 Average:93.20 Median:93.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 03:19:20 INFO - PROCESS | 1949 | Values: 93.0 93.0 94.0 93.0 93.0 94.0 94.0 93.0 92.0 93.0 03:19:20 INFO - PROCESS | 1949 | 03:19:20 INFO - PROCESS | 1949 | [#7] imaging-desaturate Cycles:10 Average:85.50 Median:86.00 stddev:1.35 (1.6%) stddev-sans-first:1.42 03:19:20 INFO - PROCESS | 1949 | Values: 86.0 85.0 84.0 84.0 85.0 86.0 86.0 87.0 84.0 88.0 03:19:20 INFO - PROCESS | 1949 | 03:19:20 INFO - PROCESS | 1949 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:58.00 stddev:3.99 (6.9%) stddev-sans-first:4.23 03:19:20 INFO - PROCESS | 1949 | Values: 57.0 59.0 59.0 58.0 57.0 57.0 58.0 67.0 55.0 51.0 03:19:20 INFO - PROCESS | 1949 | 03:19:20 INFO - PROCESS | 1949 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:68.00 stddev:4.20 (6.2%) stddev-sans-first:4.21 03:19:20 INFO - PROCESS | 1949 | Values: 64.0 62.0 68.0 70.0 76.0 73.0 67.0 66.0 65.0 68.0 03:19:20 INFO - PROCESS | 1949 | 03:19:20 INFO - PROCESS | 1949 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:80.00 stddev:1.76 (2.2%) stddev-sans-first:1.83 03:19:20 INFO - PROCESS | 1949 | Values: 79.0 80.0 81.0 80.0 80.0 79.0 80.0 77.0 80.0 84.0 03:19:20 INFO - PROCESS | 1949 | 03:19:20 INFO - PROCESS | 1949 | [#11] stanford-crypto-ccm Cycles:10 Average:117.80 Median:118.00 stddev:2.10 (1.8%) stddev-sans-first:2.20 03:19:20 INFO - PROCESS | 1949 | Values: 117.0 115.0 119.0 116.0 118.0 116.0 120.0 118.0 117.0 122.0 03:19:20 INFO - PROCESS | 1949 | 03:19:20 INFO - PROCESS | 1949 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:130.30 Median:133.00 stddev:4.88 (3.7%) stddev-sans-first:5.10 03:19:20 INFO - PROCESS | 1949 | Values: 128.0 123.0 133.0 133.0 135.0 121.0 135.0 133.0 130.0 132.0 03:19:20 INFO - PROCESS | 1949 | 03:19:20 INFO - PROCESS | 1949 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:81.10 Median:92.00 stddev:14.15 (15.4%) stddev-sans-first:13.75 03:19:20 INFO - PROCESS | 1949 | Values: 65.0 68.0 69.0 91.0 93.0 96.0 94.0 97.0 74.0 64.0 03:19:20 INFO - PROCESS | 1949 | -------- Summary: end -------- 03:19:20 INFO - PROCESS | 1949 | 03:19:21 INFO - TEST-INFO | 1949: exit 0 03:19:21 INFO - TEST-OK | kraken | took 56437ms 03:19:21 INFO - SUITE-END | took 1169s 03:19:21 INFO - Completed test suite (00:19:30) 03:19:21 INFO - javascript benchmark 03:19:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2912.635920509936, 3521.2957408518287, 3546.1843775931534, 3552.1474846036926, 3600.649756341372, 5895.0862616294435, 5897.705114744262, 5906.114082887569, 5921.052631578948, 5975.103734439836, 5875.676837773921, 5908.1433192187105, 5926.4073592640825, 5935.258092738408, 5947.970260148704, 5176.016556854186, 5220.425753167148, 5232.241325007872, 5255.527002569768, 5308.283381743473, 5291.894162116755, 5305.1776974569, 5311.389190243113, 5320.654157479771, 5326.946730532703, 5092.541671249587, 5123.205903085028, 5137.434882162959, 5163.948360516403, 5305.973470132644, 5320.441353657869, 5339.172428273643, 5355.946440535584, 5361.2226227197225, 5406.297181366436, 5075.5939524838295, 5267.683938963636, 5269.1569348903995, 5302.045631786277, 5308.681479111227, 5678.829635110953, 5777.306723193244, 5781.075027995501, 5782.826515204509, 5802.535797136219, 6156.538259630545, 6250.6874656267455, 6256.749730010794, 6257.906131408033, 6265.71804268809, 6241.438270555626, 6280.78017269398, 6303.275123360826, 6317.810465686037, 6322.87354252917, 6014.007688731398, 6017.428344307284, 6030.698465076729, 6037.4566289033755, 6043.184170137063, 6282.905756413657, 6335.873282534323, 6369.585976911486, 6379.71291291893, 6407.423331900151, 6205.131281620576, 6236.970899801482, 6239.0953311770445, 6257.906131408033, 6262.1546091278005, 6285.59143655661, 6297.086922396227, 6301.6219026858535, 6303.180586523814, 6307.400796924377, 6168.982117950578, 6181.907271390933, 6208.00671892495, 6242.719077641517, 6269.498440124779, 6176.66028368435, 6249.406306400884, 6254.280757712831, 6275.96862015687, 6281.371862813682, 4965.90068198634, 4969.981153863449, 4989.600831933437, 4996.975015124901, 5001.074801161797, 4446.577575130357, 4465.977670111629, 4515.887102822456, 4532.524084971096, 4557.020240648277, 5927.555433342516, 5931.11033344993, 5945.910811337833, 5957.702114894325, 5962.552808539377, 6275.623462592259, 6290.245170579468, 6294.496440284766, 6304.747810087545, 6314.873702525923, 5803.506701930299, 5865.061590145641, 5876.853078673067, 5960.970195149083, 5966.612170208922, 5434.755436005389, 5478.45215478449, 5494.313210848644, 5498.5876059295715, 5517.475839795213, 6457.644829534421, 6469.741210351627, 6488.091667166506, 6495.935040649628, 6538.83652908662, 5486.945130548803, 6174.536909731698, 6266.122742815918, 6302.779402720883, 6328.177336946167, 6463.353664633687, 6470.741170353322, 6475.902861456988, 6485.0, 6487.156669632917, 6107.886786452593, 6220.284667263141, 6245.375462453719, 6257.092721555258, 6281.52888533371, 6158.938410615837, 6228.688565571794, 6235.282942461675, 6268.686565671607, 6305.495560355069, 6110.358412366815, 6131.202943617302, 6140.723667434887, 6140.815775526741, 6154.0, 6039.4262545058145, 6110.236220472441, 6130.50955923534, 6136.018237082046, 6147.692615369303, 6060.333363330118, 6115.6330620162935, 6120.908186377297, 6128.717018009349, 6130.214697154933, 6143.262808463013, 6145.293291271561, 6145.508359331332, 6145.84635384119, 6156.29202641702, 6042.456178943916, 6043.607165534227, 6103.23709536308, 6131.264248290056, 6144.986077297196], "unit": "score", "name": "dojo.html", "value": 5792.085207470119}, {"lowerIsBetter": false, "replicates": [523.5654406842322, 578.4909279833747, 601.8955217176479, 620.6400287833058, 659.8053574195612, 31803.0, 32264.87072952447, 32297.0, 32317.67682323179, 32348.67651323486, 27854.442911141767, 39179.21641567174, 41969.0, 42010.78994605023, 42098.57901420985, 9615.56729947154, 9795.167410770093, 9832.06595373442, 9834.31159818813, 9840.0, 9685.564149613248, 9815.067568580973, 9831.0, 9836.458994755285, 9865.802683946316, 9762.170215531689, 9838.950805245964, 9847.90152098477, 9855.408675479459, 9861.852072218922, 9740.853887191697, 9868.309218354718, 9869.753256168582, 9871.506424678737, 9912.15746661531, 9664.420134791935, 9804.411735295906, 9805.117539421415, 9807.607695692164, 9809.705708828747, 41505.0, 41837.0, 41879.953001175214, 41882.37176442356, 41943.370849437284, 3220.339830334776, 3387.983060084684, 3418.2308980479443, 3689.9815500922323, 3849.557300910375, 28590.428191436262, 29344.559831602543, 29504.70495295041, 29675.554866677016, 30075.248118797204, 2762.557990721475, 2766.958495622567, 2804.7939386063986, 2805.957910631342, 2818.224988128281, 489034.1096589024, 548116.0, 551994.0, 552925.0, 553180.0, 65749.67125164343, 65901.01148482776, 66454.33545664481, 66583.33416665772, 66717.33282667208, 76384.61807690926, 77480.0, 78288.60855695799, 78348.60825695835, 78532.60733696294, 18328.908355458138, 18559.814401856078, 18615.255389784255, 18618.627627447375, 18623.06884655789, 13859.168449893039, 13879.514217002357, 13929.024968252124, 13965.371558279901, 14062.226577538333, 18107.45677629673, 22457.663135052662, 22868.31395058151, 22909.312720618407, 22967.0, 8010.639521221442, 9317.44095354281, 9576.473293968898, 9584.428670480916, 9644.517774111266, 825.5830805443213, 1024.0834453164375, 1038.937663740178, 1112.1269803204445, 1118.0552433193939, 29716.85141574278, 29827.85086074556, 30312.242193945327, 30551.08346749601, 30591.541126883116, 1156.7108222944264, 1163.650904728578, 1191.237607930925, 1218.9512419503299, 1240.9007279417624, 15068.020578662352, 15282.0, 15318.234088295541, 15516.922415388077, 15652.530424087296, 512278.0, 512546.0, 516071.0, 517423.0, 518640.0, 62077.27536347834, 62536.687316563126, 62788.37211627916, 62848.68575657092, 62857.74284514284, 1421.3461807568635, 1519.6960607878468, 1523.8019057522451, 1550.395345815133, 1551.4957638767446, 23827.642585360885, 24003.27990160298, 28404.715952840208, 28971.7102828969, 29371.7062829369, 48239.5176048235, 48521.27218091661, 48584.271235930784, 48592.75703621459, 48679.0, 314980.0, 325139.0, 325170.0, 325955.0, 325964.0, 28625.42749145047, 29661.5550766743, 33796.662033379354, 34089.147771305914, 35208.823955880056, 42472.36291455569, 42603.0, 44203.11593768171, 44417.55582444134, 44572.33141502815, 30713.846430767702, 36142.8192859034, 36275.81862090673, 36592.26815463623, 36632.0, 31675.52486712747, 32952.67047329496, 35989.92030239097, 36189.63810361968, 38140.0, 36953.63046369609, 37388.5044598213, 37724.62275377211, 37746.81126594349, 38031.0, 31983.68016319807, 32698.34603307873, 32789.0, 32806.83596582002, 32817.34365312633, 24727.752722473266, 24732.629010565215, 24922.875385622956, 25277.241682749547, 25296.367590810376], "unit": "score", "name": "ext.html", "value": 20040.846300386143}, {"lowerIsBetter": false, "replicates": [328.980261184329, 384.2085304273197, 385.04508818131023, 391.896147520907, 395.7862754112779, 20010.0, 20192.192312307507, 20965.895170524163, 21056.99999999998, 21095.15619375227, 11936.0, 12391.69020774481, 12512.562060327891, 12513.49946002161, 12526.56157034504, 4949.554540091391, 5265.262863199156, 6165.537584681145, 6173.938260617404, 6174.135621013039, 6109.266887973449, 6152.230971128609, 6163.907541386883, 6174.629522228658, 6179.19670442844, 5450.727463626823, 5656.830295091154, 6000.8499787505225, 6097.20736304282, 6151.538634602401, 5971.402859713994, 6035.305939816912, 6064.211652485193, 6070.423309785585, 6071.817845464643, 5208.947910520884, 5321.148616221386, 5335.1730481775385, 5358.97320513395, 5362.946370536322, 14331.140131592138, 14338.068025578408, 14344.42622295107, 20689.379318620464, 26243.0, 2112.524681946565, 2211.436083798621, 2231.6875637410776, 2325.9651105233434, 2369.9881500592387, 8262.884510591113, 10095.192384609214, 10479.423631700254, 10579.73550661232, 10630.840537391945, 1605.715427657869, 1759.832815882489, 1772.0, 1864.3526192806248, 1876.9906150469296, 97526.0, 104289.43565846518, 105934.0, 108759.0, 109531.90468095297, 10745.51645175969, 11288.492017859217, 11947.0, 11958.58144964922, 12120.515179392725, 14632.561023169323, 14696.044757090755, 14743.705125897422, 14751.40994360235, 14778.926105369404, 8766.824663506693, 9070.501122438329, 9095.0, 9169.266458683289, 9189.954050229706, 9232.0, 9232.240137836281, 9254.074592540692, 9363.0168832273, 9483.810323793485, 4619.722816631013, 4705.576498115118, 4709.599684026827, 4739.549742774431, 4754.833580824655, 1975.101328895349, 1980.9405717828488, 1983.6627773278578, 1998.6802111662064, 2024.5343570978757, 864.6757465950269, 916.7662246127195, 989.5601899236593, 999.5801763259449, 1001.8747656542932, 19401.611967760848, 19744.30894918671, 20374.388768336677, 20376.796232037785, 20530.87080210573, 991.3011327014437, 1009.248110157937, 1014.4876837197169, 1015.5277795824977, 1025.487256371814, 8805.911940880509, 9006.819863602692, 10929.016388525071, 11034.613788517363, 11091.55633774656, 646675.0, 656688.0, 667982.0, 680758.0, 683112.0, 69149.65425172843, 85794.0, 105440.0, 108157.0, 122172.38913805374, 1008.9495525223709, 1012.8025035118228, 1039.953202105907, 1042.7653777899911, 1045.947702614866, 18209.726854097466, 18569.44291671252, 18633.627327453647, 18660.440186794418, 18852.905735471235, 44339.0, 50786.746066269436, 50969.0, 51049.744751276005, 52002.0, 73436.63281683557, 73592.26407735854, 74351.0, 75144.62427687827, 75204.24795751972, 8101.10887802353, 8113.472624279403, 8151.347892168731, 8197.508149511048, 8484.066752657327, 12259.509619615472, 12856.357182141042, 12995.935020324838, 13155.53955611549, 13328.866711332763, 11148.275362101762, 11274.041706455044, 11455.255408398427, 11504.0, 11554.248973816675, 5276.261323414648, 9359.766005849908, 9629.614815407305, 11079.944600276947, 11310.434478275889, 11501.309921404743, 11586.826197606873, 11618.76762464763, 11624.476898539417, 11650.708732281422, 8133.593320333841, 8153.877691834746, 8179.263866252066, 8187.877181842397, 8261.38039647041, 9907.910129885851, 10674.199435042558, 11019.889801102207, 11750.647480575597, 11751.412429378326], "unit": "score", "name": "jquery.html", "value": 9293.534597645757}, {"lowerIsBetter": false, "replicates": [1337.7792664210406, 1625.796775403075, 1649.4721689059502, 2005.6991451282306, 2098.6851972204167, 8320.167983201676, 8862.0, 8976.237019853312, 8976.416532925356, 8985.371024028304, 7526.5484070955645, 8678.566071696421, 8881.80095687082, 8962.148595883396, 8973.95513022434, 2217.8225741940687, 2279.4871153990384, 2279.886005699717, 2530.0891678995595, 2573.7812285955715, 2390.4740956989435, 2460.089766786283, 2460.778529932306, 2464.125235541384, 2469.074097213545, 2509.7866681332016, 2544.109561653425, 2555.910543130991, 2559.053150334379, 2560.10396361273, 2500.5374005808985, 2523.5583772839773, 2530.0, 2539.961900571493, 2546.4907018596264, 2492.9750702492925, 2518.534071196816, 2551.017858124617, 2560.116759717894, 2565.961510577343, 9009.963854156791, 9042.502662353569, 9055.366124371296, 9063.864042039375, 9092.408993415473, 5494.917576236359, 5598.300212473441, 5647.971760141214, 5657.8585535361535, 5662.17898404729, 3615.6565126312958, 3674.779513229188, 3748.9625103748886, 3757.1734218472166, 3758.267137908109, 1053.2258789789498, 1074.8763892152424, 1077.1275267033727, 1085.7339951711801, 1110.5613282753268, 10173.0, 12045.879541204564, 12187.451564679523, 12218.389080546027, 12260.632181034583, 4983.0, 5054.69671819692, 5141.305923700327, 5145.562627176732, 5152.02111598795, 10573.788524229627, 10611.0, 10613.204009699304, 10629.0, 10636.89363106359, 5640.266765320482, 5688.459596338341, 5693.060644993612, 5696.743646535916, 5700.458456446631, 4585.633149348044, 4701.929471057937, 4903.141950158708, 5023.949760502422, 5130.127878260705, 4145.336746120666, 4176.519700234451, 4194.517630472535, 4230.386593943861, 4232.3016702243785, 1332.7201287729686, 1356.9185848849102, 1367.6649220940735, 1369.1442848219863, 1371.389731569462, 1139.7663478986788, 1158.5423757615695, 1161.5992482593492, 1341.8591047940022, 1430.2920054573053, 8328.916710832935, 8413.242808147295, 8434.072252052269, 8461.45000574973, 8468.788280293042, 524.9763760630781, 540.3569751995113, 540.4433433563436, 544.7603054655939, 546.6747285365201, 5365.007473617393, 5920.585559010914, 6060.878782424327, 6147.170132032208, 6170.167027451326, 10462.790744185073, 10792.51433685486, 10814.621488247874, 10961.506732197071, 10965.342079475256, 10467.895321046844, 10591.894081059245, 10823.350598964087, 10828.458577071115, 10840.970107839743, 8308.418410711312, 8410.78973025667, 8446.704365347307, 8504.829903401896, 8557.572121393905, 6748.628825414649, 8229.300509456523, 8241.711540096068, 8329.29201017896, 8365.66537338524, 9617.134457898543, 9756.609735610497, 9860.457674827954, 10001.199904007808, 10091.24315676342, 10042.347247428894, 10225.539850706884, 10232.3116685749, 10398.324108932895, 10469.319494233156, 6860.588364698134, 7405.518641288299, 7659.655315510927, 7765.844683106193, 7875.133735288999, 8418.284445822173, 8431.789205269672, 8471.66113355459, 8481.83036339282, 8496.320294376312, 7342.632868356454, 7494.17564067963, 7566.583837888969, 7608.0, 7621.428392870446, 6334.651594162181, 7328.890066648898, 7331.973523706792, 7384.076990376203, 7469.327760501581, 7885.960570197112, 7902.288794008567, 7944.920550794649, 7969.561674107979, 7988.440809143304, 5755.223044888887, 6969.965150174216, 7006.649667516705, 7013.05323781283, 7076.71693132269, 7325.926740732524, 7358.0, 7389.150247721581, 7395.8151046224275, 7399.741009064657], "unit": "score", "name": "mootools.html", "value": 4938.508192926369}, {"lowerIsBetter": false, "replicates": [331.1819805081448, 331.3902419548031, 339.68579064365457, 340.1496259351621, 346.2002773592999, 6493.415592596665, 6564.409203171714, 6569.0, 6572.507061970347, 6590.637514936682, 6511.609303441785, 6523.412892839643, 6561.934380656192, 6575.9013614795695, 6576.473882089434, 4549.931751023721, 4657.720536767804, 4671.696339737923, 4792.544708252711, 4855.174620314555, 4305.6124948754605, 4353.064091220387, 4768.427788665365, 4769.546893045155, 4820.493848145947, 3821.789801560913, 4765.523447655241, 4783.880402989918, 4786.808527658889, 4787.569118779309, 3842.3660096084113, 4468.374427580141, 4602.12559613674, 4737.573618374363, 4743.264793956908, 4068.5117785865887, 4071.9592804071876, 4081.9795901020602, 4082.530508991474, 4094.549599544048, 6138.693065346715, 6165.784197553109, 6168.0, 6195.5663103582765, 6207.441330280297, 5590.832275031715, 5601.243832082698, 5608.971955140199, 5628.971855140739, 5630.746616402272, 5571.693556854371, 6890.827729306758, 6896.413804826596, 6907.827304317432, 6945.0971373721595, 4319.654427645781, 4444.11117776446, 4462.241418958753, 4468.5531446855375, 4482.865514034552, 6969.128858892638, 7089.078419805443, 7103.82240443993, 7104.25405332443, 7134.571925684424, 4509.887252818706, 4511.503734589192, 4536.455625324982, 4560.201964656172, 4560.566746159109, 4598.034412773288, 4609.976950115295, 4610.3084537319, 4628.490866004737, 4630.629549636021, 4713.750856023156, 5001.149804533238, 5457.5633949283965, 5502.367227768777, 5506.421825708323, 5626.212330273765, 6636.469082473391, 6854.2117656469145, 6875.0718652982205, 6960.547564408297, 1594.6810637872472, 1599.4881637876001, 1614.7335689611318, 1622.7809245751907, 1624.6263359427398, 973.2214228617078, 1000.6697789729371, 1027.671145233533, 1031.3914790273775, 1043.5773511727762, 6324.146240257598, 6417.294097649255, 6537.5750576212395, 6544.149260596188, 6555.3772391622715, 7157.785266442015, 7283.817904552428, 7300.452466065067, 7307.707691692272, 7326.450516211199, 6496.447801936793, 6498.740050397932, 6514.022896565553, 6535.411812936859, 6539.934600653933, 3788.3749181385315, 3808.257389809016, 3841.615838416136, 3841.769493830379, 3851.171998020439, 7288.6720097595735, 7589.9374087627775, 7600.8479830404185, 7604.619769011527, 7620.885686714703, 7477.663505142173, 7491.925080749232, 7523.623818809147, 7540.208278130827, 7548.433867459962, 7537.2085930977555, 7576.545407275471, 7579.734709285149, 7587.734429294948, 7588.924110758932, 7007.7249355439035, 7171.175314838861, 7231.8553628928175, 7276.017737605355, 7300.707971681073, 6191.721372538156, 7057.929420705727, 7086.0433841432805, 7135.250798666066, 7137.536060156073, 7524.887126693214, 7545.886811697719, 7547.73582924595, 7548.698052077855, 7549.471536992358, 4728.905421891474, 4764.571188593043, 4774.092922344744, 4780.6175505958745, 4783.928241076456, 6899.379055884994, 7098.25468325839, 7114.679839407136, 7147.356737893615, 7151.106111736033, 6833.897491537531, 6860.6912688930115, 6875.518713689994, 6876.896846547406, 6885.380315771405, 6782.491313151435, 6825.624590647562, 6833.863322733617, 6858.108445902001, 6870.072540207208, 6716.697748601422, 6726.98190542845, 6731.562448440835, 6733.360330768569, 6750.763723269662, 6618.172728408949, 6845.041694162722, 6872.312768723088, 6881.483888708267, 6908.3437073477935, 5380.515753582196, 5896.233489646319, 6478.99575565788, 6708.02733603615, 6751.966240168767], "unit": "score", "name": "prototype.html", "value": 5040.436846090413}, {"lowerIsBetter": false, "replicates": [711.285158415792, 722.6386806596702, 722.9783106506807, 743.8809790433528, 802.6067227058743, 15111.697766044686, 15343.386264549405, 15358.078515289091, 15365.692686146283, 15378.46175383859, 14140.92929535351, 14338.856611433883, 14339.569812905629, 14360.497382591611, 14370.281485925714, 770.6069904348766, 773.5745340062942, 927.4481683398401, 929.0477260807659, 941.2846236860001, 918.7840857398506, 928.4893308680232, 931.2643012020495, 931.7297983584753, 959.3236768078488, 830.5224495914842, 997.6508222122271, 1006.2503434940979, 1006.4866917871901, 1042.3329069395593, 987.4618333008527, 1015.6343716262177, 1016.2682868334787, 1016.9033941775593, 1017.5675337981365, 750.5009168902673, 755.0825746717709, 756.6935391166531, 756.71623141322, 758.3743411685326, 15245.313960871676, 15345.156016419092, 15345.30946107428, 15357.539273821803, 15362.539123826304, 13125.540606078837, 13212.735745285137, 13244.337783110806, 13353.86646133536, 13517.797233041512, 8486.405951583392, 10167.23745719074, 10282.434466104361, 10382.117520010808, 10477.21420893436, 3522.947155792665, 3541.0058451533073, 3600.6039335673054, 3608.025833025095, 3714.9969508232625, 60987.69506152485, 77081.0, 86346.0, 86584.13415865824, 86653.56673216594, 9473.0, 9496.857547136799, 9565.760855978517, 9983.450910200008, 10225.977402259863, 21881.781182188293, 21941.561168776854, 22142.667859982113, 22229.444263893532, 22238.888805555867, 7717.382609391348, 7739.651715672696, 7796.259355361231, 7804.0, 7909.1299957004685, 4143.627073563393, 4210.157968406331, 4270.252705776539, 4284.76433796138, 4324.0919406924895, 3632.636736326346, 3643.6720695137565, 3656.3601369760186, 3658.378075727133, 3663.8351274192723, 646.7380710812129, 666.5534092158266, 674.7132468700783, 675.9628220447922, 677.9050932869402, 573.8135106090538, 597.333972620525, 610.2402508876477, 615.8299231460261, 616.0851136062943, 8351.24838764514, 8356.331493480508, 8490.660373585111, 8566.3146948244, 8677.869831952527, 522.2479629333748, 525.984849240961, 567.8097837224576, 577.5725962787591, 598.8532809461623, 3931.3513270310077, 4106.486689163855, 4237.618614324664, 4261.659067274611, 4340.826366945287, 94722.0527794727, 94832.0, 98515.50742246243, 103371.96628033774, 104188.47905760574, 79866.6006669963, 81438.77841832259, 83656.0, 83920.0, 85072.0, 59626.40373596295, 70097.0, 75324.62337688386, 75465.0, 75607.62196188983, 6891.862162756817, 8389.875390964751, 8474.915250847413, 8600.483970961763, 8609.870851937101, 31029.379412412076, 50388.99222015466, 52233.47766522438, 52321.47678523166, 52825.73587132194, 70655.0, 73942.0, 74303.0, 74408.62795685987, 74536.62731686307, 11195.0, 11433.256838305817, 11546.59586914454, 11743.94304512598, 11746.236494627821, 11994.280343179436, 12033.63899083029, 12046.578369757017, 12106.273623582612, 12815.679608009501, 11392.373419461677, 11557.01765349921, 11831.704207394883, 11948.940255299016, 12105.75788484243, 11537.926788090625, 12000.39998000079, 12172.513099475922, 12181.269123852242, 12392.62822115338, 11161.776764464828, 11628.418579070843, 11636.185467017227, 11658.417079146178, 11847.170698051053, 8544.829103418022, 10064.496775161359, 10295.17638588896, 10389.48052597352, 10402.063814256451, 9444.338896277195, 9552.85670714926, 9963.0, 10034.849477257992, 10061.446620435947], "unit": "score", "name": "yui.html", "value": 7104.88004495561}], "name": "dromaeo_css", "value": 7587.487111481413}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 108.0, 110.0, 109.0, 111.0, 115.0, 164.0, 162.0, 113.0, 108.0], "unit": "score", "name": "ai-astar", "value": 121.0}, {"lowerIsBetter": true, "replicates": [156.0, 119.0, 154.0, 147.0, 116.0, 141.0, 136.0, 117.0, 157.0, 117.0], "unit": "score", "name": "audio-beat-detection", "value": 136.0}, {"lowerIsBetter": true, "replicates": [184.0, 185.0, 183.0, 188.0, 189.0, 184.0, 186.0, 184.0, 187.0, 184.0], "unit": "score", "name": "audio-dft", "value": 185.4}, {"lowerIsBetter": true, "replicates": [76.0, 71.0, 76.0, 117.0, 55.0, 56.0, 57.0, 57.0, 120.0, 57.0], "unit": "score", "name": "audio-fft", "value": 74.2}, {"lowerIsBetter": true, "replicates": [91.0, 94.0, 128.0, 80.0, 78.0, 84.0, 118.0, 76.0, 78.0, 116.0], "unit": "score", "name": "audio-oscillator", "value": 94.3}, {"lowerIsBetter": true, "replicates": [89.0, 85.0, 88.0, 85.0, 88.0, 84.0, 89.0, 85.0, 88.0, 91.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 87.2}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 94.0, 93.0, 93.0, 94.0, 94.0, 93.0, 92.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 93.2}, {"lowerIsBetter": true, "replicates": [86.0, 85.0, 84.0, 84.0, 85.0, 86.0, 86.0, 87.0, 84.0, 88.0], "unit": "score", "name": "imaging-desaturate", "value": 85.5}, {"lowerIsBetter": true, "replicates": [57.0, 59.0, 59.0, 58.0, 57.0, 57.0, 58.0, 67.0, 55.0, 51.0], "unit": "score", "name": "json-parse-financial", "value": 57.8}, {"lowerIsBetter": true, "replicates": [64.0, 62.0, 68.0, 70.0, 76.0, 73.0, 67.0, 66.0, 65.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.9}, {"lowerIsBetter": true, "replicates": [79.0, 80.0, 81.0, 80.0, 80.0, 79.0, 80.0, 77.0, 80.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.0}, {"lowerIsBetter": true, "replicates": [117.0, 115.0, 119.0, 116.0, 118.0, 116.0, 120.0, 118.0, 117.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.8}, {"lowerIsBetter": true, "replicates": [128.0, 123.0, 133.0, 133.0, 135.0, 121.0, 135.0, 133.0, 130.0, 132.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 130.3}, {"lowerIsBetter": true, "replicates": [65.0, 68.0, 69.0, 91.0, 93.0, 96.0, 94.0, 97.0, 74.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 81.1}], "name": "kraken", "value": 1411.6999999999998}]} 03:19:21 INFO - Return code: 0 03:19:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:19:21 INFO - # TBPL SUCCESS # 03:19:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:19:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:19:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:19:21 INFO - 2016-03-11 03:19:21.904 screenresolution[1953:15041] starting screenresolution argv=screenresolution get 03:19:21 INFO - 2016-03-11 03:19:21.906 screenresolution[1953:15041] Display 0: 1600x1200x32@60 03:19:21 INFO - 2016-03-11 03:19:21.912 screenresolution[1954:15044] starting screenresolution argv=screenresolution list 03:19:21 INFO - Available Modes on Display 0 03:19:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:19:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:19:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:19:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:19:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:19:22 INFO - Intel Iris: 03:19:22 INFO - Chipset Model: Intel Iris 03:19:22 INFO - Type: GPU 03:19:22 INFO - Bus: Built-In 03:19:22 INFO - VRAM (Dynamic, Max): 1536 MB 03:19:22 INFO - Vendor: Intel (0x8086) 03:19:22 INFO - Device ID: 0x0a2e 03:19:22 INFO - Revision ID: 0x0009 03:19:22 INFO - Displays: 03:19:22 INFO - Display: 03:19:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:19:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:19:22 INFO - Display Serial Number: 1600x1200 60 03:19:22 INFO - Main Display: Yes 03:19:22 INFO - Mirror: Off 03:19:22 INFO - Online: Yes 03:19:22 INFO - Rotation: Supported 03:19:22 INFO - Return code: 0 03:19:22 INFO - Running post-action listener: _resource_record_post_action 03:19:22 INFO - Running post-run listener: _resource_record_post_run 03:19:23 INFO - Total resource usage - Wall time: 1204s; CPU: 52.0%; Read bytes: 626688; Write bytes: 662974464; Read time: 12; Write time: 2015 03:19:23 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 357677568; Write bytes: 352761344; Read time: 28000; Write time: 678 03:19:23 INFO - run-tests - Wall time: 1172s; CPU: 52.0%; Read bytes: 626688; Write bytes: 299043328; Read time: 12; Write time: 1305 03:19:23 INFO - Running post-run listener: _upload_blobber_files 03:19:23 INFO - Blob upload gear active. 03:19:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:19:23 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 03:19:23 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'] 03:19:23 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 03:19:23 INFO - (blobuploader) - INFO - Open directory for files ... 03:19:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:19:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:19:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:19:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:19:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:19:24 INFO - (blobuploader) - INFO - Done attempting. 03:19:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:19:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:19:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:19:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:19:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:19:25 INFO - (blobuploader) - INFO - Done attempting. 03:19:25 INFO - (blobuploader) - INFO - Iteration through files over. 03:19:25 INFO - Return code: 0 03:19:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:19:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:19:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b147eb6185ee1f5744756b3963113d91af957223fb17afe23a0320c19c6df6c4fe23055cb1af98cde3b8e7796e0ee8ad452a064dab07625fa5ea0496d1a29a6b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6ed8eb7fa2c089c6ea085e4d3b7b76351abdafac8241e9f576ea976be331b9620285a7980a7f548b4873311be064cc574b875b785f0c91d483ebd45932fd3149"} 03:19:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:19:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:19:25 INFO - Contents: 03:19:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b147eb6185ee1f5744756b3963113d91af957223fb17afe23a0320c19c6df6c4fe23055cb1af98cde3b8e7796e0ee8ad452a064dab07625fa5ea0496d1a29a6b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6ed8eb7fa2c089c6ea085e4d3b7b76351abdafac8241e9f576ea976be331b9620285a7980a7f548b4873311be064cc574b875b785f0c91d483ebd45932fd3149"} 03:19:25 INFO - Running post-run listener: copy_logs_to_upload_dir 03:19:25 INFO - Copying logs to upload dir... 03:19:25 INFO - mkdir: /builds/slave/test/build/upload/logs 03:19:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.165118 ========= master_lag: 4.77 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-03-11 03:19:30.590289) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-11 03:19:30.598071) ========= 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.VyBqeQXpct/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.bZ9MPa1mr0/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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/b147eb6185ee1f5744756b3963113d91af957223fb17afe23a0320c19c6df6c4fe23055cb1af98cde3b8e7796e0ee8ad452a064dab07625fa5ea0496d1a29a6b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6ed8eb7fa2c089c6ea085e4d3b7b76351abdafac8241e9f576ea976be331b9620285a7980a7f548b4873311be064cc574b875b785f0c91d483ebd45932fd3149"} build_url:https://queue.taskcluster.net/v1/task/SA84dTW_Skaua555nkqQPQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011015 build_url: 'https://queue.taskcluster.net/v1/task/SA84dTW_Skaua555nkqQPQ/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/b147eb6185ee1f5744756b3963113d91af957223fb17afe23a0320c19c6df6c4fe23055cb1af98cde3b8e7796e0ee8ad452a064dab07625fa5ea0496d1a29a6b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6ed8eb7fa2c089c6ea085e4d3b7b76351abdafac8241e9f576ea976be331b9620285a7980a7f548b4873311be064cc574b875b785f0c91d483ebd45932fd3149"}' ========= master_lag: 0.29 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-11 03:19:30.894326) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 03:19:30.897672) ========= 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.VyBqeQXpct/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.bZ9MPa1mr0/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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.005304 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 03:19:30.924688) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-11 03:19:30.924990) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-11 03:19:30.929217) ========= ========= Total master_lag: 5.25 =========