builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0032 starttime: 1460109098.28 results: success (0) buildid: 20160408004012 builduid: 1b5cfc3d9c354abfbb38b762797151a6 revision: 6adef622c36b1ff4d388e1199f1ee328651ac616 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-08 02:51:38.281838) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-08 02:51:38.282248) ========= ========= Started set props: basedir (results: 0, elapsed: 16 secs) (at 2016-04-08 02:51:38.286605) ========= 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.dTEXCA5y8o/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.c4NrSezioQ/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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.005276 basedir: '/builds/slave/test' ========= master_lag: 16.66 ========= ========= Finished set props: basedir (results: 0, elapsed: 16 secs) (at 2016-04-08 02:51:54.956683) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 23 secs) (at 2016-04-08 02:51:54.956996) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 23 secs) (at 2016-04-08 02:52:18.734127) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-04-08 02:52:18.734397) ========= 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.dTEXCA5y8o/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.c4NrSezioQ/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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.006080 ========= master_lag: 1.14 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-04-08 02:52:19.881434) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-08 02:52:19.887756) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-08 02:52:19.888128) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-08 02:52:19.888403) ========= 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.dTEXCA5y8o/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.c4NrSezioQ/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-08 02:52:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 24.4M=0s 2016-04-08 02:52:21 (24.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.594996 ========= master_lag: 1.50 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-08 02:52:21.987436) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 02:52:21.990583) ========= 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.dTEXCA5y8o/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.c4NrSezioQ/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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.026720 ========= master_lag: 0.13 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 02:52:22.148817) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-08 02:52:22.149144) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6adef622c36b1ff4d388e1199f1ee328651ac616 --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 6adef622c36b1ff4d388e1199f1ee328651ac616 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dTEXCA5y8o/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.c4NrSezioQ/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-08 02:52:22,273 truncating revision to first 12 chars 2016-04-08 02:52:22,274 Setting DEBUG logging. 2016-04-08 02:52:22,274 attempt 1/10 2016-04-08 02:52:22,274 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/6adef622c36b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-08 02:52:23,018 unpacking tar archive at: mozilla-aurora-6adef622c36b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.998647 ========= master_lag: 0.64 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-08 02:52:23.784107) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 1 secs) (at 2016-04-08 02:52:23.784409) ========= echo 6adef622c36b1ff4d388e1199f1ee328651ac616 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'6adef622c36b1ff4d388e1199f1ee328651ac616'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dTEXCA5y8o/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.c4NrSezioQ/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 6adef622c36b1ff4d388e1199f1ee328651ac616 program finished with exit code 0 elapsedTime=0.006069 script_repo_revision: '6adef622c36b1ff4d388e1199f1ee328651ac616' ========= master_lag: 1.49 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 1 secs) (at 2016-04-08 02:52:25.280573) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 24 secs) (at 2016-04-08 02:52:25.280867) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 24 secs) (at 2016-04-08 02:52:49.496033) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-04-08 02:52:49.496453) ========= /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.dTEXCA5y8o/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.c4NrSezioQ/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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:52:50 INFO - MultiFileLogger online at 20160408 02:52:50 in /builds/slave/test 02:52:50 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:52:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:52:50 INFO - {'append_to_log': False, 02:52:50 INFO - 'base_work_dir': '/builds/slave/test', 02:52:50 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:52:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:52:50 INFO - 'branch': 'Mozilla-Aurora', 02:52:50 INFO - 'buildbot_json_path': 'buildprops.json', 02:52:50 INFO - 'config_files': ('talos/mac_config.py',), 02:52:50 INFO - 'default_actions': ('clobber', 02:52:50 INFO - 'read-buildbot-config', 02:52:50 INFO - 'download-and-extract', 02:52:50 INFO - 'populate-webroot', 02:52:50 INFO - 'create-virtualenv', 02:52:50 INFO - 'install', 02:52:50 INFO - 'run-tests'), 02:52:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:52:50 INFO - 'download_minidump_stackwalk': True, 02:52:50 INFO - 'download_symbols': 'ondemand', 02:52:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:52:50 INFO - 'tooltool.py': '/tools/tooltool.py', 02:52:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:52:50 INFO - '/tools/misc-python/virtualenv.py')}, 02:52:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:52:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:52:50 INFO - 'installer_path': 'installer.exe', 02:52:50 INFO - 'log_level': 'info', 02:52:50 INFO - 'log_name': 'talos', 02:52:50 INFO - 'log_to_console': True, 02:52:50 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:52:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:52:50 INFO - 'opt_config_files': (), 02:52:50 INFO - 'pip_index': False, 02:52:50 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:52:50 INFO - 'cmd': ('bash', 02:52:50 INFO - '-c', 02:52:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:52:50 INFO - 'enabled': True, 02:52:50 INFO - 'halt_on_failure': False, 02:52:50 INFO - 'name': 'check_screen_resolution'},), 02:52:50 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:52:50 INFO - 'cmd': ('bash', 02:52:50 INFO - '-c', 02:52:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:52:50 INFO - 'enabled': True, 02:52:50 INFO - 'halt_on_failure': False, 02:52:50 INFO - 'name': 'check_screen_resolution'},), 02:52:50 INFO - 'run_cmd_checks_enabled': True, 02:52:50 INFO - 'sps_profile': False, 02:52:50 INFO - 'sps_profile_interval': 0, 02:52:50 INFO - 'suite': 'dromaeojs', 02:52:50 INFO - 'system_bits': '32', 02:52:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:52:50 INFO - 'title': 't-yosemite-r7-0032', 02:52:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:52:50 INFO - 'use_talos_json': True, 02:52:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:52:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:52:50 INFO - 'work_dir': 'build'} 02:52:50 INFO - ##### 02:52:50 INFO - ##### Running clobber step. 02:52:50 INFO - ##### 02:52:50 INFO - Running pre-action listener: _resource_record_pre_action 02:52:50 INFO - Running main action method: clobber 02:52:50 INFO - rmtree: /builds/slave/test/build 02:52:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:52:52 INFO - Running post-action listener: _resource_record_post_action 02:52:52 INFO - ##### 02:52:52 INFO - ##### Running read-buildbot-config step. 02:52:52 INFO - ##### 02:52:52 INFO - Running pre-action listener: _resource_record_pre_action 02:52:52 INFO - Running main action method: read_buildbot_config 02:52:52 INFO - Using buildbot properties: 02:52:52 INFO - { 02:52:52 INFO - "project": "", 02:52:52 INFO - "product": "firefox", 02:52:52 INFO - "script_repo_revision": "production", 02:52:52 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 02:52:52 INFO - "repository": "", 02:52:52 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 02:52:52 INFO - "buildid": "20160408004012", 02:52:52 INFO - "stage_platform": "macosx64", 02:52:52 INFO - "basedir": "/builds/slave/test", 02:52:52 INFO - "nightly_build": "True", 02:52:52 INFO - "buildnumber": 266, 02:52:52 INFO - "slavename": "t-yosemite-r7-0032", 02:52:52 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 02:52:52 INFO - "platform": "yosemite_r7", 02:52:52 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:52:52 INFO - "branch": "mozilla-aurora", 02:52:52 INFO - "repo_path": "releases/mozilla-aurora", 02:52:52 INFO - "revision": "6adef622c36b1ff4d388e1199f1ee328651ac616", 02:52:52 INFO - "pgo_build": "False", 02:52:52 INFO - "builduid": "1b5cfc3d9c354abfbb38b762797151a6", 02:52:52 INFO - "slavebuilddir": "test" 02:52:52 INFO - } 02:52:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/ImiGljzWSgGgBNSd5WYmDw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 02:52:52 INFO - Running post-action listener: _resource_record_post_action 02:52:52 INFO - ##### 02:52:52 INFO - ##### Running download-and-extract step. 02:52:52 INFO - ##### 02:52:52 INFO - Running pre-action listener: _resource_record_pre_action 02:52:52 INFO - Running main action method: download_and_extract 02:52:52 INFO - mkdir: /builds/slave/test/build/tests 02:52:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:52 INFO - https://queue.taskcluster.net/v1/task/ImiGljzWSgGgBNSd5WYmDw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 02:52:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImiGljzWSgGgBNSd5WYmDw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 02:52:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImiGljzWSgGgBNSd5WYmDw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 02:52:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImiGljzWSgGgBNSd5WYmDw/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:52:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImiGljzWSgGgBNSd5WYmDw/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:52:53 INFO - Downloaded 1277 bytes. 02:52:53 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 02:52:53 INFO - Using the following test package requirements: 02:52:53 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 02:52:53 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:52:53 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 02:52:53 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:52:53 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 02:52:53 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:52:53 INFO - u'jsshell-mac.zip'], 02:52:53 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:52:53 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 02:52:53 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 02:52:53 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:52:53 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 02:52:53 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:52:53 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 02:52:53 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:52:53 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 02:52:53 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 02:52:53 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:52:53 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 02:52:53 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:52:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:53 INFO - https://queue.taskcluster.net/v1/task/ImiGljzWSgGgBNSd5WYmDw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:52:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImiGljzWSgGgBNSd5WYmDw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:52:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImiGljzWSgGgBNSd5WYmDw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:52:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImiGljzWSgGgBNSd5WYmDw/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:52:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImiGljzWSgGgBNSd5WYmDw/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:52:54 INFO - Downloaded 17904262 bytes. 02:52:54 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:52:54 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:52:57 INFO - Return code: 0 02:52:57 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:52:57 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:52:57 INFO - https://queue.taskcluster.net/v1/task/ImiGljzWSgGgBNSd5WYmDw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:52:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImiGljzWSgGgBNSd5WYmDw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:52:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImiGljzWSgGgBNSd5WYmDw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:52:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImiGljzWSgGgBNSd5WYmDw/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:52:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImiGljzWSgGgBNSd5WYmDw/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:52:59 INFO - Downloaded 17904262 bytes. 02:52:59 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:52:59 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:53:02 INFO - Return code: 0 02:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:53:02 INFO - https://queue.taskcluster.net/v1/task/ImiGljzWSgGgBNSd5WYmDw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:53:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImiGljzWSgGgBNSd5WYmDw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 02:53:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImiGljzWSgGgBNSd5WYmDw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 02:53:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImiGljzWSgGgBNSd5WYmDw/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:53:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImiGljzWSgGgBNSd5WYmDw/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:53:03 INFO - Downloaded 10845168 bytes. 02:53:03 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:53:03 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:53:03 INFO - Return code: 0 02:53: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:53:03 INFO - https://queue.taskcluster.net/v1/task/ImiGljzWSgGgBNSd5WYmDw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 02:53:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImiGljzWSgGgBNSd5WYmDw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:53:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImiGljzWSgGgBNSd5WYmDw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:53:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImiGljzWSgGgBNSd5WYmDw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 02:53:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ImiGljzWSgGgBNSd5WYmDw/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:53:07 INFO - Downloaded 115320502 bytes. 02:53:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ImiGljzWSgGgBNSd5WYmDw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:53:07 INFO - mkdir: /builds/slave/test/properties 02:53:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:53:07 INFO - Writing to file /builds/slave/test/properties/build_url 02:53:07 INFO - Contents: 02:53:07 INFO - build_url:https://queue.taskcluster.net/v1/task/ImiGljzWSgGgBNSd5WYmDw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:53:08 INFO - Running post-action listener: _resource_record_post_action 02:53:08 INFO - Running post-action listener: set_extra_try_arguments 02:53:08 INFO - ##### 02:53:08 INFO - ##### Running populate-webroot step. 02:53:08 INFO - ##### 02:53:08 INFO - Running pre-action listener: _resource_record_pre_action 02:53:08 INFO - Running main action method: populate_webroot 02:53:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:53:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:53:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:53:08 INFO - '--tppagecycles', 02:53:08 INFO - '7'], 02:53:08 INFO - 'tests': ['tsvgm']}}, 02:53:08 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:53:08 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:53:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:53:08 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 02:53:08 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:53:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:53:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:53:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:53:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:53:08 INFO - 'talos_options': ['--e10s'], 02:53:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:53:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:53:08 INFO - 'tests': ['damp', 'tps']}, 02:53:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:53:08 INFO - 'talos_options': ['--e10s'], 02:53:08 INFO - 'tests': ['damp', 'tps']}, 02:53:08 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:53:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:53:08 INFO - 'other': {'tests': ['a11yr', 02:53:08 INFO - 'ts_paint', 02:53:08 INFO - 'tpaint', 02:53:08 INFO - 'sessionrestore', 02:53:08 INFO - 'sessionrestore_no_auto_restore', 02:53:08 INFO - 'tabpaint']}, 02:53:08 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:53:08 INFO - 'tests': ['a11yr', 02:53:08 INFO - 'ts_paint', 02:53:08 INFO - 'tpaint', 02:53:08 INFO - 'sessionrestore', 02:53:08 INFO - 'sessionrestore_no_auto_restore', 02:53:08 INFO - 'tabpaint']}, 02:53:08 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:53:08 INFO - 'tests': ['a11yr', 02:53:08 INFO - 'ts_paint', 02:53:08 INFO - 'tpaint', 02:53:08 INFO - 'sessionrestore', 02:53:08 INFO - 'sessionrestore_no_auto_restore', 02:53:08 INFO - 'tabpaint']}, 02:53:08 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:53:08 INFO - 'tests': ['a11yr', 02:53:08 INFO - 'ts_paint', 02:53:08 INFO - 'tpaint', 02:53:08 INFO - 'sessionrestore', 02:53:08 INFO - 'sessionrestore_no_auto_restore', 02:53:08 INFO - 'tabpaint']}, 02:53:08 INFO - 'other_l64': {'tests': ['a11yr', 02:53:08 INFO - 'ts_paint', 02:53:08 INFO - 'tpaint', 02:53:08 INFO - 'sessionrestore', 02:53:08 INFO - 'sessionrestore_no_auto_restore', 02:53:08 INFO - 'tabpaint']}, 02:53:08 INFO - 'other_nol64': {'tests': ['a11yr', 02:53:08 INFO - 'ts_paint', 02:53:08 INFO - 'tpaint', 02:53:08 INFO - 'sessionrestore', 02:53:08 INFO - 'sessionrestore_no_auto_restore', 02:53:08 INFO - 'tabpaint']}, 02:53:08 INFO - 'svgr': {'tests': ['tsvgx', 02:53:08 INFO - 'tsvgr_opacity', 02:53:08 INFO - 'tart', 02:53:08 INFO - 'tscrollx', 02:53:08 INFO - 'cart']}, 02:53:08 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:53:08 INFO - 'tests': ['tsvgx', 02:53:08 INFO - 'tsvgr_opacity', 02:53:08 INFO - 'tart', 02:53:08 INFO - 'tscrollx', 02:53:08 INFO - 'cart']}, 02:53:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:53:08 INFO - 'tests': ['tp5o']}, 02:53:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:53:08 INFO - 'talos_options': ['--e10s'], 02:53:08 INFO - 'tests': ['tp5o']}, 02:53:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:53:08 INFO - 'talos_options': ['--xperf_path', 02:53:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:53:08 INFO - 'tests': ['tp5n']}, 02:53:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:53:08 INFO - 'talos_options': ['--e10s', 02:53:08 INFO - '--xperf_path', 02:53:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:53:08 INFO - 'tests': ['tp5n']}}, 02:53:08 INFO - 'talos.zip': {'path': '', 02:53:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:53:08 INFO - Running post-action listener: _resource_record_post_action 02:53:08 INFO - ##### 02:53:08 INFO - ##### Running create-virtualenv step. 02:53:08 INFO - ##### 02:53:08 INFO - Running pre-action listener: _resource_record_pre_action 02:53:08 INFO - Running main action method: create_virtualenv 02:53:08 INFO - Creating virtualenv /builds/slave/test/build/venv 02:53:08 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:53:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:53:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:53:09 INFO - Using real prefix '/tools/python27' 02:53:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:53:09 INFO - Installing distribute.............................................................................................................................................................................................done. 02:53:12 INFO - Installing pip.................done. 02:53:12 INFO - Return code: 0 02:53:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:53: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:53:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53: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:53:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ed66a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed6d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89e3c6c880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec0ad30>, '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 0x10ea6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec01b20>, '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.dTEXCA5y8o/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.c4NrSezioQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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:53:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:53:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:53:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dTEXCA5y8o/Render', 02:53:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:12 INFO - 'HOME': '/Users/cltbld', 02:53:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:12 INFO - 'LOGNAME': 'cltbld', 02:53:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:12 INFO - 'MOZ_NO_REMOTE': '1', 02:53:12 INFO - 'NO_EM_RESTART': '1', 02:53:12 INFO - 'PAGER': '/bin/cat', 02:53:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:12 INFO - 'PWD': '/builds/slave/test', 02:53:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:12 INFO - 'SHELL': '/bin/bash', 02:53:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c4NrSezioQ/Listeners', 02:53:12 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 02:53:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:12 INFO - 'USER': 'cltbld', 02:53:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:12 INFO - 'XPC_FLAGS': '0x0', 02:53:12 INFO - 'XPC_SERVICE_NAME': '0', 02:53:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:12 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:53:12 INFO - Cleaning up... 02:53:12 INFO - Return code: 0 02:53:12 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:53: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:53:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53: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:53:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ed66a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed6d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89e3c6c880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec0ad30>, '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 0x10ea6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec01b20>, '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.dTEXCA5y8o/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.c4NrSezioQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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:53:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:53:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:53:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dTEXCA5y8o/Render', 02:53:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:12 INFO - 'HOME': '/Users/cltbld', 02:53:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:12 INFO - 'LOGNAME': 'cltbld', 02:53:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:12 INFO - 'MOZ_NO_REMOTE': '1', 02:53:12 INFO - 'NO_EM_RESTART': '1', 02:53:12 INFO - 'PAGER': '/bin/cat', 02:53:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:12 INFO - 'PWD': '/builds/slave/test', 02:53:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:12 INFO - 'SHELL': '/bin/bash', 02:53:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c4NrSezioQ/Listeners', 02:53:12 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 02:53:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:12 INFO - 'USER': 'cltbld', 02:53:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:12 INFO - 'XPC_FLAGS': '0x0', 02:53:12 INFO - 'XPC_SERVICE_NAME': '0', 02:53:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:13 INFO - Downloading/unpacking psutil>=0.7.1 02:53: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:53: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:53: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:53: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:53: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:53: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:53:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:53:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:53:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:53:15 INFO - Installing collected packages: psutil 02:53:15 INFO - Running setup.py install for psutil 02:53:15 INFO - building 'psutil._psutil_osx' extension 02:53:15 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:53:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 02:53:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 02:53:16 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 02:53:16 INFO - building 'psutil._psutil_posix' extension 02:53:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 02:53:16 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:53:16 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:53:16 INFO - ^ 02:53:16 INFO - 1 warning generated. 02:53:16 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 02:53:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:53:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:53:16 INFO - Successfully installed psutil 02:53:16 INFO - Cleaning up... 02:53:17 INFO - Return code: 0 02:53:17 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:53:17 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:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:17 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:53:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:17 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 0x10ed66a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed6d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89e3c6c880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec0ad30>, '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 0x10ea6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec01b20>, '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.dTEXCA5y8o/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.c4NrSezioQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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:53:17 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:53:17 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:53:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dTEXCA5y8o/Render', 02:53:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:17 INFO - 'HOME': '/Users/cltbld', 02:53:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:17 INFO - 'LOGNAME': 'cltbld', 02:53:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:17 INFO - 'MOZ_NO_REMOTE': '1', 02:53:17 INFO - 'NO_EM_RESTART': '1', 02:53:17 INFO - 'PAGER': '/bin/cat', 02:53:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:17 INFO - 'PWD': '/builds/slave/test', 02:53:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:17 INFO - 'SHELL': '/bin/bash', 02:53:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c4NrSezioQ/Listeners', 02:53:17 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 02:53:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:17 INFO - 'USER': 'cltbld', 02:53:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:17 INFO - 'XPC_FLAGS': '0x0', 02:53:17 INFO - 'XPC_SERVICE_NAME': '0', 02:53:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:17 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:19 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:53:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:53:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:53:19 INFO - Installing collected packages: mozsystemmonitor 02:53:19 INFO - Running setup.py install for mozsystemmonitor 02:53:19 INFO - Successfully installed mozsystemmonitor 02:53:19 INFO - Cleaning up... 02:53:19 INFO - Return code: 0 02:53:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:53:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:53:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:53:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ed66a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed6d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89e3c6c880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec0ad30>, '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 0x10ea6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec01b20>, '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.dTEXCA5y8o/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.c4NrSezioQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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:53:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:53:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:53:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dTEXCA5y8o/Render', 02:53:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:19 INFO - 'HOME': '/Users/cltbld', 02:53:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:19 INFO - 'LOGNAME': 'cltbld', 02:53:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:19 INFO - 'MOZ_NO_REMOTE': '1', 02:53:19 INFO - 'NO_EM_RESTART': '1', 02:53:19 INFO - 'PAGER': '/bin/cat', 02:53:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:19 INFO - 'PWD': '/builds/slave/test', 02:53:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:19 INFO - 'SHELL': '/bin/bash', 02:53:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c4NrSezioQ/Listeners', 02:53:19 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 02:53:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:19 INFO - 'USER': 'cltbld', 02:53:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:19 INFO - 'XPC_FLAGS': '0x0', 02:53:19 INFO - 'XPC_SERVICE_NAME': '0', 02:53:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:20 INFO - Downloading/unpacking blobuploader==1.2.4 02:53:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:22 INFO - Downloading blobuploader-1.2.4.tar.gz 02:53:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:53:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:53:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:53:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:23 INFO - Downloading docopt-0.6.1.tar.gz 02:53:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:53:23 INFO - Installing collected packages: blobuploader, requests, docopt 02:53:23 INFO - Running setup.py install for blobuploader 02:53:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:53:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:53:23 INFO - Running setup.py install for requests 02:53:24 INFO - Running setup.py install for docopt 02:53:24 INFO - Successfully installed blobuploader requests docopt 02:53:24 INFO - Cleaning up... 02:53:24 INFO - Return code: 0 02:53:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:53:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:53:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:53:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ed66a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed6d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89e3c6c880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec0ad30>, '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 0x10ea6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec01b20>, '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.dTEXCA5y8o/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.c4NrSezioQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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:53:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:53:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:53:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dTEXCA5y8o/Render', 02:53:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:24 INFO - 'HOME': '/Users/cltbld', 02:53:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:24 INFO - 'LOGNAME': 'cltbld', 02:53:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:24 INFO - 'MOZ_NO_REMOTE': '1', 02:53:24 INFO - 'NO_EM_RESTART': '1', 02:53:24 INFO - 'PAGER': '/bin/cat', 02:53:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:24 INFO - 'PWD': '/builds/slave/test', 02:53:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:24 INFO - 'SHELL': '/bin/bash', 02:53:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c4NrSezioQ/Listeners', 02:53:24 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 02:53:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:24 INFO - 'USER': 'cltbld', 02:53:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:24 INFO - 'XPC_FLAGS': '0x0', 02:53:24 INFO - 'XPC_SERVICE_NAME': '0', 02:53:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:53:25 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-fgIKLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:53:25 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-A5NQvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:53:25 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-ViXdwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:53:25 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-3AmnI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:53:25 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-hCnKFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:53:25 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-ETBabH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:53:25 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-lQoWN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:53:25 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-Soc9f4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:53:25 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-fxFvIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:53:25 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-0o6NDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:53:26 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-sULrMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:53:26 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-f16udy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:53:26 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-w1Sudy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:53:26 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-pXwnz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:53:26 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-hR02mi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:53:26 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-V2ct4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:53:26 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-d9_TPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:53:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:53:26 INFO - Running setup.py install for manifestparser 02:53:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:53:26 INFO - Running setup.py install for mozcrash 02:53:27 INFO - Running setup.py install for mozdebug 02:53:27 INFO - Running setup.py install for mozdevice 02:53:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:53:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:53:27 INFO - Running setup.py install for mozfile 02:53:27 INFO - Running setup.py install for mozhttpd 02:53:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:53:27 INFO - Running setup.py install for mozinfo 02:53:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:53:27 INFO - Running setup.py install for mozInstall 02:53:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:53:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:53:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:53:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:53:27 INFO - Running setup.py install for mozleak 02:53:28 INFO - Running setup.py install for mozlog 02:53:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:53:28 INFO - Running setup.py install for moznetwork 02:53:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:53:28 INFO - Running setup.py install for mozprocess 02:53:28 INFO - Running setup.py install for mozprofile 02:53:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:53:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:53:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:53:28 INFO - Running setup.py install for mozrunner 02:53:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:53:28 INFO - Running setup.py install for mozscreenshot 02:53:29 INFO - Running setup.py install for moztest 02:53:29 INFO - Running setup.py install for mozversion 02:53:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:53:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:53:29 INFO - Cleaning up... 02:53:29 INFO - Return code: 0 02:53:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:53:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:53:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:53:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ed66a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed6d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89e3c6c880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec0ad30>, '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 0x10ea6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec01b20>, '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.dTEXCA5y8o/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.c4NrSezioQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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:53:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:53:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:53:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dTEXCA5y8o/Render', 02:53:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:29 INFO - 'HOME': '/Users/cltbld', 02:53:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:29 INFO - 'LOGNAME': 'cltbld', 02:53:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:29 INFO - 'MOZ_NO_REMOTE': '1', 02:53:29 INFO - 'NO_EM_RESTART': '1', 02:53:29 INFO - 'PAGER': '/bin/cat', 02:53:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:29 INFO - 'PWD': '/builds/slave/test', 02:53:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:29 INFO - 'SHELL': '/bin/bash', 02:53:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c4NrSezioQ/Listeners', 02:53:29 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 02:53:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:29 INFO - 'USER': 'cltbld', 02:53:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:29 INFO - 'XPC_FLAGS': '0x0', 02:53:29 INFO - 'XPC_SERVICE_NAME': '0', 02:53:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:53:29 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-tPjZv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:53:29 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:53:29 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-ptfQ9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:53:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:53:29 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-v_ynQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:53:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:53:29 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-_DMn9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:53:30 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:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:53:30 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-mO30i_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:53:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:53:30 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-eA4FBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:53:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:53:30 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-w3DL13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:53:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:53:30 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-Ia5efi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:53:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:53:30 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-4nQBDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:53:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:53:30 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-E27YJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:53:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:53:30 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-dAyJ7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:53:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:53:30 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-98Jpq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:53:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:53:30 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-tqAyEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:53:31 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:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:53:31 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-pqoaYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:53:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:53:31 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-EdDnMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:53:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:53:31 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-SBP5fR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:53:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:53:31 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-D7x_5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:53:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:53:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:53:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:53:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:53:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:53:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:53:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:33 INFO - Downloading blessings-1.6.tar.gz 02:53:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:53:33 INFO - Installing collected packages: blessings 02:53:33 INFO - Running setup.py install for blessings 02:53:34 INFO - Successfully installed blessings 02:53:34 INFO - Cleaning up... 02:53:34 INFO - Return code: 0 02:53:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:53:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:53:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:53:34 INFO - Reading from file tmpfile_stdout 02:53:34 INFO - Current package versions: 02:53:34 INFO - blessings == 1.6 02:53:34 INFO - blobuploader == 1.2.4 02:53:34 INFO - docopt == 0.6.1 02:53:34 INFO - manifestparser == 1.1 02:53:34 INFO - mozInstall == 1.12 02:53:34 INFO - mozcrash == 0.17 02:53:34 INFO - mozdebug == 0.1 02:53:34 INFO - mozdevice == 0.48 02:53:34 INFO - mozfile == 1.2 02:53:34 INFO - mozhttpd == 0.7 02:53:34 INFO - mozinfo == 0.9 02:53:34 INFO - mozleak == 0.1 02:53:34 INFO - mozlog == 3.1 02:53:34 INFO - moznetwork == 0.27 02:53:34 INFO - mozprocess == 0.22 02:53:34 INFO - mozprofile == 0.28 02:53:34 INFO - mozrunner == 6.11 02:53:34 INFO - mozscreenshot == 0.1 02:53:34 INFO - mozsystemmonitor == 0.0 02:53:34 INFO - moztest == 0.7 02:53:34 INFO - mozversion == 1.4 02:53:34 INFO - psutil == 3.1.1 02:53:34 INFO - requests == 1.2.3 02:53:34 INFO - wsgiref == 0.1.2 02:53:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:53: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:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53: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:53:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ed66a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed6d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89e3c6c880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec0ad30>, '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 0x10ea6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec01b20>, '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.dTEXCA5y8o/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.c4NrSezioQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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:53:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:53:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:53:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dTEXCA5y8o/Render', 02:53:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:34 INFO - 'HOME': '/Users/cltbld', 02:53:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:34 INFO - 'LOGNAME': 'cltbld', 02:53:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:34 INFO - 'MOZ_NO_REMOTE': '1', 02:53:34 INFO - 'NO_EM_RESTART': '1', 02:53:34 INFO - 'PAGER': '/bin/cat', 02:53:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:34 INFO - 'PWD': '/builds/slave/test', 02:53:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:34 INFO - 'SHELL': '/bin/bash', 02:53:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c4NrSezioQ/Listeners', 02:53:34 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 02:53:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:34 INFO - 'USER': 'cltbld', 02:53:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:34 INFO - 'XPC_FLAGS': '0x0', 02:53:34 INFO - 'XPC_SERVICE_NAME': '0', 02:53:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:53:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:53:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:53:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:53:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:53:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:53:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:53:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:53:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:53:34 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:53:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:53:34 INFO - Cleaning up... 02:53:34 INFO - Return code: 0 02:53:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:53: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:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53: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:53:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ed66a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed6d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89e3c6c880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec0ad30>, '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 0x10ea6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec01b20>, '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.dTEXCA5y8o/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.c4NrSezioQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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:53:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:53:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:53:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dTEXCA5y8o/Render', 02:53:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:34 INFO - 'HOME': '/Users/cltbld', 02:53:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:34 INFO - 'LOGNAME': 'cltbld', 02:53:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:34 INFO - 'MOZ_NO_REMOTE': '1', 02:53:34 INFO - 'NO_EM_RESTART': '1', 02:53:34 INFO - 'PAGER': '/bin/cat', 02:53:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:34 INFO - 'PWD': '/builds/slave/test', 02:53:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:34 INFO - 'SHELL': '/bin/bash', 02:53:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c4NrSezioQ/Listeners', 02:53:34 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 02:53:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:34 INFO - 'USER': 'cltbld', 02:53:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:34 INFO - 'XPC_FLAGS': '0x0', 02:53:34 INFO - 'XPC_SERVICE_NAME': '0', 02:53:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:35 INFO - Downloading/unpacking jsonschema 02:53:35 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:53:35 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:53:35 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:53:35 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:53:35 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:53:35 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:53:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:53:37 INFO - Downloading/unpacking functools32 (from jsonschema) 02:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:37 INFO - Downloading functools32-3.2.3-2.tar.gz 02:53:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:53:37 INFO - warning: no files found matching '*.txt' 02:53:37 INFO - no previously-included directories found matching 'build' 02:53:37 INFO - no previously-included directories found matching 'dist' 02:53:37 INFO - no previously-included directories found matching '.git*' 02:53:37 INFO - Installing collected packages: jsonschema, functools32 02:53:37 INFO - Running setup.py install for functools32 02:53:38 INFO - warning: no files found matching '*.txt' 02:53:38 INFO - no previously-included directories found matching 'build' 02:53:38 INFO - no previously-included directories found matching 'dist' 02:53:38 INFO - no previously-included directories found matching '.git*' 02:53:38 INFO - Successfully installed jsonschema functools32 02:53:38 INFO - Cleaning up... 02:53:38 INFO - Return code: 0 02:53:38 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:53:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:53:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ed66a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed6d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89e3c6c880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec0ad30>, '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 0x10ea6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec01b20>, '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.dTEXCA5y8o/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.c4NrSezioQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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:53:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:53:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:53:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dTEXCA5y8o/Render', 02:53:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:38 INFO - 'HOME': '/Users/cltbld', 02:53:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:38 INFO - 'LOGNAME': 'cltbld', 02:53:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:38 INFO - 'MOZ_NO_REMOTE': '1', 02:53:38 INFO - 'NO_EM_RESTART': '1', 02:53:38 INFO - 'PAGER': '/bin/cat', 02:53:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:38 INFO - 'PWD': '/builds/slave/test', 02:53:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:38 INFO - 'SHELL': '/bin/bash', 02:53:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c4NrSezioQ/Listeners', 02:53:38 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 02:53:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:38 INFO - 'USER': 'cltbld', 02:53:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:38 INFO - 'XPC_FLAGS': '0x0', 02:53:38 INFO - 'XPC_SERVICE_NAME': '0', 02:53:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:38 INFO - Downloading/unpacking flake8 02:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:53:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:53:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:53:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:53:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:53:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:53:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:53:42 INFO - no previously-included directories found matching 'docs/_build' 02:53:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:53:42 INFO - Running setup.py install for pep8 02:53:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:53:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:53:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:53:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:53:42 INFO - no previously-included directories found matching 'docs/_build' 02:53:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:53:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:53:42 INFO - Cleaning up... 02:53:42 INFO - Return code: 0 02:53:42 INFO - Running post-action listener: _resource_record_post_action 02:53:42 INFO - Running post-action listener: _start_resource_monitoring 02:53:42 INFO - Starting resource monitoring. 02:53:42 INFO - ##### 02:53:42 INFO - ##### Running install step. 02:53:42 INFO - ##### 02:53:42 INFO - Running pre-action listener: _resource_record_pre_action 02:53:42 INFO - Running main action method: install 02:53:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:53:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:53:42 INFO - Reading from file tmpfile_stdout 02:53:42 INFO - Detecting whether we're running mozinstall >=1.0... 02:53:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:53:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:53:42 INFO - Reading from file tmpfile_stdout 02:53:42 INFO - Output received: 02:53:42 INFO - Usage: mozinstall [options] installer 02:53:42 INFO - Options: 02:53:42 INFO - -h, --help show this help message and exit 02:53:42 INFO - -d DEST, --destination=DEST 02:53:42 INFO - Directory to install application into. [default: 02:53:42 INFO - "/builds/slave/test"] 02:53:42 INFO - --app=APP Application being installed. [default: firefox] 02:53:42 INFO - mkdir: /builds/slave/test/build/application 02:53:42 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:53:42 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:54:15 INFO - Reading from file tmpfile_stdout 02:54:15 INFO - Output received: 02:54:15 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:54:15 INFO - Running post-action listener: _resource_record_post_action 02:54:15 INFO - ##### 02:54:15 INFO - ##### Running run-tests step. 02:54:15 INFO - ##### 02:54:15 INFO - Running pre-action listener: _resource_record_pre_action 02:54:15 INFO - Running main action method: run_tests 02:54:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:54:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:54:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:54:15 INFO - 2016-04-08 02:54:15.189 screenresolution[1651:7979] starting screenresolution argv=screenresolution get 02:54:15 INFO - 2016-04-08 02:54:15.192 screenresolution[1651:7979] Display 0: 1600x1200x32@60 02:54:15 INFO - 2016-04-08 02:54:15.197 screenresolution[1652:7981] starting screenresolution argv=screenresolution list 02:54:15 INFO - Available Modes on Display 0 02:54:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:54:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:54:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:54:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:54:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:54:15 INFO - Intel Iris: 02:54:15 INFO - Chipset Model: Intel Iris 02:54:15 INFO - Type: GPU 02:54:15 INFO - Bus: Built-In 02:54:15 INFO - VRAM (Dynamic, Max): 1536 MB 02:54:15 INFO - Vendor: Intel (0x8086) 02:54:15 INFO - Device ID: 0x0a2e 02:54:15 INFO - Revision ID: 0x0009 02:54:15 INFO - Displays: 02:54:15 INFO - Display: 02:54:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:54:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:54:15 INFO - Display Serial Number: 1600x1200 60 02:54:15 INFO - Main Display: Yes 02:54:15 INFO - Mirror: Off 02:54:15 INFO - Online: Yes 02:54:15 INFO - Rotation: Supported 02:54:15 INFO - Return code: 0 02:54:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:54:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:54:15 INFO - Python 2.7.3 02:54:15 INFO - Return code: 0 02:54:15 INFO - grabbing minidump binary from tooltool 02:54: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:54:15 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec0ad30>, '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 0x10ea6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec01b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:54:15 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:54:15 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 02:54:15 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:54:15 INFO - Return code: 0 02:54:15 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:54:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:54:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:54:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:54:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:54:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:54:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:54:16 INFO - Return code: 0 02:54:16 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/ImiGljzWSgGgBNSd5WYmDw/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0032', '--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:54:16 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/ImiGljzWSgGgBNSd5WYmDw/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0032 --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:54:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dTEXCA5y8o/Render', 02:54:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:54:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:54:16 INFO - 'HOME': '/Users/cltbld', 02:54:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:54:16 INFO - 'LOGNAME': 'cltbld', 02:54:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:54:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:54:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:16 INFO - 'MOZ_NO_REMOTE': '1', 02:54:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:54:16 INFO - 'NO_EM_RESTART': '1', 02:54:16 INFO - 'PAGER': '/bin/cat', 02:54:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:54:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:16 INFO - 'PWD': '/builds/slave/test', 02:54:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:54:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:54:16 INFO - 'SHELL': '/bin/bash', 02:54:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c4NrSezioQ/Listeners', 02:54:16 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 02:54:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:54:16 INFO - 'USER': 'cltbld', 02:54:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:54:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:54:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:16 INFO - 'XPC_FLAGS': '0x0', 02:54:16 INFO - 'XPC_SERVICE_NAME': '0', 02:54:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:54:16 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/ImiGljzWSgGgBNSd5WYmDw/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0032', '--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:54:16 INFO - mozversion application_buildid: 20160408004012 02:54:16 INFO - mozversion application_changeset: 6adef622c36b1ff4d388e1199f1ee328651ac616 02:54:16 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:54:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:54:16 INFO - mozversion application_name: Firefox 02:54:16 INFO - mozversion application_remotingname: firefox-dev 02:54:16 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:54:16 INFO - mozversion application_vendor: Mozilla 02:54:16 INFO - mozversion application_version: 47.0a2 02:54:16 INFO - mozversion platform_buildid: 20160408004012 02:54:16 INFO - mozversion platform_changeset: 6adef622c36b1ff4d388e1199f1ee328651ac616 02:54:16 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:54:16 INFO - mozversion platform_version: 47.0a2 02:54:16 INFO - using testdate: 1460109256 02:54:16 INFO - actual date: 1460109256 02:54:16 INFO - starting webserver on 'localhost:49270' 02:54:16 INFO - SUITE-START | Running 2 tests 02:54:16 INFO - TEST-START | dromaeo_css 02:54:16 INFO - operating with platform_type : mac_ 02:54:16 INFO - Initialising browser for dromaeo_css test... 02:54:16 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmp3q68jn/profile http://localhost:49270/getInfo.html) 02:54:19 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 02:54:19 INFO - PROCESS | 1670 | colorDepth:24 02:54:19 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 02:54:19 INFO - PROCESS | 1670 | __metrics 02:54:19 INFO - PROCESS | 1670 | 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:54:19 INFO - PROCESS | 1670 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:54:19 INFO - TEST-INFO | 1670: exit 0 02:54:19 INFO - Browser initialized. 02:54:19 INFO - Running cycle 1/1 for dromaeo_css test... 02:54:19 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmp3q68jn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:54:31 INFO - PROCESS | 1674 | RSS: Main: 207253504 02:54:31 INFO - PROCESS | 1674 | 02:55:23 INFO - PROCESS | 1674 | 1460109323827 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] 02:57:32 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 02:57:34 INFO - PROCESS | 1674 | RSS: Main: 324403200 02:57:34 INFO - PROCESS | 1674 | 03:00:36 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 03:00:37 INFO - PROCESS | 1674 | RSS: Main: 344113152 03:00:37 INFO - PROCESS | 1674 | 03:03:39 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 03:03:39 INFO - PROCESS | 1674 | RSS: Main: 343445504 03:03:39 INFO - PROCESS | 1674 | 03:06:41 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 03:06:42 INFO - PROCESS | 1674 | RSS: Main: 306003968 03:06:42 INFO - PROCESS | 1674 | 03:09:45 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 03:09:46 INFO - PROCESS | 1674 | RSS: Main: 309506048 03:09:46 INFO - PROCESS | 1674 | 03:12:48 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 03:12:48 INFO - PROCESS | 1674 | RSS: Main: 354828288 03:12:48 INFO - PROCESS | 1674 | 03:12:48 INFO - PROCESS | 1674 | __start_tp_report 03:12:48 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 03:12:48 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 03:12:48 INFO - PROCESS | 1674 | |i|pagename|runs| 03:12:48 INFO - PROCESS | 1674 | |0;dojo.html;3094.4584697677906;3444.982775086124;3447.4828775683636;3450.2754421571467;3500.667436593523;5624.409437009112;5628.577856660757;5629.7185140743;5629.802956896509;5661.886762264752;5594.748236329365;5616.663000219979;5630.774769009245;5637.154426835967;5648.604597678164;5080.263361812535;5097.84706458805;5104.979004199156;5137.58899288057;5149.201873709562;5183.248428977796;5186.9626074785;5187.792488300463;5191.714455704935;5206.140986737184;5116.1814109742445;5163.406208286057;5185.403678576955;5202.76587553561;5210.505002024802;4611.5619016193405;5183.53348198662;5216.3218781558535;5230.058589453897;5284.339457567804;5023.447420783711;5100.974495127538;5102.540771330561;5110.310108135392;5148;4816.555033489939;5522.972385138089;5564.054110801174;5572.080606699889;5598.608097433182;6037.245344331958;6078.787242446538;6089.817305480843;6163.198784158076;6199.969000155015;6136.1821086261625;6160.815175544741;6181.938180618181;6246.750129994794;6253.312135665074;5708.514776244025;5753.309602847643;5758.309002919635;5760.53915686744;5794.65232086072;6237.532185086136;6243.625382477066;6379.234491861006;6379.71291291893;6383.202099737533;6056.647052957033;6075.817725468243;6090.23872015998;6090.756369745249;6094.423602403839;6210.534209934273;6215.564910456224;6215.564910456315;6222.035584484322;6223.284322302902;6026.156338112668;6079.422454866781;6116.847078823065;6122.20411346531;6137.110119032715;6155.784547540904;6156.538259630545;6165.938340616626;6196.721147548371;6197.03945888388;4875.5124487551675;4879.170541008037;4885.193942999365;4900.950990490121;4901.117798796179;4273.9358909616385;4394.912101757947;4410.580994805488;4418.734875907456;4431.889202769957;5519.530839878575;5594.0769772987005;5602.187682786055;5602.299712535933;5604.943950560524;6121.693915304217;6130.63216207029;6135.509159267248;6139.201903752483;6144.016957286902;5603.131514615241;5639.295088113986;5653.208550802891;5666.631668941505;5682.829515114553;5345.679259244458;5369.436209197978;5370.1407774756635;5371.435999220103;5383.461653834664;6382.808515744535;6390.297067322591;6392.296847346788;6397.072424498421;6401.615903045832;6099.176611157437;6126.30393285589;6127.617148554337;6234.1583886174785;6297.905531417124;6366.108744775827;6371.458426033839;6372.9362706374195;6374.840628984312;6383.744650213939;6110.7250173741395;6128.969355153374;6130.969345153246;6144.324124346408;6148.292946311052;5539.612227144061;6114.785982490592;6177.011678131477;6200.596961197508;6235.501159907287;5983.730732117152;5989.880202396015;5997.10043493462;6003.90994135097;6016.608920420159;6022.337542870193;6032.426919442646;6038.758449661965;6047.879042419215;6051.727672254847;5783.797567085132;5867;5872.530197584098;5875.471207591338;6012.259551943633;5797.275340582427;5808.82573522795;5817.447342502455;5839.328477225174;5865.3254875689845;5688.089905615082;5725.856853578527;5726.74229659658;5730.226419433323;5744.109663002241 03:12:48 INFO - PROCESS | 1674 | |1;ext.html;470.5224197439599;493.0877875929533;608.4919092557714;631.2614241337633;674.4570620650376;30333.393332133342;32176.67823321766;32190;32201.51697724536;32254.516182257285;33091.834540827265;34339.82830085852;42527.57472425275;42592.361114583306;42621.36067958975;8326.500409975391;9613.086756758097;9768.706938791847;9809.607615695364;9810.018998100168;9617.56720947559;9769.316147869651;9776.120149186572;9778.853317200212;9779.559919803625;9033.638654453815;9081.727548173565;9792.951035244814;9799.657012004582;9822.803543929118;9711;9861.654842080565;9874.1113299803;9889.554970026365;9901.900980990242;9701.563429645683;9815.607375704963;9816.509174541316;9830.508474576243;9851.605935762562;42568;42949.14101717979;42969.35545966813;42970.14059718788;43022.35466468005;3425.8629654813776;3438.4670376091744;3470.4620783778555;3599.4600809878466;4012.7391719538427;28142;29039.274018149503;29601.407971840443;29645.110646680634;30281.545776813364;2797.608334833125;2836.347640042781;2844.9431011379656;2856.8285902845687;2883.495388307038;501273;506738;507105;507868;508325;74773.25226747771;75039.24960750432;75041;75121.24878751252;75130.62434687791;79802;81396.59301703454;81494;81556.77664835032;81659.5917020423;18493.352732654294;18525.81474185241;18675.15961781723;18741.81258187428;18756.531086722942;14058.929705351407;14185;14201.360938757574;14208.431662733376;14227.715445691028;22736.545269094855;23074.538509229722;23108.075676972734;23172.53654926892;23571.29286121419;8368.744688296803;9461.668841590648;9554.90445095554;9875.456849873326;9883.505824708736;975.5512464266375;1025.205465764024;1091.1210646153002;1119.4682525800342;1198.2451055834767;27843.164705058476;30427;30577.08268751941;30957;30991.915282965438;1158.264502041193;1170.3621526268205;1178.263585259213;1200.8198770184542;1226.2397313665585;15264.313105910262;15394;15403.691926161415;15704.528864134094;15726.68546629061;548749.2562537162;553073.703894442;556032;556340;556828;62850.857457126964;63385;63449.68275158687;63685;63934.36065639377;1415.7451658701327;1446.6600348917996;1527.0990115831712;1574.889757716949;1575.5430925031612;30067.700327806633;30361.24096897595;30543;30557.677616500863;30705.539416908316;50825;51275.23087153621;51350.486495136065;51381;51457;338108;369860;369992;370272;370923;29805.5529167067;34375.484367734;34692;35057.298854023284;35105;43328.56671433245;43531;43676.56323436725;43949.12101758011;44009.33985990148;35148.82425587856;36254.274914502086;36317.27365452729;36542.63457365392;37062.62937370592;35676.64323356837;35751.64248357587;35981.64018359783;36460.45309320309;36566.63433365632;36790.8160459196;37101.25797483981;37342.8132859334;38169.80915095407;38224;31590.73637054492;32116.67883321137;32313.838430808635;32374.83812580922;32856.83571582127;24713.382165446008;24754.381140471633;24892.875535622206;25126.246212613652;25209.11768088108 03:12:48 INFO - PROCESS | 1674 | |2;jquery.html;373.9569949455812;380.5794596970348;382.3022983055923;389.0196704305149;389.6162280154048;19759.802401975976;19822.801771982293;20282.69575956362;20418.183272669074;20458.28396006138;17699.91150044251;20050.097745601448;20539.28112516062;20812.583748325025;21360.67958980613;5222.399424066243;5949.583529152961;6002.939970600281;6003.429674180968;6005.909911351333;4137.420761093449;4492.595666390024;6458;6557.672116394185;6669.699863506154;6585.703643336062;6591.077249185118;6600.075989361493;6602.207735071798;6615.17310336208;6218.595791273553;6491.8052458425855;6498.415142637138;6500.41496265336;6500.577462464948;5569.526590239834;5616.803411880564;5629.071203251458;5639.238702775114;5640.689762063085;24459;25783.484330313288;25985.960561577514;26039.479210415873;26488.470230595474;2279.076973825603;2347.5891718949115;2405.987970060156;2591.3262551736498;2740.83514506334;14725.337359818726;15033.548993530103;15215.771763423558;15286.541403757905;15311.234438278041;1744.6685129825294;1762.268658506718;1768.328035346573;1837.5589858434014;1839.6181999296289;91390;93802;96264;96567.51716241444;97605.53591696131;10407.375557466576;10685.83971240432;10941.726456838484;11130.443477826077;11191.496382662637;13464.259465729283;13501;13563.864361356458;13574.321283935764;13582.86417135816;8776.429532080394;8930.86603700945;8946.910530894738;8990.011098779129;9022.593983270768;9182.449053056838;9191.540422978824;9196.448213107235;9277.304202184863;9285.907140928504;6122.357152499013;6344.191905306965;6345.682715864188;6358.109864618957;6375.649339286384;1819.4359748478014;1873.147717788403;1875.6436277107307;1889.527618095476;1900.7814101378242;935.8362286599818;972;983.1495756171004;997.7079681812071;1100.625787232345;19236.519087022658;21209.045592948354;21810;21858.344249672537;22996;993.2997236948079;998.8202123617673;1019.8266294729914;1033.2508931024947;1043.3322673488974;10929.125669946385;11376;11435;11437.02785263262;11452.713682157846;625285;627858;634155;644424;673168;124508;125911;129115;130859;134322.32838835742;1069.3102948598266;1095.7041598768128;1109.5672687651822;1109.8279766636185;1110.3615421132881;18085.547861303574;18198.818011819712;18330.17514211837;18419.355322563646;18784.6243075135;41702.648387288755;50717.746411267704;51584.90697339239;52729.41811745654;52865.735671321396;72194;72638;73754;74538;77317.84023239544;8008.799780005546;8205.630746616298;8352.331813454788;8466.407351485337;8553.97352317701;12199.87800122023;13442;13530.932345338604;13839.515616953358;13900.16599004063;11779.411029448322;11823.881761182278;11828.053755699351;11903.464344104363;11967.341796201292;11618.419079046183;11680.948714615726;11726.472308746297;11887.524499020288;11927.667161666344;10037.49812509357;10994.560217591206;11768.470418831344;11959.820602690792;12251.75496490083;8053.395995300493;8185.754427367188;8294.502329860228;8381.203785640355;8519.8722019171;8479.78800529967;8628.137186281321;11096.722581935193;11381.317120972768;12072.39638018078 03:12:48 INFO - PROCESS | 1674 | |3;mootools.html;1283.4352884730724;1385.8336999560051;1651.1661610886504;1926.624308259889;2115.2385141349114;8423.452475589082;9085.818283634324;9222.077792220774;9226.123518265762;9226.169644731974;8950.776230594238;9201.17189452949;9209.723708288746;9229.815403691939;9263.166315031645;2150.7849215078522;2243.181238847817;2502.324372419446;2571.974280257197;2583.147561304765;2605.413781899067;2609.4650596627644;2614.2026681862026;2618.6857577090777;2619.0571394298036;2292.8280378971563;2495.189063554343;2499.9250022499355;2590.870456477178;2598.142612937726;2330.8135349172026;2372.5729368713623;2569.203546900467;2600.8569528675916;2604.7785938195275;2548.413864811104;2581.922542323733;2602.2583563684448;2603.856787876666;2615.908443204498;9251.768705782342;9359.719208423758;9377.953110234404;9399.389039712465;9402.106799854071;5733.655980641175;5898.1152827076285;5952.494038006775;5963.13534537494;5964.433378829048;3703.148275896559;3790.166163444038;3790.469334293201;3815.961840381616;3827.7129215308687;1065.477915821242;1066.5840322274319;1077.06833588945;1095.5617752898825;1121.6298621454982;12613.558525451657;12617.242965422103;12635.368231588476;12640.620781376481;12696.111272211041;5068.873278168076;5077.644564880423;5180.637355385163;5189.870253243624;5209.687418754811;10713.732156695989;10733.83899241512;10746.78506429867;10757.677269681923;10778.73053173677;5868.67722275279;5875.676837773964;5890.440408161217;5919.496842768327;5928.525717942554;4648.093621743795;4800.303955926371;5028.899422011539;5113.028524580318;5187.948120518822;4099.651529619956;4130.380442933584;4184.322033898246;4185.769782661922;4192.098698779777;1009.707184916366;1127.6278827986744;1198.1433275208267;1200.8739082396398;1299.1750238598559;1128.802459569572;1151.7696460707725;1156.2079975217002;1366.3714691241942;1457.118443341784;8609.5695215239;8639.740807775777;8643.265322447662;8800.119988001148;8862.512561809033;987.7579992901641;1176.394157009141;1205.8372119763894;1270.4092596942282;1275.0819410024767;6456.838579035468;6493.25327587324;6538.280789113193;6552.017197420425;6564.179477565304;11203.159763017806;11734.11994100446;11744.58893938708;11747.236429632047;11766.058715302755;11038.944805275922;11477.253978491372;11536.25014374063;11561.826572601418;11620.76758464826;8737.781555461164;8755.343349248831;8857.822843543221;8873.467591944374;8875.334349923653;8296.419250652396;8309.335253179852;8335.208155225244;8414.990201175899;8446.662133514836;9957.551910164206;10081.092701656886;10262.435566043641;10279.177665786869;10355.068043876086;10261;10649.8935010652;10686.519106640375;10802.189835762192;10847.186461015297;6771;6916.861662766616;6918.273581273894;7228.132624085143;7489.513181643176;8085.272325490734;8418.536980466133;8733.868991964999;8743.519106449206;8745.863037805044;7653.502522336031;7691.4615976883315;7749.535027898344;7882.960585197037;7928.405369597188;7579.810504737426;7618.314351708373;7693.230676932486;7800.570968596555;7831.647575858986;6766.289539598271;8110.918890811016;8116.391270654843;8126.228008339198;8188.7952801180445;7285.817854553678;7400.148982867039;7422.814429639302;7429.44279179053;7453.142888567667;7478;7497.887531687138;7554.395648348229;7563.281488258606;7564.621768911643 03:12:48 INFO - PROCESS | 1674 | |4;prototype.html;299.6988027032833;327.1934681011307;337.5729701927062;337.8445914879155;343.0617261789005;6354.714037868302;6394.456471199947;6403.135576697145;6414.326495717953;6456.192975878015;6244.500439964803;6314.873702525947;6321.1150438938585;6343.492520598353;6346.889294373478;3765.585785563586;4444.911101777962;4560.771961401933;4571.817127314904;4720.268358404444;4645.512221216774;4653.95286060637;4663.8367657132;4675.088357770236;4698.6006189473765;4587.449506059277;4617.722936623813;4626.699264547794;4631.791569379369;4659.231226847566;4396.120775844844;4508.391367165424;4647.581717645395;4659.138059459011;4660.04469083837;4017.819198136091;4043.3732771420478;4052.1895620875944;4062.2078694654556;4063.7968101595097;4752.287156926489;6061.757529698807;6081.665508397036;6107.206063211798;6114.663693496856;5473.480019398151;5510.173473978895;5526.226328314039;5527.281453411071;5546.639468434539;6701.865962680719;6709.261981182066;6742.865142697167;6751.493637977172;6813.11429514165;4398.120375924827;4561.7262964222255;4577.5880170784785;4596.896744781262;4602.401687780601;6266.809306231801;6662.800115996528;7033.191183013917;7096.396806271473;7148.356647901714;3824.9426258606145;4685.0629874025335;4711.8350857719815;4722.763861806896;4727.763611819395;4769.713817170981;4769.785359658824;4781.211100168433;4785.928211076836;4800.183968725325;4448.866534003985;5528.391876893538;5542.307211598551;5542.889142217133;5547.944520554824;5478.890422191534;6529.412352888263;6768.763093291711;6788.2193547742645;6825.146856642919;1640.9343626255054;1644.21077882617;1664.4923298393865;1666.0170499405408;1668.382698401599;1027.9743006424899;1054.0776820282254;1074.119222237773;1077.8221593437152;1104.9060829829393;6041.24484439445;6129.264488261348;6151.477124444473;6201.720922558496;6354.618722876642;7043.718251269892;7059.435245180373;7062.1878483975;7071.292870712888;7099.3965512930945;6312.936870631327;6323.9051414228825;6338.112664227012;6341.4609758170145;6396.968015159894;3654.8720794772057;3698.130939229279;3714.0900479382185;3722.7021838252876;3738.831752571141;7150.10623672041;7398.297161769623;7414.332710056013;7469.663865126083;7492.925070749332;7218.855622887513;7234.927650723531;7247.528910620793;7257.0565826442225;7275.454340924452;7386;7390.297921697537;7398.926010739931;7406.296401841816;7424.294692004251;6992.370686638227;7021;7023.367896889305;7032.894506582303;7044.260352663102;6677.399034086956;6911.481638877205;6915.481338899502;6943.930560694531;6952.165740111219;6116.449519543263;6914.481413894078;7280.417566594554;7378;7378.3029903121505;4481.148581769454;4554.089182163514;4559.38448309474;4560.794764235551;4560.954390456053;7023.929760702532;7032.12098487689;7043.823904402431;7056.15326160864;7058.25888281723;6521.380468855451;6789.691504888362;6823.761168359084;6835.043093966749;6858.3827455529245;6703.195616526048;6794.558353706993;6815.318468153145;6816.454683625398;6828.5220034597105;5377.489138531833;6649.534532582673;6652.135222421248;6654.966725166343;6679.766208182885;6789;6795.592264464148;6816.62508562014;6819.897701534382;6827.931720682928;6364.586301890362;6417.550771445954;6475.1582294303325;6520.18497687789;6637.867242655023 03:12:48 INFO - PROCESS | 1674 | |5;yui.html;720.4344589497249;723.7720118162779;751.4814777803318;767.3439209475898;774.3766268154135;15299.388024479022;15471.45849895254;15670.294836732346;15672.764908526382;15680.686386272282;14818.333175007123;14888;14891.627709307273;14901.105933643988;14915.179665118414;800.1558355934487;809.9959500202491;998.9400635961865;1034.3586976074807;1036.2849633752687;986.5067466266867;1004.0963133180123;1006.2101250518344;1006.5118417567473;1009.5154325923561;1066.653337665258;1067.4395942130404;1068.6046162919731;1068.9198310126733;1069.9090577300938;838.0362583029535;848.9320854331638;849.7068511363632;1058.6506452870574;1068.7648717282225;634.9968250158765;780.3951937248621;795.0380040151424;797.5693125712108;797.9905419644155;16065.277062532097;16110.677786444205;16129.274182661808;16147.273372698257;16199.35202591895;13391.531296404677;13529.797053044213;13531.458741650322;13690.657733556642;13789.793153102712;10124.088832005154;10331.121854642364;10349.172066234683;10463.738406539822;10497.685069447929;3561.554805649294;3568.107973006748;3595.8921232363073;3673.0633688409284;3816.809159542012;84759.72860407038;85042;86378;86679;87168.12831871664;9802.446376522814;9844.064813842673;9971.40171589707;9990.200783937413;10188;23391.649125263135;23478.413039674146;23487.295381138592;23517.529649406915;23565.882170589037;7576.962115189499;7667.11828139771;7669.079710434672;7741.8838717419285;7784.350430550356;4222.408862759216;4228.556001619847;4267.103908179255;4407.118576284756;4423.5576442355505;3713.7400381973002;3760.7179461539945;3769.359208934488;3775.5846856845724;3781.546214454283;637.4199478474566;646.4634353486595;665.2848188197706;666.2072134160334;669.4042302350912;573.1574585359515;615.3354377272535;619.0219453263833;624.316373570939;630.152444961526;8061.1938806118915;8419.536925469158;8605.31157507398;8621.09478504748;8660.696875609323;552.0500816656827;583.635227982511;589.7906243283659;606.0848119339829;619.3465893482329;3886.106195575034;3956.169204467094;4032.5362583303295;4075.89810254746;4094.5905409458815;97159;97309.05381892464;98696;99350.5032474833;100501.48746281401;82686.58656706678;83433.74849377264;83738.5813070943;84993;85276.14723852681;66471.33528664749;70264.64867675629;71531.64234178796;72657.2734272661;73078.63460682663;8591.355648326526;8604.913950860411;8778.385513014027;8855.55722213874;8895.73312800617;49410;50398.697158972485;51290;52258.693532661986;52365.47634523606;74624.62687686527;75756.4848703034;75878;76087;76422;11000.504977275881;11170.050545703707;11191.496382662963;11421.37182454973;11611.245269057823;11955.342456164646;12119;12241;12342.259464432163;12647.304398257817;11816.70458238551;11855.822162667395;11958.940205298917;12035.398230088636;12224.75550489003;11819.527218911147;11929.522819087138;11989.280643161439;12191.695207619525;12247.571335003233;11496.712582185177;11557.42212889369;11696.06431485496;11765.941170294094;11803.645890623295;10011.299209055296;10070.295079344669;10253.641122560675;10263.384196948207;10434.37393756377;9665.661701840401;9931.205503559553;9932.354396964174;9955.850662239927;9967.750806229902 03:12:48 INFO - PROCESS | 1674 | __end_tp_report 03:12:48 INFO - PROCESS | 1674 | __start_cc_report 03:12:48 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,1012 03:12:48 INFO - PROCESS | 1674 | __end_cc_report 03:12:48 INFO - PROCESS | 1674 | __startTimestamp1460110368883__endTimestamp 03:12:48 INFO - PROCESS | 1674 | 03:12:48 INFO - PROCESS | 1674 | ------- Summary: start ------- 03:12:48 INFO - PROCESS | 1674 | Number of tests: 6 03:12:48 INFO - PROCESS | 1674 | 03:12:48 INFO - PROCESS | 1674 | [#0] dojo.html Cycles:165 Average:5676.15 Median:5797.28 stddev:637.35 (11.0%) stddev-sans-first:606.27 03:12:48 INFO - PROCESS | 1674 | Values: 3094.5 3445.0 3447.5 3450.3 3500.7 5624.4 5628.6 5629.7 5629.8 5661.9 5594.7 5616.7 5630.8 5637.2 5648.6 5080.3 5097.8 5105.0 5137.6 5149.2 5183.2 5187.0 5187.8 5191.7 5206.1 5116.2 5163.4 5185.4 5202.8 5210.5 4611.6 5183.5 5216.3 5230.1 5284.3 5023.4 5101.0 5102.5 5110.3 5148.0 4816.6 5523.0 5564.1 5572.1 5598.6 6037.2 6078.8 6089.8 6163.2 6200.0 6136.2 6160.8 6181.9 6246.8 6253.3 5708.5 5753.3 5758.3 5760.5 5794.7 6237.5 6243.6 6379.2 6379.7 6383.2 6056.6 6075.8 6090.2 6090.8 6094.4 6210.5 6215.6 6215.6 6222.0 6223.3 6026.2 6079.4 6116.8 6122.2 6137.1 6155.8 6156.5 6165.9 6196.7 6197.0 4875.5 4879.2 4885.2 4901.0 4901.1 4273.9 4394.9 4410.6 4418.7 4431.9 5519.5 5594.1 5602.2 5602.3 5604.9 6121.7 6130.6 6135.5 6139.2 6144.0 5603.1 5639.3 5653.2 5666.6 5682.8 5345.7 5369.4 5370.1 5371.4 5383.5 6382.8 6390.3 6392.3 6397.1 6401.6 6099.2 6126.3 6127.6 6234.2 6297.9 6366.1 6371.5 6372.9 6374.8 6383.7 6110.7 6129.0 6131.0 6144.3 6148.3 5539.6 6114.8 6177.0 6200.6 6235.5 5983.7 5989.9 5997.1 6003.9 6016.6 6022.3 6032.4 6038.8 6047.9 6051.7 5783.8 5867.0 5872.5 5875.5 6012.3 5797.3 5808.8 5817.4 5839.3 5865.3 5688.1 5725.9 5726.7 5730.2 5744.1 03:12:48 INFO - PROCESS | 1674 | 03:12:48 INFO - PROCESS | 1674 | [#1] ext.html Cycles:180 Average:63431.39 Median:203325.41 stddev:128133.76 (63.0%) stddev-sans-first:128406.01 03:12:48 INFO - PROCESS | 1674 | Values: 470.5 493.1 608.5 631.3 674.5 30333.4 32176.7 32190.0 32201.5 32254.5 33091.8 34339.8 42527.6 42592.4 42621.4 8326.5 9613.1 9768.7 9809.6 9810.0 9617.6 9769.3 9776.1 9778.9 9779.6 9033.6 9081.7 9793.0 9799.7 9822.8 9711.0 9861.7 9874.1 9889.6 9901.9 9701.6 9815.6 9816.5 9830.5 9851.6 42568.0 42949.1 42969.4 42970.1 43022.4 3425.9 3438.5 3470.5 3599.5 4012.7 28142.0 29039.3 29601.4 29645.1 30281.5 2797.6 2836.3 2844.9 2856.8 2883.5 501273.0 506738.0 507105.0 507868.0 508325.0 74773.3 75039.2 75041.0 75121.2 75130.6 79802.0 81396.6 81494.0 81556.8 81659.6 18493.4 18525.8 18675.2 18741.8 18756.5 14058.9 14185.0 14201.4 14208.4 14227.7 22736.5 23074.5 23108.1 23172.5 23571.3 8368.7 9461.7 9554.9 9875.5 9883.5 975.6 1025.2 1091.1 1119.5 1198.2 27843.2 30427.0 30577.1 30957.0 30991.9 1158.3 1170.4 1178.3 1200.8 1226.2 15264.3 15394.0 15403.7 15704.5 15726.7 548749.3 553073.7 556032.0 556340.0 556828.0 62850.9 63385.0 63449.7 63685.0 63934.4 1415.7 1446.7 1527.1 1574.9 1575.5 30067.7 30361.2 30543.0 30557.7 30705.5 50825.0 51275.2 51350.5 51381.0 51457.0 338108.0 369860.0 369992.0 370272.0 370923.0 29805.6 34375.5 34692.0 35057.3 35105.0 43328.6 43531.0 43676.6 43949.1 44009.3 35148.8 36254.3 36317.3 36542.6 37062.6 35676.6 35751.6 35981.6 36460.5 36566.6 36790.8 37101.3 37342.8 38169.8 38224.0 31590.7 32116.7 32313.8 32374.8 32856.8 24713.4 24754.4 24892.9 25126.2 25209.1 03:12:48 INFO - PROCESS | 1674 | 03:12:48 INFO - PROCESS | 1674 | [#2] jquery.html Cycles:180 Average:35702.60 Median:25121.24 stddev:106116.55 (422.4%) stddev-sans-first:106381.07 03:12:48 INFO - PROCESS | 1674 | Values: 374.0 380.6 382.3 389.0 389.6 19759.8 19822.8 20282.7 20418.2 20458.3 17699.9 20050.1 20539.3 20812.6 21360.7 5222.4 5949.6 6002.9 6003.4 6005.9 4137.4 4492.6 6458.0 6557.7 6669.7 6585.7 6591.1 6600.1 6602.2 6615.2 6218.6 6491.8 6498.4 6500.4 6500.6 5569.5 5616.8 5629.1 5639.2 5640.7 24459.0 25783.5 25986.0 26039.5 26488.5 2279.1 2347.6 2406.0 2591.3 2740.8 14725.3 15033.5 15215.8 15286.5 15311.2 1744.7 1762.3 1768.3 1837.6 1839.6 91390.0 93802.0 96264.0 96567.5 97605.5 10407.4 10685.8 10941.7 11130.4 11191.5 13464.3 13501.0 13563.9 13574.3 13582.9 8776.4 8930.9 8946.9 8990.0 9022.6 9182.4 9191.5 9196.4 9277.3 9285.9 6122.4 6344.2 6345.7 6358.1 6375.6 1819.4 1873.1 1875.6 1889.5 1900.8 935.8 972.0 983.1 997.7 1100.6 19236.5 21209.0 21810.0 21858.3 22996.0 993.3 998.8 1019.8 1033.3 1043.3 10929.1 11376.0 11435.0 11437.0 11452.7 625285.0 627858.0 634155.0 644424.0 673168.0 124508.0 125911.0 129115.0 130859.0 134322.3 1069.3 1095.7 1109.6 1109.8 1110.4 18085.5 18198.8 18330.2 18419.4 18784.6 41702.6 50717.7 51584.9 52729.4 52865.7 72194.0 72638.0 73754.0 74538.0 77317.8 8008.8 8205.6 8352.3 8466.4 8554.0 12199.9 13442.0 13530.9 13839.5 13900.2 11779.4 11823.9 11828.1 11903.5 11967.3 11618.4 11680.9 11726.5 11887.5 11927.7 10037.5 10994.6 11768.5 11959.8 12251.8 8053.4 8185.8 8294.5 8381.2 8519.9 8479.8 8628.1 11096.7 11381.3 12072.4 03:12:48 INFO - PROCESS | 1674 | 03:12:48 INFO - PROCESS | 1674 | [#3] mootools.html Cycles:180 Average:6388.45 Median:5048.89 stddev:3419.60 (67.7%) stddev-sans-first:3407.66 03:12:48 INFO - PROCESS | 1674 | Values: 1283.4 1385.8 1651.2 1926.6 2115.2 8423.5 9085.8 9222.1 9226.1 9226.2 8950.8 9201.2 9209.7 9229.8 9263.2 2150.8 2243.2 2502.3 2572.0 2583.1 2605.4 2609.5 2614.2 2618.7 2619.1 2292.8 2495.2 2499.9 2590.9 2598.1 2330.8 2372.6 2569.2 2600.9 2604.8 2548.4 2581.9 2602.3 2603.9 2615.9 9251.8 9359.7 9378.0 9399.4 9402.1 5733.7 5898.1 5952.5 5963.1 5964.4 3703.1 3790.2 3790.5 3816.0 3827.7 1065.5 1066.6 1077.1 1095.6 1121.6 12613.6 12617.2 12635.4 12640.6 12696.1 5068.9 5077.6 5180.6 5189.9 5209.7 10713.7 10733.8 10746.8 10757.7 10778.7 5868.7 5875.7 5890.4 5919.5 5928.5 4648.1 4800.3 5028.9 5113.0 5187.9 4099.7 4130.4 4184.3 4185.8 4192.1 1009.7 1127.6 1198.1 1200.9 1299.2 1128.8 1151.8 1156.2 1366.4 1457.1 8609.6 8639.7 8643.3 8800.1 8862.5 987.8 1176.4 1205.8 1270.4 1275.1 6456.8 6493.3 6538.3 6552.0 6564.2 11203.2 11734.1 11744.6 11747.2 11766.1 11038.9 11477.3 11536.3 11561.8 11620.8 8737.8 8755.3 8857.8 8873.5 8875.3 8296.4 8309.3 8335.2 8415.0 8446.7 9957.6 10081.1 10262.4 10279.2 10355.1 10261.0 10649.9 10686.5 10802.2 10847.2 6771.0 6916.9 6918.3 7228.1 7489.5 8085.3 8418.5 8733.9 8743.5 8745.9 7653.5 7691.5 7749.5 7883.0 7928.4 7579.8 7618.3 7693.2 7800.6 7831.6 6766.3 8110.9 8116.4 8126.2 8188.8 7285.8 7400.1 7422.8 7429.4 7453.1 7478.0 7497.9 7554.4 7563.3 7564.6 03:12:48 INFO - PROCESS | 1674 | 03:12:48 INFO - PROCESS | 1674 | [#4] prototype.html Cycles:180 Average:5549.10 Median:6317.99 stddev:1754.97 (27.8%) stddev-sans-first:1715.10 03:12:48 INFO - PROCESS | 1674 | Values: 299.7 327.2 337.6 337.8 343.1 6354.7 6394.5 6403.1 6414.3 6456.2 6244.5 6314.9 6321.1 6343.5 6346.9 3765.6 4444.9 4560.8 4571.8 4720.3 4645.5 4654.0 4663.8 4675.1 4698.6 4587.4 4617.7 4626.7 4631.8 4659.2 4396.1 4508.4 4647.6 4659.1 4660.0 4017.8 4043.4 4052.2 4062.2 4063.8 4752.3 6061.8 6081.7 6107.2 6114.7 5473.5 5510.2 5526.2 5527.3 5546.6 6701.9 6709.3 6742.9 6751.5 6813.1 4398.1 4561.7 4577.6 4596.9 4602.4 6266.8 6662.8 7033.2 7096.4 7148.4 3824.9 4685.1 4711.8 4722.8 4727.8 4769.7 4769.8 4781.2 4785.9 4800.2 4448.9 5528.4 5542.3 5542.9 5547.9 5478.9 6529.4 6768.8 6788.2 6825.1 1640.9 1644.2 1664.5 1666.0 1668.4 1028.0 1054.1 1074.1 1077.8 1104.9 6041.2 6129.3 6151.5 6201.7 6354.6 7043.7 7059.4 7062.2 7071.3 7099.4 6312.9 6323.9 6338.1 6341.5 6397.0 3654.9 3698.1 3714.1 3722.7 3738.8 7150.1 7398.3 7414.3 7469.7 7492.9 7218.9 7234.9 7247.5 7257.1 7275.5 7386.0 7390.3 7398.9 7406.3 7424.3 6992.4 7021.0 7023.4 7032.9 7044.3 6677.4 6911.5 6915.5 6943.9 6952.2 6116.4 6914.5 7280.4 7378.0 7378.3 4481.1 4554.1 4559.4 4560.8 4561.0 7023.9 7032.1 7043.8 7056.2 7058.3 6521.4 6789.7 6823.8 6835.0 6858.4 6703.2 6794.6 6815.3 6816.5 6828.5 5377.5 6649.5 6652.1 6655.0 6679.8 6789.0 6795.6 6816.6 6819.9 6827.9 6364.6 6417.6 6475.2 6520.2 6637.9 03:12:48 INFO - PROCESS | 1674 | 03:12:48 INFO - PROCESS | 1674 | [#5] yui.html Cycles:180 Average:19376.22 Median:4225.48 stddev:27405.63 (648.6%) stddev-sans-first:27446.71 03:12:48 INFO - PROCESS | 1674 | Values: 720.4 723.8 751.5 767.3 774.4 15299.4 15471.5 15670.3 15672.8 15680.7 14818.3 14888.0 14891.6 14901.1 14915.2 800.2 810.0 998.9 1034.4 1036.3 986.5 1004.1 1006.2 1006.5 1009.5 1066.7 1067.4 1068.6 1068.9 1069.9 838.0 848.9 849.7 1058.7 1068.8 635.0 780.4 795.0 797.6 798.0 16065.3 16110.7 16129.3 16147.3 16199.4 13391.5 13529.8 13531.5 13690.7 13789.8 10124.1 10331.1 10349.2 10463.7 10497.7 3561.6 3568.1 3595.9 3673.1 3816.8 84759.7 85042.0 86378.0 86679.0 87168.1 9802.4 9844.1 9971.4 9990.2 10188.0 23391.6 23478.4 23487.3 23517.5 23565.9 7577.0 7667.1 7669.1 7741.9 7784.4 4222.4 4228.6 4267.1 4407.1 4423.6 3713.7 3760.7 3769.4 3775.6 3781.5 637.4 646.5 665.3 666.2 669.4 573.2 615.3 619.0 624.3 630.2 8061.2 8419.5 8605.3 8621.1 8660.7 552.1 583.6 589.8 606.1 619.3 3886.1 3956.2 4032.5 4075.9 4094.6 97159.0 97309.1 98696.0 99350.5 100501.5 82686.6 83433.7 83738.6 84993.0 85276.1 66471.3 70264.6 71531.6 72657.3 73078.6 8591.4 8604.9 8778.4 8855.6 8895.7 49410.0 50398.7 51290.0 52258.7 52365.5 74624.6 75756.5 75878.0 76087.0 76422.0 11000.5 11170.1 11191.5 11421.4 11611.2 11955.3 12119.0 12241.0 12342.3 12647.3 11816.7 11855.8 11958.9 12035.4 12224.8 11819.5 11929.5 11989.3 12191.7 12247.6 11496.7 11557.4 11696.1 11765.9 11803.6 10011.3 10070.3 10253.6 10263.4 10434.4 9665.7 9931.2 9932.4 9955.9 9967.8 03:12:48 INFO - PROCESS | 1674 | -------- Summary: end -------- 03:12:48 INFO - PROCESS | 1674 | 03:12:49 INFO - TEST-INFO | 1674: exit 0 03:12:49 INFO - TEST-OK | dromaeo_css | took 1112525ms 03:12:49 INFO - TEST-START | kraken 03:12:49 INFO - operating with platform_type : mac_ 03:12:49 INFO - Initialising browser for kraken test... 03:12:49 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpJYzPah/profile http://localhost:49270/getInfo.html) 03:12:51 INFO - PROCESS | 1679 | __metrics Screen width/height:1600/1200 03:12:51 INFO - PROCESS | 1679 | colorDepth:24 03:12:51 INFO - PROCESS | 1679 | Browser inner width/height: 1024/689 03:12:51 INFO - PROCESS | 1679 | __metrics 03:12:51 INFO - PROCESS | 1679 | 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:12:51 INFO - PROCESS | 1679 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:12:52 INFO - TEST-INFO | 1679: exit 0 03:12:52 INFO - Browser initialized. 03:12:52 INFO - Running cycle 1/1 for kraken test... 03:12:52 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpJYzPah/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:13:04 INFO - PROCESS | 1682 | RSS: Main: 207392768 03:13:04 INFO - PROCESS | 1682 | 03:13:07 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 03:13:07 INFO - PROCESS | 1682 | RSS: Main: 262086656 03:13:07 INFO - PROCESS | 1682 | 03:13:10 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 03:13:10 INFO - PROCESS | 1682 | RSS: Main: 273235968 03:13:10 INFO - PROCESS | 1682 | 03:13:14 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 03:13:14 INFO - PROCESS | 1682 | RSS: Main: 263168000 03:13:14 INFO - PROCESS | 1682 | 03:13:16 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 03:13:17 INFO - PROCESS | 1682 | RSS: Main: 264507392 03:13:17 INFO - PROCESS | 1682 | 03:13:19 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:13:19 INFO - PROCESS | 1682 | RSS: Main: 265527296 03:13:19 INFO - PROCESS | 1682 | 03:13:22 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 03:13:23 INFO - PROCESS | 1682 | RSS: Main: 265510912 03:13:23 INFO - PROCESS | 1682 | 03:13:25 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 03:13:26 INFO - PROCESS | 1682 | RSS: Main: 266051584 03:13:26 INFO - PROCESS | 1682 | 03:13:29 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 03:13:29 INFO - PROCESS | 1682 | RSS: Main: 266047488 03:13:29 INFO - PROCESS | 1682 | 03:13:31 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:13:32 INFO - PROCESS | 1682 | RSS: Main: 299569152 03:13:32 INFO - PROCESS | 1682 | 03:13:33 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:13:34 INFO - PROCESS | 1682 | RSS: Main: 300400640 03:13:34 INFO - PROCESS | 1682 | 03:13:36 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:13:37 INFO - PROCESS | 1682 | RSS: Main: 305577984 03:13:37 INFO - PROCESS | 1682 | 03:13:39 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:13:40 INFO - PROCESS | 1682 | RSS: Main: 307478528 03:13:40 INFO - PROCESS | 1682 | 03:13:42 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:13:43 INFO - PROCESS | 1682 | RSS: Main: 307269632 03:13:43 INFO - PROCESS | 1682 | 03:13:44 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 03:13:45 INFO - PROCESS | 1682 | RSS: Main: 369844224 03:13:45 INFO - PROCESS | 1682 | 03:13:45 INFO - PROCESS | 1682 | __start_tp_report 03:13:45 INFO - PROCESS | 1682 | _x_x_mozilla_page_load 03:13:45 INFO - PROCESS | 1682 | _x_x_mozilla_page_load_details 03:13:45 INFO - PROCESS | 1682 | |i|pagename|runs| 03:13:45 INFO - PROCESS | 1682 | |0;ai-astar;110;108;111;110;112;113;121;112;112;110 03:13:45 INFO - PROCESS | 1682 | |1;audio-beat-detection;153;116;150;150;117;140;116;147;161;116 03:13:45 INFO - PROCESS | 1682 | |2;audio-dft;183;185;186;188;185;184;187;182;185;187 03:13:45 INFO - PROCESS | 1682 | |3;audio-fft;73;80;72;118;55;59;57;58;118;55 03:13:45 INFO - PROCESS | 1682 | |4;audio-oscillator;96;93;129;80;77;82;116;76;78;112 03:13:45 INFO - PROCESS | 1682 | |5;imaging-gaussian-blur;94;130;88;86;88;85;89;86;88;85 03:13:45 INFO - PROCESS | 1682 | |6;imaging-darkroom;94;94;93;93;93;92;94;93;93;93 03:13:45 INFO - PROCESS | 1682 | |7;imaging-desaturate;85;86;85;86;87;86;86;85;85;89 03:13:45 INFO - PROCESS | 1682 | |8;json-parse-financial;55;58;58;58;58;58;59;69;51;53 03:13:45 INFO - PROCESS | 1682 | |9;json-stringify-tinderbox;61;61;66;75;66;64;64;64;64;67 03:13:45 INFO - PROCESS | 1682 | |10;stanford-crypto-aes;81;81;81;81;95;105;105;78;79;84 03:13:45 INFO - PROCESS | 1682 | |11;stanford-crypto-ccm;124;128;118;118;132;133;128;128;131;118 03:13:45 INFO - PROCESS | 1682 | |12;stanford-crypto-pbkdf2;133;123;134;132;135;122;132;131;133;132 03:13:45 INFO - PROCESS | 1682 | |13;stanford-crypto-sha256-iterative;66;65;67;66;66;65;64;65;66;65 03:13:45 INFO - PROCESS | 1682 | __end_tp_report 03:13:45 INFO - PROCESS | 1682 | __start_cc_report 03:13:45 INFO - PROCESS | 1682 | _x_x_mozilla_cycle_collect,1195 03:13:45 INFO - PROCESS | 1682 | __end_cc_report 03:13:45 INFO - PROCESS | 1682 | __startTimestamp1460110425211__endTimestamp 03:13:45 INFO - PROCESS | 1682 | 03:13:45 INFO - PROCESS | 1682 | ------- Summary: start ------- 03:13:45 INFO - PROCESS | 1682 | Number of tests: 14 03:13:45 INFO - PROCESS | 1682 | 03:13:45 INFO - PROCESS | 1682 | [#0] ai-astar Cycles:10 Average:111.90 Median:112.00 stddev:3.51 (3.1%) stddev-sans-first:3.66 03:13:45 INFO - PROCESS | 1682 | Values: 110.0 108.0 111.0 110.0 112.0 113.0 121.0 112.0 112.0 110.0 03:13:45 INFO - PROCESS | 1682 | 03:13:45 INFO - PROCESS | 1682 | [#1] audio-beat-detection Cycles:10 Average:136.60 Median:148.50 stddev:18.26 (12.3%) stddev-sans-first:18.38 03:13:45 INFO - PROCESS | 1682 | Values: 153.0 116.0 150.0 150.0 117.0 140.0 116.0 147.0 161.0 116.0 03:13:45 INFO - PROCESS | 1682 | 03:13:45 INFO - PROCESS | 1682 | [#2] audio-dft Cycles:10 Average:185.20 Median:185.50 stddev:1.87 (1.0%) stddev-sans-first:1.81 03:13:45 INFO - PROCESS | 1682 | Values: 183.0 185.0 186.0 188.0 185.0 184.0 187.0 182.0 185.0 187.0 03:13:45 INFO - PROCESS | 1682 | 03:13:45 INFO - PROCESS | 1682 | [#3] audio-fft Cycles:10 Average:74.50 Median:58.50 stddev:24.50 (41.9%) stddev-sans-first:25.98 03:13:45 INFO - PROCESS | 1682 | Values: 73.0 80.0 72.0 118.0 55.0 59.0 57.0 58.0 118.0 55.0 03:13:45 INFO - PROCESS | 1682 | 03:13:45 INFO - PROCESS | 1682 | [#4] audio-oscillator Cycles:10 Average:93.90 Median:79.00 stddev:18.99 (24.0%) stddev-sans-first:20.13 03:13:45 INFO - PROCESS | 1682 | Values: 96.0 93.0 129.0 80.0 77.0 82.0 116.0 76.0 78.0 112.0 03:13:45 INFO - PROCESS | 1682 | 03:13:45 INFO - PROCESS | 1682 | [#5] imaging-gaussian-blur Cycles:10 Average:91.90 Median:88.00 stddev:13.64 (15.5%) stddev-sans-first:14.45 03:13:45 INFO - PROCESS | 1682 | Values: 94.0 130.0 88.0 86.0 88.0 85.0 89.0 86.0 88.0 85.0 03:13:45 INFO - PROCESS | 1682 | 03:13:45 INFO - PROCESS | 1682 | [#6] imaging-darkroom Cycles:10 Average:93.20 Median:93.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 03:13:45 INFO - PROCESS | 1682 | Values: 94.0 94.0 93.0 93.0 93.0 92.0 94.0 93.0 93.0 93.0 03:13:45 INFO - PROCESS | 1682 | 03:13:45 INFO - PROCESS | 1682 | [#7] imaging-desaturate Cycles:10 Average:86.00 Median:86.00 stddev:1.25 (1.5%) stddev-sans-first:1.27 03:13:45 INFO - PROCESS | 1682 | Values: 85.0 86.0 85.0 86.0 87.0 86.0 86.0 85.0 85.0 89.0 03:13:45 INFO - PROCESS | 1682 | 03:13:45 INFO - PROCESS | 1682 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:58.00 stddev:4.76 (8.2%) stddev-sans-first:4.95 03:13:45 INFO - PROCESS | 1682 | Values: 55.0 58.0 58.0 58.0 58.0 58.0 59.0 69.0 51.0 53.0 03:13:45 INFO - PROCESS | 1682 | 03:13:45 INFO - PROCESS | 1682 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:3.97 (6.1%) stddev-sans-first:3.91 03:13:45 INFO - PROCESS | 1682 | Values: 61.0 61.0 66.0 75.0 66.0 64.0 64.0 64.0 64.0 67.0 03:13:45 INFO - PROCESS | 1682 | 03:13:45 INFO - PROCESS | 1682 | [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:81.00 stddev:10.59 (13.1%) stddev-sans-first:11.01 03:13:45 INFO - PROCESS | 1682 | Values: 81.0 81.0 81.0 81.0 95.0 105.0 105.0 78.0 79.0 84.0 03:13:45 INFO - PROCESS | 1682 | 03:13:45 INFO - PROCESS | 1682 | [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:128.00 stddev:5.94 (4.6%) stddev-sans-first:6.26 03:13:45 INFO - PROCESS | 1682 | Values: 124.0 128.0 118.0 118.0 132.0 133.0 128.0 128.0 131.0 118.0 03:13:45 INFO - PROCESS | 1682 | 03:13:45 INFO - PROCESS | 1682 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:130.70 Median:132.50 stddev:4.47 (3.4%) stddev-sans-first:4.67 03:13:45 INFO - PROCESS | 1682 | Values: 133.0 123.0 134.0 132.0 135.0 122.0 132.0 131.0 133.0 132.0 03:13:45 INFO - PROCESS | 1682 | 03:13:45 INFO - PROCESS | 1682 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:66.00 stddev:0.85 (1.3%) stddev-sans-first:0.88 03:13:45 INFO - PROCESS | 1682 | Values: 66.0 65.0 67.0 66.0 66.0 65.0 64.0 65.0 66.0 65.0 03:13:45 INFO - PROCESS | 1682 | -------- Summary: end -------- 03:13:45 INFO - PROCESS | 1682 | 03:13:45 INFO - TEST-INFO | 1682: exit 0 03:13:45 INFO - TEST-OK | kraken | took 56471ms 03:13:45 INFO - SUITE-END | took 1168s 03:13:46 INFO - Completed test suite (00:19:29) 03:13:46 INFO - javascript benchmark 03:13:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3094.4584697677906, 3444.982775086124, 3447.4828775683636, 3450.2754421571467, 3500.667436593523, 5624.409437009112, 5628.577856660757, 5629.7185140743, 5629.802956896509, 5661.886762264752, 5594.748236329365, 5616.663000219979, 5630.774769009245, 5637.154426835967, 5648.604597678164, 5080.263361812535, 5097.84706458805, 5104.979004199156, 5137.58899288057, 5149.201873709562, 5183.248428977796, 5186.9626074785, 5187.792488300463, 5191.714455704935, 5206.140986737184, 5116.1814109742445, 5163.406208286057, 5185.403678576955, 5202.76587553561, 5210.505002024802, 4611.5619016193405, 5183.53348198662, 5216.3218781558535, 5230.058589453897, 5284.339457567804, 5023.447420783711, 5100.974495127538, 5102.540771330561, 5110.310108135392, 5148.0, 4816.555033489939, 5522.972385138089, 5564.054110801174, 5572.080606699889, 5598.608097433182, 6037.245344331958, 6078.787242446538, 6089.817305480843, 6163.198784158076, 6199.969000155015, 6136.1821086261625, 6160.815175544741, 6181.938180618181, 6246.750129994794, 6253.312135665074, 5708.514776244025, 5753.309602847643, 5758.309002919635, 5760.53915686744, 5794.65232086072, 6237.532185086136, 6243.625382477066, 6379.234491861006, 6379.71291291893, 6383.202099737533, 6056.647052957033, 6075.817725468243, 6090.23872015998, 6090.756369745249, 6094.423602403839, 6210.534209934273, 6215.564910456224, 6215.564910456315, 6222.035584484322, 6223.284322302902, 6026.156338112668, 6079.422454866781, 6116.847078823065, 6122.20411346531, 6137.110119032715, 6155.784547540904, 6156.538259630545, 6165.938340616626, 6196.721147548371, 6197.03945888388, 4875.5124487551675, 4879.170541008037, 4885.193942999365, 4900.950990490121, 4901.117798796179, 4273.9358909616385, 4394.912101757947, 4410.580994805488, 4418.734875907456, 4431.889202769957, 5519.530839878575, 5594.0769772987005, 5602.187682786055, 5602.299712535933, 5604.943950560524, 6121.693915304217, 6130.63216207029, 6135.509159267248, 6139.201903752483, 6144.016957286902, 5603.131514615241, 5639.295088113986, 5653.208550802891, 5666.631668941505, 5682.829515114553, 5345.679259244458, 5369.436209197978, 5370.1407774756635, 5371.435999220103, 5383.461653834664, 6382.808515744535, 6390.297067322591, 6392.296847346788, 6397.072424498421, 6401.615903045832, 6099.176611157437, 6126.30393285589, 6127.617148554337, 6234.1583886174785, 6297.905531417124, 6366.108744775827, 6371.458426033839, 6372.9362706374195, 6374.840628984312, 6383.744650213939, 6110.7250173741395, 6128.969355153374, 6130.969345153246, 6144.324124346408, 6148.292946311052, 5539.612227144061, 6114.785982490592, 6177.011678131477, 6200.596961197508, 6235.501159907287, 5983.730732117152, 5989.880202396015, 5997.10043493462, 6003.90994135097, 6016.608920420159, 6022.337542870193, 6032.426919442646, 6038.758449661965, 6047.879042419215, 6051.727672254847, 5783.797567085132, 5867.0, 5872.530197584098, 5875.471207591338, 6012.259551943633, 5797.275340582427, 5808.82573522795, 5817.447342502455, 5839.328477225174, 5865.3254875689845, 5688.089905615082, 5725.856853578527, 5726.74229659658, 5730.226419433323, 5744.109663002241], "unit": "score", "name": "dojo.html", "value": 5635.364777429934}, {"lowerIsBetter": false, "replicates": [470.5224197439599, 493.0877875929533, 608.4919092557714, 631.2614241337633, 674.4570620650376, 30333.393332133342, 32176.67823321766, 32190.0, 32201.51697724536, 32254.516182257285, 33091.834540827265, 34339.82830085852, 42527.57472425275, 42592.361114583306, 42621.36067958975, 8326.500409975391, 9613.086756758097, 9768.706938791847, 9809.607615695364, 9810.018998100168, 9617.56720947559, 9769.316147869651, 9776.120149186572, 9778.853317200212, 9779.559919803625, 9033.638654453815, 9081.727548173565, 9792.951035244814, 9799.657012004582, 9822.803543929118, 9711.0, 9861.654842080565, 9874.1113299803, 9889.554970026365, 9901.900980990242, 9701.563429645683, 9815.607375704963, 9816.509174541316, 9830.508474576243, 9851.605935762562, 42568.0, 42949.14101717979, 42969.35545966813, 42970.14059718788, 43022.35466468005, 3425.8629654813776, 3438.4670376091744, 3470.4620783778555, 3599.4600809878466, 4012.7391719538427, 28142.0, 29039.274018149503, 29601.407971840443, 29645.110646680634, 30281.545776813364, 2797.608334833125, 2836.347640042781, 2844.9431011379656, 2856.8285902845687, 2883.495388307038, 501273.0, 506738.0, 507105.0, 507868.0, 508325.0, 74773.25226747771, 75039.24960750432, 75041.0, 75121.24878751252, 75130.62434687791, 79802.0, 81396.59301703454, 81494.0, 81556.77664835032, 81659.5917020423, 18493.352732654294, 18525.81474185241, 18675.15961781723, 18741.81258187428, 18756.531086722942, 14058.929705351407, 14185.0, 14201.360938757574, 14208.431662733376, 14227.715445691028, 22736.545269094855, 23074.538509229722, 23108.075676972734, 23172.53654926892, 23571.29286121419, 8368.744688296803, 9461.668841590648, 9554.90445095554, 9875.456849873326, 9883.505824708736, 975.5512464266375, 1025.205465764024, 1091.1210646153002, 1119.4682525800342, 1198.2451055834767, 27843.164705058476, 30427.0, 30577.08268751941, 30957.0, 30991.915282965438, 1158.264502041193, 1170.3621526268205, 1178.263585259213, 1200.8198770184542, 1226.2397313665585, 15264.313105910262, 15394.0, 15403.691926161415, 15704.528864134094, 15726.68546629061, 548749.2562537162, 553073.703894442, 556032.0, 556340.0, 556828.0, 62850.857457126964, 63385.0, 63449.68275158687, 63685.0, 63934.36065639377, 1415.7451658701327, 1446.6600348917996, 1527.0990115831712, 1574.889757716949, 1575.5430925031612, 30067.700327806633, 30361.24096897595, 30543.0, 30557.677616500863, 30705.539416908316, 50825.0, 51275.23087153621, 51350.486495136065, 51381.0, 51457.0, 338108.0, 369860.0, 369992.0, 370272.0, 370923.0, 29805.5529167067, 34375.484367734, 34692.0, 35057.298854023284, 35105.0, 43328.56671433245, 43531.0, 43676.56323436725, 43949.12101758011, 44009.33985990148, 35148.82425587856, 36254.274914502086, 36317.27365452729, 36542.63457365392, 37062.62937370592, 35676.64323356837, 35751.64248357587, 35981.64018359783, 36460.45309320309, 36566.63433365632, 36790.8160459196, 37101.25797483981, 37342.8132859334, 38169.80915095407, 38224.0, 31590.73637054492, 32116.67883321137, 32313.838430808635, 32374.83812580922, 32856.83571582127, 24713.382165446008, 24754.381140471633, 24892.875535622206, 25126.246212613652, 25209.11768088108], "unit": "score", "name": "ext.html", "value": 20424.590317927257}, {"lowerIsBetter": false, "replicates": [373.9569949455812, 380.5794596970348, 382.3022983055923, 389.0196704305149, 389.6162280154048, 19759.802401975976, 19822.801771982293, 20282.69575956362, 20418.183272669074, 20458.28396006138, 17699.91150044251, 20050.097745601448, 20539.28112516062, 20812.583748325025, 21360.67958980613, 5222.399424066243, 5949.583529152961, 6002.939970600281, 6003.429674180968, 6005.909911351333, 4137.420761093449, 4492.595666390024, 6458.0, 6557.672116394185, 6669.699863506154, 6585.703643336062, 6591.077249185118, 6600.075989361493, 6602.207735071798, 6615.17310336208, 6218.595791273553, 6491.8052458425855, 6498.415142637138, 6500.41496265336, 6500.577462464948, 5569.526590239834, 5616.803411880564, 5629.071203251458, 5639.238702775114, 5640.689762063085, 24459.0, 25783.484330313288, 25985.960561577514, 26039.479210415873, 26488.470230595474, 2279.076973825603, 2347.5891718949115, 2405.987970060156, 2591.3262551736498, 2740.83514506334, 14725.337359818726, 15033.548993530103, 15215.771763423558, 15286.541403757905, 15311.234438278041, 1744.6685129825294, 1762.268658506718, 1768.328035346573, 1837.5589858434014, 1839.6181999296289, 91390.0, 93802.0, 96264.0, 96567.51716241444, 97605.53591696131, 10407.375557466576, 10685.83971240432, 10941.726456838484, 11130.443477826077, 11191.496382662637, 13464.259465729283, 13501.0, 13563.864361356458, 13574.321283935764, 13582.86417135816, 8776.429532080394, 8930.86603700945, 8946.910530894738, 8990.011098779129, 9022.593983270768, 9182.449053056838, 9191.540422978824, 9196.448213107235, 9277.304202184863, 9285.907140928504, 6122.357152499013, 6344.191905306965, 6345.682715864188, 6358.109864618957, 6375.649339286384, 1819.4359748478014, 1873.147717788403, 1875.6436277107307, 1889.527618095476, 1900.7814101378242, 935.8362286599818, 972.0, 983.1495756171004, 997.7079681812071, 1100.625787232345, 19236.519087022658, 21209.045592948354, 21810.0, 21858.344249672537, 22996.0, 993.2997236948079, 998.8202123617673, 1019.8266294729914, 1033.2508931024947, 1043.3322673488974, 10929.125669946385, 11376.0, 11435.0, 11437.02785263262, 11452.713682157846, 625285.0, 627858.0, 634155.0, 644424.0, 673168.0, 124508.0, 125911.0, 129115.0, 130859.0, 134322.32838835742, 1069.3102948598266, 1095.7041598768128, 1109.5672687651822, 1109.8279766636185, 1110.3615421132881, 18085.547861303574, 18198.818011819712, 18330.17514211837, 18419.355322563646, 18784.6243075135, 41702.648387288755, 50717.746411267704, 51584.90697339239, 52729.41811745654, 52865.735671321396, 72194.0, 72638.0, 73754.0, 74538.0, 77317.84023239544, 8008.799780005546, 8205.630746616298, 8352.331813454788, 8466.407351485337, 8553.97352317701, 12199.87800122023, 13442.0, 13530.932345338604, 13839.515616953358, 13900.16599004063, 11779.411029448322, 11823.881761182278, 11828.053755699351, 11903.464344104363, 11967.341796201292, 11618.419079046183, 11680.948714615726, 11726.472308746297, 11887.524499020288, 11927.667161666344, 10037.49812509357, 10994.560217591206, 11768.470418831344, 11959.820602690792, 12251.75496490083, 8053.395995300493, 8185.754427367188, 8294.502329860228, 8381.203785640355, 8519.8722019171, 8479.78800529967, 8628.137186281321, 11096.722581935193, 11381.317120972768, 12072.39638018078], "unit": "score", "name": "jquery.html", "value": 9888.064742985172}, {"lowerIsBetter": false, "replicates": [1283.4352884730724, 1385.8336999560051, 1651.1661610886504, 1926.624308259889, 2115.2385141349114, 8423.452475589082, 9085.818283634324, 9222.077792220774, 9226.123518265762, 9226.169644731974, 8950.776230594238, 9201.17189452949, 9209.723708288746, 9229.815403691939, 9263.166315031645, 2150.7849215078522, 2243.181238847817, 2502.324372419446, 2571.974280257197, 2583.147561304765, 2605.413781899067, 2609.4650596627644, 2614.2026681862026, 2618.6857577090777, 2619.0571394298036, 2292.8280378971563, 2495.189063554343, 2499.9250022499355, 2590.870456477178, 2598.142612937726, 2330.8135349172026, 2372.5729368713623, 2569.203546900467, 2600.8569528675916, 2604.7785938195275, 2548.413864811104, 2581.922542323733, 2602.2583563684448, 2603.856787876666, 2615.908443204498, 9251.768705782342, 9359.719208423758, 9377.953110234404, 9399.389039712465, 9402.106799854071, 5733.655980641175, 5898.1152827076285, 5952.494038006775, 5963.13534537494, 5964.433378829048, 3703.148275896559, 3790.166163444038, 3790.469334293201, 3815.961840381616, 3827.7129215308687, 1065.477915821242, 1066.5840322274319, 1077.06833588945, 1095.5617752898825, 1121.6298621454982, 12613.558525451657, 12617.242965422103, 12635.368231588476, 12640.620781376481, 12696.111272211041, 5068.873278168076, 5077.644564880423, 5180.637355385163, 5189.870253243624, 5209.687418754811, 10713.732156695989, 10733.83899241512, 10746.78506429867, 10757.677269681923, 10778.73053173677, 5868.67722275279, 5875.676837773964, 5890.440408161217, 5919.496842768327, 5928.525717942554, 4648.093621743795, 4800.303955926371, 5028.899422011539, 5113.028524580318, 5187.948120518822, 4099.651529619956, 4130.380442933584, 4184.322033898246, 4185.769782661922, 4192.098698779777, 1009.707184916366, 1127.6278827986744, 1198.1433275208267, 1200.8739082396398, 1299.1750238598559, 1128.802459569572, 1151.7696460707725, 1156.2079975217002, 1366.3714691241942, 1457.118443341784, 8609.5695215239, 8639.740807775777, 8643.265322447662, 8800.119988001148, 8862.512561809033, 987.7579992901641, 1176.394157009141, 1205.8372119763894, 1270.4092596942282, 1275.0819410024767, 6456.838579035468, 6493.25327587324, 6538.280789113193, 6552.017197420425, 6564.179477565304, 11203.159763017806, 11734.11994100446, 11744.58893938708, 11747.236429632047, 11766.058715302755, 11038.944805275922, 11477.253978491372, 11536.25014374063, 11561.826572601418, 11620.76758464826, 8737.781555461164, 8755.343349248831, 8857.822843543221, 8873.467591944374, 8875.334349923653, 8296.419250652396, 8309.335253179852, 8335.208155225244, 8414.990201175899, 8446.662133514836, 9957.551910164206, 10081.092701656886, 10262.435566043641, 10279.177665786869, 10355.068043876086, 10261.0, 10649.8935010652, 10686.519106640375, 10802.189835762192, 10847.186461015297, 6771.0, 6916.861662766616, 6918.273581273894, 7228.132624085143, 7489.513181643176, 8085.272325490734, 8418.536980466133, 8733.868991964999, 8743.519106449206, 8745.863037805044, 7653.502522336031, 7691.4615976883315, 7749.535027898344, 7882.960585197037, 7928.405369597188, 7579.810504737426, 7618.314351708373, 7693.230676932486, 7800.570968596555, 7831.647575858986, 6766.289539598271, 8110.918890811016, 8116.391270654843, 8126.228008339198, 8188.7952801180445, 7285.817854553678, 7400.148982867039, 7422.814429639302, 7429.44279179053, 7453.142888567667, 7478.0, 7497.887531687138, 7554.395648348229, 7563.281488258606, 7564.621768911643], "unit": "score", "name": "mootools.html", "value": 5159.797736157637}, {"lowerIsBetter": false, "replicates": [299.6988027032833, 327.1934681011307, 337.5729701927062, 337.8445914879155, 343.0617261789005, 6354.714037868302, 6394.456471199947, 6403.135576697145, 6414.326495717953, 6456.192975878015, 6244.500439964803, 6314.873702525947, 6321.1150438938585, 6343.492520598353, 6346.889294373478, 3765.585785563586, 4444.911101777962, 4560.771961401933, 4571.817127314904, 4720.268358404444, 4645.512221216774, 4653.95286060637, 4663.8367657132, 4675.088357770236, 4698.6006189473765, 4587.449506059277, 4617.722936623813, 4626.699264547794, 4631.791569379369, 4659.231226847566, 4396.120775844844, 4508.391367165424, 4647.581717645395, 4659.138059459011, 4660.04469083837, 4017.819198136091, 4043.3732771420478, 4052.1895620875944, 4062.2078694654556, 4063.7968101595097, 4752.287156926489, 6061.757529698807, 6081.665508397036, 6107.206063211798, 6114.663693496856, 5473.480019398151, 5510.173473978895, 5526.226328314039, 5527.281453411071, 5546.639468434539, 6701.865962680719, 6709.261981182066, 6742.865142697167, 6751.493637977172, 6813.11429514165, 4398.120375924827, 4561.7262964222255, 4577.5880170784785, 4596.896744781262, 4602.401687780601, 6266.809306231801, 6662.800115996528, 7033.191183013917, 7096.396806271473, 7148.356647901714, 3824.9426258606145, 4685.0629874025335, 4711.8350857719815, 4722.763861806896, 4727.763611819395, 4769.713817170981, 4769.785359658824, 4781.211100168433, 4785.928211076836, 4800.183968725325, 4448.866534003985, 5528.391876893538, 5542.307211598551, 5542.889142217133, 5547.944520554824, 5478.890422191534, 6529.412352888263, 6768.763093291711, 6788.2193547742645, 6825.146856642919, 1640.9343626255054, 1644.21077882617, 1664.4923298393865, 1666.0170499405408, 1668.382698401599, 1027.9743006424899, 1054.0776820282254, 1074.119222237773, 1077.8221593437152, 1104.9060829829393, 6041.24484439445, 6129.264488261348, 6151.477124444473, 6201.720922558496, 6354.618722876642, 7043.718251269892, 7059.435245180373, 7062.1878483975, 7071.292870712888, 7099.3965512930945, 6312.936870631327, 6323.9051414228825, 6338.112664227012, 6341.4609758170145, 6396.968015159894, 3654.8720794772057, 3698.130939229279, 3714.0900479382185, 3722.7021838252876, 3738.831752571141, 7150.10623672041, 7398.297161769623, 7414.332710056013, 7469.663865126083, 7492.925070749332, 7218.855622887513, 7234.927650723531, 7247.528910620793, 7257.0565826442225, 7275.454340924452, 7386.0, 7390.297921697537, 7398.926010739931, 7406.296401841816, 7424.294692004251, 6992.370686638227, 7021.0, 7023.367896889305, 7032.894506582303, 7044.260352663102, 6677.399034086956, 6911.481638877205, 6915.481338899502, 6943.930560694531, 6952.165740111219, 6116.449519543263, 6914.481413894078, 7280.417566594554, 7378.0, 7378.3029903121505, 4481.148581769454, 4554.089182163514, 4559.38448309474, 4560.794764235551, 4560.954390456053, 7023.929760702532, 7032.12098487689, 7043.823904402431, 7056.15326160864, 7058.25888281723, 6521.380468855451, 6789.691504888362, 6823.761168359084, 6835.043093966749, 6858.3827455529245, 6703.195616526048, 6794.558353706993, 6815.318468153145, 6816.454683625398, 6828.5220034597105, 5377.489138531833, 6649.534532582673, 6652.135222421248, 6654.966725166343, 6679.766208182885, 6789.0, 6795.592264464148, 6816.62508562014, 6819.897701534382, 6827.931720682928, 6364.586301890362, 6417.550771445954, 6475.1582294303325, 6520.18497687789, 6637.867242655023], "unit": "score", "name": "prototype.html", "value": 4973.386861040777}, {"lowerIsBetter": false, "replicates": [720.4344589497249, 723.7720118162779, 751.4814777803318, 767.3439209475898, 774.3766268154135, 15299.388024479022, 15471.45849895254, 15670.294836732346, 15672.764908526382, 15680.686386272282, 14818.333175007123, 14888.0, 14891.627709307273, 14901.105933643988, 14915.179665118414, 800.1558355934487, 809.9959500202491, 998.9400635961865, 1034.3586976074807, 1036.2849633752687, 986.5067466266867, 1004.0963133180123, 1006.2101250518344, 1006.5118417567473, 1009.5154325923561, 1066.653337665258, 1067.4395942130404, 1068.6046162919731, 1068.9198310126733, 1069.9090577300938, 838.0362583029535, 848.9320854331638, 849.7068511363632, 1058.6506452870574, 1068.7648717282225, 634.9968250158765, 780.3951937248621, 795.0380040151424, 797.5693125712108, 797.9905419644155, 16065.277062532097, 16110.677786444205, 16129.274182661808, 16147.273372698257, 16199.35202591895, 13391.531296404677, 13529.797053044213, 13531.458741650322, 13690.657733556642, 13789.793153102712, 10124.088832005154, 10331.121854642364, 10349.172066234683, 10463.738406539822, 10497.685069447929, 3561.554805649294, 3568.107973006748, 3595.8921232363073, 3673.0633688409284, 3816.809159542012, 84759.72860407038, 85042.0, 86378.0, 86679.0, 87168.12831871664, 9802.446376522814, 9844.064813842673, 9971.40171589707, 9990.200783937413, 10188.0, 23391.649125263135, 23478.413039674146, 23487.295381138592, 23517.529649406915, 23565.882170589037, 7576.962115189499, 7667.11828139771, 7669.079710434672, 7741.8838717419285, 7784.350430550356, 4222.408862759216, 4228.556001619847, 4267.103908179255, 4407.118576284756, 4423.5576442355505, 3713.7400381973002, 3760.7179461539945, 3769.359208934488, 3775.5846856845724, 3781.546214454283, 637.4199478474566, 646.4634353486595, 665.2848188197706, 666.2072134160334, 669.4042302350912, 573.1574585359515, 615.3354377272535, 619.0219453263833, 624.316373570939, 630.152444961526, 8061.1938806118915, 8419.536925469158, 8605.31157507398, 8621.09478504748, 8660.696875609323, 552.0500816656827, 583.635227982511, 589.7906243283659, 606.0848119339829, 619.3465893482329, 3886.106195575034, 3956.169204467094, 4032.5362583303295, 4075.89810254746, 4094.5905409458815, 97159.0, 97309.05381892464, 98696.0, 99350.5032474833, 100501.48746281401, 82686.58656706678, 83433.74849377264, 83738.5813070943, 84993.0, 85276.14723852681, 66471.33528664749, 70264.64867675629, 71531.64234178796, 72657.2734272661, 73078.63460682663, 8591.355648326526, 8604.913950860411, 8778.385513014027, 8855.55722213874, 8895.73312800617, 49410.0, 50398.697158972485, 51290.0, 52258.693532661986, 52365.47634523606, 74624.62687686527, 75756.4848703034, 75878.0, 76087.0, 76422.0, 11000.504977275881, 11170.050545703707, 11191.496382662963, 11421.37182454973, 11611.245269057823, 11955.342456164646, 12119.0, 12241.0, 12342.259464432163, 12647.304398257817, 11816.70458238551, 11855.822162667395, 11958.940205298917, 12035.398230088636, 12224.75550489003, 11819.527218911147, 11929.522819087138, 11989.280643161439, 12191.695207619525, 12247.571335003233, 11496.712582185177, 11557.42212889369, 11696.06431485496, 11765.941170294094, 11803.645890623295, 10011.299209055296, 10070.295079344669, 10253.641122560675, 10263.384196948207, 10434.37393756377, 9665.661701840401, 9931.205503559553, 9932.354396964174, 9955.850662239927, 9967.750806229902], "unit": "score", "name": "yui.html", "value": 7256.677638688216}], "name": "dromaeo_css", "value": 7721.605202908351}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 108.0, 111.0, 110.0, 112.0, 113.0, 121.0, 112.0, 112.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.9}, {"lowerIsBetter": true, "replicates": [153.0, 116.0, 150.0, 150.0, 117.0, 140.0, 116.0, 147.0, 161.0, 116.0], "unit": "score", "name": "audio-beat-detection", "value": 136.6}, {"lowerIsBetter": true, "replicates": [183.0, 185.0, 186.0, 188.0, 185.0, 184.0, 187.0, 182.0, 185.0, 187.0], "unit": "score", "name": "audio-dft", "value": 185.2}, {"lowerIsBetter": true, "replicates": [73.0, 80.0, 72.0, 118.0, 55.0, 59.0, 57.0, 58.0, 118.0, 55.0], "unit": "score", "name": "audio-fft", "value": 74.5}, {"lowerIsBetter": true, "replicates": [96.0, 93.0, 129.0, 80.0, 77.0, 82.0, 116.0, 76.0, 78.0, 112.0], "unit": "score", "name": "audio-oscillator", "value": 93.9}, {"lowerIsBetter": true, "replicates": [94.0, 130.0, 88.0, 86.0, 88.0, 85.0, 89.0, 86.0, 88.0, 85.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 91.9}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 93.0, 93.0, 93.0, 92.0, 94.0, 93.0, 93.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 93.2}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 85.0, 86.0, 87.0, 86.0, 86.0, 85.0, 85.0, 89.0], "unit": "score", "name": "imaging-desaturate", "value": 86.0}, {"lowerIsBetter": true, "replicates": [55.0, 58.0, 58.0, 58.0, 58.0, 58.0, 59.0, 69.0, 51.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 57.7}, {"lowerIsBetter": true, "replicates": [61.0, 61.0, 66.0, 75.0, 66.0, 64.0, 64.0, 64.0, 64.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.2}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 81.0, 81.0, 95.0, 105.0, 105.0, 78.0, 79.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.0}, {"lowerIsBetter": true, "replicates": [124.0, 128.0, 118.0, 118.0, 132.0, 133.0, 128.0, 128.0, 131.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.8}, {"lowerIsBetter": true, "replicates": [133.0, 123.0, 134.0, 132.0, 135.0, 122.0, 132.0, 131.0, 133.0, 132.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 130.7}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 67.0, 66.0, 66.0, 65.0, 64.0, 65.0, 66.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.5}], "name": "kraken", "value": 1405.1000000000001}]} 03:13:46 INFO - Return code: 0 03:13:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:13:46 INFO - # TBPL SUCCESS # 03:13:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:13:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:13:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:13:46 INFO - 2016-04-08 03:13:46.520 screenresolution[1686:10207] starting screenresolution argv=screenresolution get 03:13:46 INFO - 2016-04-08 03:13:46.522 screenresolution[1686:10207] Display 0: 1600x1200x32@60 03:13:46 INFO - 2016-04-08 03:13:46.528 screenresolution[1687:10210] starting screenresolution argv=screenresolution list 03:13:46 INFO - Available Modes on Display 0 03:13:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:13:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:13:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:13:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:13:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:13:46 INFO - Intel Iris: 03:13:46 INFO - Chipset Model: Intel Iris 03:13:46 INFO - Type: GPU 03:13:46 INFO - Bus: Built-In 03:13:46 INFO - VRAM (Dynamic, Max): 1536 MB 03:13:46 INFO - Vendor: Intel (0x8086) 03:13:46 INFO - Device ID: 0x0a2e 03:13:46 INFO - Revision ID: 0x0009 03:13:46 INFO - Displays: 03:13:46 INFO - Display: 03:13:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:13:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:13:46 INFO - Display Serial Number: 1600x1200 60 03:13:46 INFO - Main Display: Yes 03:13:46 INFO - Mirror: Off 03:13:46 INFO - Online: Yes 03:13:46 INFO - Rotation: Supported 03:13:46 INFO - Return code: 0 03:13:46 INFO - Running post-action listener: _resource_record_post_action 03:13:46 INFO - Running post-run listener: _resource_record_post_run 03:13:47 INFO - Total resource usage - Wall time: 1203s; CPU: 53.0%; Read bytes: 32402944; Write bytes: 666320384; Read time: 321; Write time: 2105 03:13:47 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 354150912; Write bytes: 354310144; Read time: 27974; Write time: 664 03:13:47 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 31464960; Write bytes: 301671936; Read time: 306; Write time: 1408 03:13:47 INFO - Running post-run listener: _upload_blobber_files 03:13:47 INFO - Blob upload gear active. 03:13:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:13:47 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:13:47 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:13:47 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:13:48 INFO - (blobuploader) - INFO - Open directory for files ... 03:13:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:13:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:13:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:13:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:13:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:13:48 INFO - (blobuploader) - INFO - Done attempting. 03:13:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:13:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:13:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:13:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:13:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:13:50 INFO - (blobuploader) - INFO - Done attempting. 03:13:50 INFO - (blobuploader) - INFO - Iteration through files over. 03:13:50 INFO - Return code: 0 03:13:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:13:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:13:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4790c8c28d127fdc6940d0f83c1caf4395c8dbaaa81ac16f11bbb2de0f99841ddeaff43608fd0a2df38ce3d5c653d5781470e591611e57fc0f0491d996e65212", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aa92d2286420b481c09be62303cae2d5b0d3f37b1882ccc518b511f5bdad5211b0aa4f907839190042abeaad625793886e5b6627e8b28d7e2924f015c8c18b6e"} 03:13:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:13:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:13:50 INFO - Contents: 03:13:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4790c8c28d127fdc6940d0f83c1caf4395c8dbaaa81ac16f11bbb2de0f99841ddeaff43608fd0a2df38ce3d5c653d5781470e591611e57fc0f0491d996e65212", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aa92d2286420b481c09be62303cae2d5b0d3f37b1882ccc518b511f5bdad5211b0aa4f907839190042abeaad625793886e5b6627e8b28d7e2924f015c8c18b6e"} 03:13:50 INFO - Running post-run listener: copy_logs_to_upload_dir 03:13:50 INFO - Copying logs to upload dir... 03:13:50 INFO - mkdir: /builds/slave/test/build/upload/logs 03:13:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.288802 ========= master_lag: 1.34 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-04-08 03:13:50.123886) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-08 03:13:50.127913) ========= 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.dTEXCA5y8o/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.c4NrSezioQ/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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/4790c8c28d127fdc6940d0f83c1caf4395c8dbaaa81ac16f11bbb2de0f99841ddeaff43608fd0a2df38ce3d5c653d5781470e591611e57fc0f0491d996e65212", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aa92d2286420b481c09be62303cae2d5b0d3f37b1882ccc518b511f5bdad5211b0aa4f907839190042abeaad625793886e5b6627e8b28d7e2924f015c8c18b6e"} build_url:https://queue.taskcluster.net/v1/task/ImiGljzWSgGgBNSd5WYmDw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011286 build_url: 'https://queue.taskcluster.net/v1/task/ImiGljzWSgGgBNSd5WYmDw/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/4790c8c28d127fdc6940d0f83c1caf4395c8dbaaa81ac16f11bbb2de0f99841ddeaff43608fd0a2df38ce3d5c653d5781470e591611e57fc0f0491d996e65212", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aa92d2286420b481c09be62303cae2d5b0d3f37b1882ccc518b511f5bdad5211b0aa4f907839190042abeaad625793886e5b6627e8b28d7e2924f015c8c18b6e"}' ========= master_lag: 0.44 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-08 03:13:50.577939) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 03:13:50.578291) ========= 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.dTEXCA5y8o/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.c4NrSezioQ/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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.005175 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 03:13:50.631272) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-08 03:13:50.631624) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-08 03:13:50.632054) ========= ========= Total master_lag: 23.39 =========