builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0033 starttime: 1457431503.35 results: success (0) buildid: 20160308004005 builduid: 910d3bff56774b48867b4e7b0f6eff08 revision: ce9a5e723e4b21ce0dac5ede64e156023bb70534 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-08 02:05:03.352881) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-08 02:05:03.353295) ========= ========= Started set props: basedir (results: 0, elapsed: 1 mins, 33 secs) (at 2016-03-08 02:05:03.353611) ========= 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.TNuXnrDPqF/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.nEv4j6P5fP/Listeners TMPDIR=/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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.005331 basedir: '/builds/slave/test' ========= master_lag: 93.30 ========= ========= Finished set props: basedir (results: 0, elapsed: 1 mins, 33 secs) (at 2016-03-08 02:06:36.662404) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 23 secs) (at 2016-03-08 02:06:36.662718) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 23 secs) (at 2016-03-08 02:07:00.584621) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-03-08 02:07:00.586007) ========= 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.TNuXnrDPqF/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.nEv4j6P5fP/Listeners TMPDIR=/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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.005852 ========= master_lag: 1.13 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-03-08 02:07:01.717573) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-08 02:07:01.717856) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-08 02:07:01.718214) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 9 secs) (at 2016-03-08 02:07:01.718488) ========= 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.TNuXnrDPqF/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.nEv4j6P5fP/Listeners TMPDIR=/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-08 02:07:01-- 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% 159M=0s 2016-03-08 02:07:02 (159 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.976644 ========= master_lag: 8.44 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 9 secs) (at 2016-03-08 02:07:11.133277) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 12 secs) (at 2016-03-08 02:07:11.133553) ========= 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.TNuXnrDPqF/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.nEv4j6P5fP/Listeners TMPDIR=/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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.026480 ========= master_lag: 12.60 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 12 secs) (at 2016-03-08 02:07:23.758970) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 6 secs) (at 2016-03-08 02:07:23.759342) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ce9a5e723e4b21ce0dac5ede64e156023bb70534 --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 ce9a5e723e4b21ce0dac5ede64e156023bb70534 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TNuXnrDPqF/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.nEv4j6P5fP/Listeners TMPDIR=/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-08 02:07:24,079 truncating revision to first 12 chars 2016-03-08 02:07:24,079 Setting DEBUG logging. 2016-03-08 02:07:24,079 attempt 1/10 2016-03-08 02:07:24,079 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ce9a5e723e4b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-08 02:07:27,195 unpacking tar archive at: mozilla-aurora-ce9a5e723e4b/testing/mozharness/ program finished with exit code 0 elapsedTime=4.148178 ========= master_lag: 2.79 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 6 secs) (at 2016-03-08 02:07:30.702312) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-08 02:07:30.702744) ========= echo ce9a5e723e4b21ce0dac5ede64e156023bb70534 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'ce9a5e723e4b21ce0dac5ede64e156023bb70534'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TNuXnrDPqF/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.nEv4j6P5fP/Listeners TMPDIR=/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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 ce9a5e723e4b21ce0dac5ede64e156023bb70534 program finished with exit code 0 elapsedTime=0.005784 script_repo_revision: 'ce9a5e723e4b21ce0dac5ede64e156023bb70534' ========= master_lag: 0.69 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-08 02:07:31.394634) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 9 secs) (at 2016-03-08 02:07:31.394968) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 9 secs) (at 2016-03-08 02:07:40.627774) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-03-08 02:07:40.628148) ========= /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.TNuXnrDPqF/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.nEv4j6P5fP/Listeners TMPDIR=/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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:07:41 INFO - MultiFileLogger online at 20160308 02:07:41 in /builds/slave/test 02:07:41 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:07:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:07:41 INFO - {'append_to_log': False, 02:07:41 INFO - 'base_work_dir': '/builds/slave/test', 02:07:41 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:07:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:07:41 INFO - 'branch': 'Mozilla-Aurora', 02:07:41 INFO - 'buildbot_json_path': 'buildprops.json', 02:07:41 INFO - 'config_files': ('talos/mac_config.py',), 02:07:41 INFO - 'default_actions': ('clobber', 02:07:41 INFO - 'read-buildbot-config', 02:07:41 INFO - 'download-and-extract', 02:07:41 INFO - 'populate-webroot', 02:07:41 INFO - 'create-virtualenv', 02:07:41 INFO - 'install', 02:07:41 INFO - 'run-tests'), 02:07:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:07:41 INFO - 'download_minidump_stackwalk': True, 02:07:41 INFO - 'download_symbols': 'ondemand', 02:07:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:07:41 INFO - 'tooltool.py': '/tools/tooltool.py', 02:07:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:07:41 INFO - '/tools/misc-python/virtualenv.py')}, 02:07:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:07:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:07:41 INFO - 'installer_path': 'installer.exe', 02:07:41 INFO - 'log_level': 'info', 02:07:41 INFO - 'log_name': 'talos', 02:07:41 INFO - 'log_to_console': True, 02:07:41 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:07:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:07:41 INFO - 'opt_config_files': (), 02:07:41 INFO - 'pip_index': False, 02:07:41 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:07:41 INFO - 'cmd': ('bash', 02:07:41 INFO - '-c', 02:07:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:07:41 INFO - 'enabled': True, 02:07:41 INFO - 'halt_on_failure': False, 02:07:41 INFO - 'name': 'check_screen_resolution'},), 02:07:41 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:07:41 INFO - 'cmd': ('bash', 02:07:41 INFO - '-c', 02:07:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:07:41 INFO - 'enabled': True, 02:07:41 INFO - 'halt_on_failure': False, 02:07:41 INFO - 'name': 'check_screen_resolution'},), 02:07:41 INFO - 'run_cmd_checks_enabled': True, 02:07:41 INFO - 'sps_profile': False, 02:07:41 INFO - 'sps_profile_interval': 0, 02:07:41 INFO - 'suite': 'dromaeojs', 02:07:41 INFO - 'system_bits': '32', 02:07:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:07:41 INFO - 'title': 't-yosemite-r7-0033', 02:07:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:07:41 INFO - 'use_talos_json': True, 02:07:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:07:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:07:41 INFO - 'work_dir': 'build'} 02:07:41 INFO - ##### 02:07:41 INFO - ##### Running clobber step. 02:07:41 INFO - ##### 02:07:41 INFO - Running pre-action listener: _resource_record_pre_action 02:07:41 INFO - Running main action method: clobber 02:07:41 INFO - rmtree: /builds/slave/test/build 02:07:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:07:43 INFO - Running post-action listener: _resource_record_post_action 02:07:43 INFO - ##### 02:07:43 INFO - ##### Running read-buildbot-config step. 02:07:43 INFO - ##### 02:07:43 INFO - Running pre-action listener: _resource_record_pre_action 02:07:43 INFO - Running main action method: read_buildbot_config 02:07:43 INFO - Using buildbot properties: 02:07:43 INFO - { 02:07:43 INFO - "project": "", 02:07:43 INFO - "product": "firefox", 02:07:43 INFO - "script_repo_revision": "production", 02:07:43 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 02:07:43 INFO - "repository": "", 02:07:43 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 02:07:43 INFO - "buildid": "20160308004005", 02:07:43 INFO - "stage_platform": "macosx64", 02:07:43 INFO - "basedir": "/builds/slave/test", 02:07:43 INFO - "nightly_build": "True", 02:07:43 INFO - "buildnumber": 212, 02:07:43 INFO - "slavename": "t-yosemite-r7-0033", 02:07:43 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 02:07:43 INFO - "platform": "yosemite_r7", 02:07:43 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:07:43 INFO - "branch": "mozilla-aurora", 02:07:43 INFO - "repo_path": "releases/mozilla-aurora", 02:07:43 INFO - "revision": "ce9a5e723e4b21ce0dac5ede64e156023bb70534", 02:07:43 INFO - "pgo_build": "False", 02:07:43 INFO - "builduid": "910d3bff56774b48867b4e7b0f6eff08", 02:07:43 INFO - "slavebuilddir": "test" 02:07:43 INFO - } 02:07:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/MHL_SnqvREec-1EcMQlUxA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 02:07:43 INFO - Running post-action listener: _resource_record_post_action 02:07:43 INFO - ##### 02:07:43 INFO - ##### Running download-and-extract step. 02:07:43 INFO - ##### 02:07:43 INFO - Running pre-action listener: _resource_record_pre_action 02:07:43 INFO - Running main action method: download_and_extract 02:07:43 INFO - mkdir: /builds/slave/test/build/tests 02:07:43 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:07:43 INFO - https://queue.taskcluster.net/v1/task/MHL_SnqvREec-1EcMQlUxA/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 02:07:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MHL_SnqvREec-1EcMQlUxA/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 02:07:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MHL_SnqvREec-1EcMQlUxA/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 02:07:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MHL_SnqvREec-1EcMQlUxA/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:07:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MHL_SnqvREec-1EcMQlUxA/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:07:45 INFO - Downloaded 1277 bytes. 02:07:45 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 02:07:45 INFO - Using the following test package requirements: 02:07:45 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 02:07:45 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:07:45 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 02:07:45 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:07:45 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 02:07:45 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:07:45 INFO - u'jsshell-mac.zip'], 02:07:45 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:07:45 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 02:07:45 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 02:07:45 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:07:45 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 02:07:45 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:07:45 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 02:07:45 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:07:45 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 02:07:45 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 02:07:45 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:07:45 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 02:07:45 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:07:45 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:07:45 INFO - https://queue.taskcluster.net/v1/task/MHL_SnqvREec-1EcMQlUxA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:07:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MHL_SnqvREec-1EcMQlUxA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:07:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MHL_SnqvREec-1EcMQlUxA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:07:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MHL_SnqvREec-1EcMQlUxA/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:07:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MHL_SnqvREec-1EcMQlUxA/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:07:46 INFO - Downloaded 17864745 bytes. 02:07:46 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:07:46 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:07:49 INFO - Return code: 0 02:07:49 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:07:49 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:07:49 INFO - https://queue.taskcluster.net/v1/task/MHL_SnqvREec-1EcMQlUxA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:07:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MHL_SnqvREec-1EcMQlUxA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:07:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MHL_SnqvREec-1EcMQlUxA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:07:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MHL_SnqvREec-1EcMQlUxA/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:07:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MHL_SnqvREec-1EcMQlUxA/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:07:51 INFO - Downloaded 17864745 bytes. 02:07:51 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:07:51 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:07:54 INFO - Return code: 0 02:07:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:54 INFO - https://queue.taskcluster.net/v1/task/MHL_SnqvREec-1EcMQlUxA/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:07:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MHL_SnqvREec-1EcMQlUxA/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 02:07:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MHL_SnqvREec-1EcMQlUxA/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 02:07:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MHL_SnqvREec-1EcMQlUxA/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:07:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MHL_SnqvREec-1EcMQlUxA/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:07:58 INFO - Downloaded 10845161 bytes. 02:07:58 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:07:58 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:07:58 INFO - Return code: 0 02:07:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:58 INFO - https://queue.taskcluster.net/v1/task/MHL_SnqvREec-1EcMQlUxA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 02:07:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MHL_SnqvREec-1EcMQlUxA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:07:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MHL_SnqvREec-1EcMQlUxA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:07:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MHL_SnqvREec-1EcMQlUxA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 02:07:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MHL_SnqvREec-1EcMQlUxA/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:08:01 INFO - Downloaded 115007092 bytes. 02:08:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MHL_SnqvREec-1EcMQlUxA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:08:01 INFO - mkdir: /builds/slave/test/properties 02:08:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:08:01 INFO - Writing to file /builds/slave/test/properties/build_url 02:08:01 INFO - Contents: 02:08:01 INFO - build_url:https://queue.taskcluster.net/v1/task/MHL_SnqvREec-1EcMQlUxA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:08:02 INFO - Running post-action listener: _resource_record_post_action 02:08:02 INFO - Running post-action listener: set_extra_try_arguments 02:08:02 INFO - ##### 02:08:02 INFO - ##### Running populate-webroot step. 02:08:02 INFO - ##### 02:08:02 INFO - Running pre-action listener: _resource_record_pre_action 02:08:02 INFO - Running main action method: populate_webroot 02:08:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:08:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:08:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:08:02 INFO - '--tppagecycles', 02:08:02 INFO - '7'], 02:08:02 INFO - 'tests': ['tsvgm']}}, 02:08:02 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:08:02 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:08:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:08:02 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 02:08:02 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:08:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:08:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:08:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:02 INFO - 'talos_options': ['--e10s'], 02:08:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:08:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:02 INFO - 'tests': ['damp', 'tps']}, 02:08:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:02 INFO - 'talos_options': ['--e10s'], 02:08:02 INFO - 'tests': ['damp', 'tps']}, 02:08:02 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:08:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:08:02 INFO - 'other': {'tests': ['a11yr', 02:08:02 INFO - 'ts_paint', 02:08:02 INFO - 'tpaint', 02:08:02 INFO - 'sessionrestore', 02:08:02 INFO - 'sessionrestore_no_auto_restore', 02:08:02 INFO - 'tabpaint']}, 02:08:02 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:08:02 INFO - 'tests': ['a11yr', 02:08:02 INFO - 'ts_paint', 02:08:02 INFO - 'tpaint', 02:08:02 INFO - 'sessionrestore', 02:08:02 INFO - 'sessionrestore_no_auto_restore', 02:08:02 INFO - 'tabpaint']}, 02:08:02 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:08:02 INFO - 'tests': ['a11yr', 02:08:02 INFO - 'ts_paint', 02:08:02 INFO - 'tpaint', 02:08:02 INFO - 'sessionrestore', 02:08:02 INFO - 'sessionrestore_no_auto_restore', 02:08:02 INFO - 'tabpaint']}, 02:08:02 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:08:02 INFO - 'tests': ['a11yr', 02:08:02 INFO - 'ts_paint', 02:08:02 INFO - 'tpaint', 02:08:02 INFO - 'sessionrestore', 02:08:02 INFO - 'sessionrestore_no_auto_restore', 02:08:02 INFO - 'tabpaint']}, 02:08:02 INFO - 'other_l64': {'tests': ['a11yr', 02:08:02 INFO - 'ts_paint', 02:08:02 INFO - 'tpaint', 02:08:02 INFO - 'sessionrestore', 02:08:02 INFO - 'sessionrestore_no_auto_restore', 02:08:02 INFO - 'tabpaint']}, 02:08:02 INFO - 'other_nol64': {'tests': ['a11yr', 02:08:02 INFO - 'ts_paint', 02:08:02 INFO - 'tpaint', 02:08:02 INFO - 'sessionrestore', 02:08:02 INFO - 'sessionrestore_no_auto_restore', 02:08:02 INFO - 'tabpaint']}, 02:08:02 INFO - 'svgr': {'tests': ['tsvgx', 02:08:02 INFO - 'tsvgr_opacity', 02:08:02 INFO - 'tart', 02:08:02 INFO - 'tscrollx', 02:08:02 INFO - 'cart']}, 02:08:02 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:08:02 INFO - 'tests': ['tsvgx', 02:08:02 INFO - 'tsvgr_opacity', 02:08:02 INFO - 'tart', 02:08:02 INFO - 'tscrollx', 02:08:02 INFO - 'cart']}, 02:08:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:02 INFO - 'tests': ['tp5o']}, 02:08:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:02 INFO - 'talos_options': ['--e10s'], 02:08:02 INFO - 'tests': ['tp5o']}, 02:08:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:02 INFO - 'talos_options': ['--xperf_path', 02:08:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:08:02 INFO - 'tests': ['tp5n']}, 02:08:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:02 INFO - 'talos_options': ['--e10s', 02:08:02 INFO - '--xperf_path', 02:08:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:08:02 INFO - 'tests': ['tp5n']}}, 02:08:02 INFO - 'talos.zip': {'path': '', 02:08:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:08:02 INFO - Running post-action listener: _resource_record_post_action 02:08:02 INFO - ##### 02:08:02 INFO - ##### Running create-virtualenv step. 02:08:02 INFO - ##### 02:08:02 INFO - Running pre-action listener: _resource_record_pre_action 02:08:02 INFO - Running main action method: create_virtualenv 02:08:02 INFO - Creating virtualenv /builds/slave/test/build/venv 02:08:02 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:08:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:08:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:08:03 INFO - Using real prefix '/tools/python27' 02:08:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:08:03 INFO - Installing distribute.............................................................................................................................................................................................done. 02:08:06 INFO - Installing pip.................done. 02:08:06 INFO - Return code: 0 02:08:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:08:06 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:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:06 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:08:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:06 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 0x102efda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f044c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe0b55c950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102da1d30>, '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 0x102c05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d98b20>, '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.TNuXnrDPqF/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.nEv4j6P5fP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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:08:06 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:08:06 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:08:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TNuXnrDPqF/Render', 02:08:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:08:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:08:06 INFO - 'HOME': '/Users/cltbld', 02:08:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:08:06 INFO - 'LOGNAME': 'cltbld', 02:08:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:06 INFO - 'MOZ_NO_REMOTE': '1', 02:08:06 INFO - 'NO_EM_RESTART': '1', 02:08:06 INFO - 'PAGER': '/bin/cat', 02:08:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:08:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:06 INFO - 'PWD': '/builds/slave/test', 02:08:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:08:06 INFO - 'SHELL': '/bin/bash', 02:08:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nEv4j6P5fP/Listeners', 02:08:06 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 02:08:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:08:06 INFO - 'USER': 'cltbld', 02:08:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:08:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:08:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:06 INFO - 'XPC_FLAGS': '0x0', 02:08:06 INFO - 'XPC_SERVICE_NAME': '0', 02:08:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:08:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:06 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:08:06 INFO - Cleaning up... 02:08:06 INFO - Return code: 0 02:08:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:08:06 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:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:06 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:08:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:06 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 0x102efda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f044c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe0b55c950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102da1d30>, '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 0x102c05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d98b20>, '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.TNuXnrDPqF/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.nEv4j6P5fP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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:08:06 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:08:06 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:08:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TNuXnrDPqF/Render', 02:08:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:08:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:08:06 INFO - 'HOME': '/Users/cltbld', 02:08:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:08:06 INFO - 'LOGNAME': 'cltbld', 02:08:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:06 INFO - 'MOZ_NO_REMOTE': '1', 02:08:06 INFO - 'NO_EM_RESTART': '1', 02:08:06 INFO - 'PAGER': '/bin/cat', 02:08:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:08:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:06 INFO - 'PWD': '/builds/slave/test', 02:08:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:08:06 INFO - 'SHELL': '/bin/bash', 02:08:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nEv4j6P5fP/Listeners', 02:08:06 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 02:08:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:08:06 INFO - 'USER': 'cltbld', 02:08:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:08:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:08:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:06 INFO - 'XPC_FLAGS': '0x0', 02:08:06 INFO - 'XPC_SERVICE_NAME': '0', 02:08:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:08:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:07 INFO - Downloading/unpacking psutil>=0.7.1 02:08:07 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:08:07 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:08:07 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:08:07 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:08:07 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:08:07 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:08:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:08:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:08:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:08:10 INFO - Installing collected packages: psutil 02:08:10 INFO - Running setup.py install for psutil 02:08:10 INFO - building 'psutil._psutil_osx' extension 02:08:10 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:08:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 02:08:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 02:08:11 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:08:11 INFO - building 'psutil._psutil_posix' extension 02:08:11 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:08:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:08:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:08:11 INFO - ^ 02:08:11 INFO - 1 warning generated. 02:08:11 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:08:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:08:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:08:11 INFO - Successfully installed psutil 02:08:11 INFO - Cleaning up... 02:08:11 INFO - Return code: 0 02:08:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:08:11 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:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:11 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:08:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:11 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 0x102efda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f044c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe0b55c950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102da1d30>, '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 0x102c05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d98b20>, '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.TNuXnrDPqF/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.nEv4j6P5fP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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:08:11 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:08:11 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:08:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TNuXnrDPqF/Render', 02:08:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:08:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:08:11 INFO - 'HOME': '/Users/cltbld', 02:08:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:08:11 INFO - 'LOGNAME': 'cltbld', 02:08:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:11 INFO - 'MOZ_NO_REMOTE': '1', 02:08:11 INFO - 'NO_EM_RESTART': '1', 02:08:11 INFO - 'PAGER': '/bin/cat', 02:08:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:08:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:11 INFO - 'PWD': '/builds/slave/test', 02:08:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:08:11 INFO - 'SHELL': '/bin/bash', 02:08:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nEv4j6P5fP/Listeners', 02:08:11 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 02:08:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:08:11 INFO - 'USER': 'cltbld', 02:08:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:08:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:08:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:11 INFO - 'XPC_FLAGS': '0x0', 02:08:11 INFO - 'XPC_SERVICE_NAME': '0', 02:08:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:08:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:08:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:08:14 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:08:14 INFO - Installing collected packages: mozsystemmonitor 02:08:14 INFO - Running setup.py install for mozsystemmonitor 02:08:15 INFO - Successfully installed mozsystemmonitor 02:08:15 INFO - Cleaning up... 02:08:15 INFO - Return code: 0 02:08:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:08: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:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08: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:08:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:15 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 0x102efda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f044c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe0b55c950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102da1d30>, '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 0x102c05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d98b20>, '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.TNuXnrDPqF/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.nEv4j6P5fP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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:08:15 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:08:15 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:08:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TNuXnrDPqF/Render', 02:08:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:08:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:08:15 INFO - 'HOME': '/Users/cltbld', 02:08:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:08:15 INFO - 'LOGNAME': 'cltbld', 02:08:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:15 INFO - 'MOZ_NO_REMOTE': '1', 02:08:15 INFO - 'NO_EM_RESTART': '1', 02:08:15 INFO - 'PAGER': '/bin/cat', 02:08:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:08:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:15 INFO - 'PWD': '/builds/slave/test', 02:08:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:08:15 INFO - 'SHELL': '/bin/bash', 02:08:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nEv4j6P5fP/Listeners', 02:08:15 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 02:08:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:08:15 INFO - 'USER': 'cltbld', 02:08:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:08:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:08:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:15 INFO - 'XPC_FLAGS': '0x0', 02:08:15 INFO - 'XPC_SERVICE_NAME': '0', 02:08:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:08:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:15 INFO - Downloading/unpacking blobuploader==1.2.4 02:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:17 INFO - Downloading blobuploader-1.2.4.tar.gz 02:08:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:08:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:08: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:08: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:08: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:08: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:08: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:08: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:08:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:08:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:18 INFO - Downloading docopt-0.6.1.tar.gz 02:08:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:08:19 INFO - Installing collected packages: blobuploader, requests, docopt 02:08:19 INFO - Running setup.py install for blobuploader 02:08:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:08:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:08:19 INFO - Running setup.py install for requests 02:08:19 INFO - Running setup.py install for docopt 02:08:19 INFO - Successfully installed blobuploader requests docopt 02:08:19 INFO - Cleaning up... 02:08:19 INFO - Return code: 0 02:08:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:08: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:08:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08: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:08:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:19 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 0x102efda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f044c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe0b55c950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102da1d30>, '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 0x102c05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d98b20>, '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.TNuXnrDPqF/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.nEv4j6P5fP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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:08:19 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:08:19 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:08:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TNuXnrDPqF/Render', 02:08:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:08:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:08:19 INFO - 'HOME': '/Users/cltbld', 02:08:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:08:19 INFO - 'LOGNAME': 'cltbld', 02:08:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:19 INFO - 'MOZ_NO_REMOTE': '1', 02:08:19 INFO - 'NO_EM_RESTART': '1', 02:08:19 INFO - 'PAGER': '/bin/cat', 02:08:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:08:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:19 INFO - 'PWD': '/builds/slave/test', 02:08:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:08:19 INFO - 'SHELL': '/bin/bash', 02:08:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nEv4j6P5fP/Listeners', 02:08:19 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 02:08:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:08:19 INFO - 'USER': 'cltbld', 02:08:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:08:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:08:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:19 INFO - 'XPC_FLAGS': '0x0', 02:08:19 INFO - 'XPC_SERVICE_NAME': '0', 02:08:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:08:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:08:20 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-DeJz04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:08:20 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-ulK88i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:08:20 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-7fqkSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:08:20 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-s4PBN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:08:20 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-9YHuvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:08:20 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-nELkcZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:08:20 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-hFp3j5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:08:20 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-7n6Jwq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:08:20 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-Nt2jTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:08:21 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-qrldTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:08:21 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-m1_m26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:08:21 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-L3KgkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:08:21 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-W9yDGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:08:21 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-6T21Eo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:08:21 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-vnuYEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:08:21 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-1Vrtfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:08:21 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-5IeCWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:08:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:08:21 INFO - Running setup.py install for manifestparser 02:08:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:08:21 INFO - Running setup.py install for mozcrash 02:08:22 INFO - Running setup.py install for mozdebug 02:08:22 INFO - Running setup.py install for mozdevice 02:08:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:08:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:08:22 INFO - Running setup.py install for mozfile 02:08:22 INFO - Running setup.py install for mozhttpd 02:08:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:08:22 INFO - Running setup.py install for mozinfo 02:08:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:08:22 INFO - Running setup.py install for mozInstall 02:08:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:08:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:08:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:08:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:08:23 INFO - Running setup.py install for mozleak 02:08:23 INFO - Running setup.py install for mozlog 02:08:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:08:23 INFO - Running setup.py install for moznetwork 02:08:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:08:23 INFO - Running setup.py install for mozprocess 02:08:23 INFO - Running setup.py install for mozprofile 02:08:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:08:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:08:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:08:23 INFO - Running setup.py install for mozrunner 02:08:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:08:23 INFO - Running setup.py install for mozscreenshot 02:08:24 INFO - Running setup.py install for moztest 02:08:24 INFO - Running setup.py install for mozversion 02:08:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:08:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:08:24 INFO - Cleaning up... 02:08:24 INFO - Return code: 0 02:08:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:08: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:08:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08: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:08:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:24 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 0x102efda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f044c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe0b55c950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102da1d30>, '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 0x102c05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d98b20>, '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.TNuXnrDPqF/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.nEv4j6P5fP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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:08:24 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:08:24 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:08:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TNuXnrDPqF/Render', 02:08:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:08:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:08:24 INFO - 'HOME': '/Users/cltbld', 02:08:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:08:24 INFO - 'LOGNAME': 'cltbld', 02:08:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:24 INFO - 'MOZ_NO_REMOTE': '1', 02:08:24 INFO - 'NO_EM_RESTART': '1', 02:08:24 INFO - 'PAGER': '/bin/cat', 02:08:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:08:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:24 INFO - 'PWD': '/builds/slave/test', 02:08:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:08:24 INFO - 'SHELL': '/bin/bash', 02:08:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nEv4j6P5fP/Listeners', 02:08:24 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 02:08:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:08:24 INFO - 'USER': 'cltbld', 02:08:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:08:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:08:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:24 INFO - 'XPC_FLAGS': '0x0', 02:08:24 INFO - 'XPC_SERVICE_NAME': '0', 02:08:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:08:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:08:24 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-XO4mh5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:08:24 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:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:08:24 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-lUW9rA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:08:24 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:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:08:24 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-VS7HZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:08:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:08:25 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-w7NJM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:08:25 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:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:08:25 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-sSPC5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:08:25 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:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:08:25 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-7VXsWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:08:25 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:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:08:25 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-ZVqEPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:08:25 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:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:08:25 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-59Imt0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:08:25 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:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:08:25 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-muqHcl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:08:25 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:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:08:25 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-j6tBMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:08:25 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:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:08:25 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-QW3F2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:08:25 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:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:08:25 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-fuC34Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:08:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:08:26 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-QJznve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:08:26 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:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:08:26 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-S3F_a5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:08:26 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:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:08:26 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-wSJOsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:08:26 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:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:08:26 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-cZndDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:08:26 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:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:08:26 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-eI6d1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:08:26 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:08:26 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:08:26 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:08:26 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:08:26 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:08:26 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:08:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:08:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:30 INFO - Downloading blessings-1.6.tar.gz 02:08:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:08:30 INFO - Installing collected packages: blessings 02:08:30 INFO - Running setup.py install for blessings 02:08:30 INFO - Successfully installed blessings 02:08:30 INFO - Cleaning up... 02:08:30 INFO - Return code: 0 02:08:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:08:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:08:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:08:31 INFO - Reading from file tmpfile_stdout 02:08:31 INFO - Current package versions: 02:08:31 INFO - blessings == 1.6 02:08:31 INFO - blobuploader == 1.2.4 02:08:31 INFO - docopt == 0.6.1 02:08:31 INFO - manifestparser == 1.1 02:08:31 INFO - mozInstall == 1.12 02:08:31 INFO - mozcrash == 0.17 02:08:31 INFO - mozdebug == 0.1 02:08:31 INFO - mozdevice == 0.48 02:08:31 INFO - mozfile == 1.2 02:08:31 INFO - mozhttpd == 0.7 02:08:31 INFO - mozinfo == 0.9 02:08:31 INFO - mozleak == 0.1 02:08:31 INFO - mozlog == 3.1 02:08:31 INFO - moznetwork == 0.27 02:08:31 INFO - mozprocess == 0.22 02:08:31 INFO - mozprofile == 0.28 02:08:31 INFO - mozrunner == 6.11 02:08:31 INFO - mozscreenshot == 0.1 02:08:31 INFO - mozsystemmonitor == 0.0 02:08:31 INFO - moztest == 0.7 02:08:31 INFO - mozversion == 1.4 02:08:31 INFO - psutil == 3.1.1 02:08:31 INFO - requests == 1.2.3 02:08:31 INFO - wsgiref == 0.1.2 02:08:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:08:31 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:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:31 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:08:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:31 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 0x102efda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f044c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe0b55c950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102da1d30>, '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 0x102c05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d98b20>, '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.TNuXnrDPqF/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.nEv4j6P5fP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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:08:31 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:08:31 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:08:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TNuXnrDPqF/Render', 02:08:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:08:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:08:31 INFO - 'HOME': '/Users/cltbld', 02:08:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:08:31 INFO - 'LOGNAME': 'cltbld', 02:08:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:31 INFO - 'MOZ_NO_REMOTE': '1', 02:08:31 INFO - 'NO_EM_RESTART': '1', 02:08:31 INFO - 'PAGER': '/bin/cat', 02:08:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:08:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:31 INFO - 'PWD': '/builds/slave/test', 02:08:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:08:31 INFO - 'SHELL': '/bin/bash', 02:08:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nEv4j6P5fP/Listeners', 02:08:31 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 02:08:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:08:31 INFO - 'USER': 'cltbld', 02:08:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:08:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:08:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:31 INFO - 'XPC_FLAGS': '0x0', 02:08:31 INFO - 'XPC_SERVICE_NAME': '0', 02:08:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:08:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:31 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:08:31 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:08:31 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:08:31 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:08:31 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:08:31 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:08:31 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:08:31 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:08:31 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:08:31 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:08:31 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:08:31 INFO - Cleaning up... 02:08:31 INFO - Return code: 0 02:08:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:08:31 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:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:31 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:08:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:31 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 0x102efda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f044c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe0b55c950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102da1d30>, '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 0x102c05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d98b20>, '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.TNuXnrDPqF/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.nEv4j6P5fP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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:08:31 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:08:31 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:08:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TNuXnrDPqF/Render', 02:08:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:08:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:08:31 INFO - 'HOME': '/Users/cltbld', 02:08:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:08:31 INFO - 'LOGNAME': 'cltbld', 02:08:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:31 INFO - 'MOZ_NO_REMOTE': '1', 02:08:31 INFO - 'NO_EM_RESTART': '1', 02:08:31 INFO - 'PAGER': '/bin/cat', 02:08:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:08:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:31 INFO - 'PWD': '/builds/slave/test', 02:08:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:08:31 INFO - 'SHELL': '/bin/bash', 02:08:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nEv4j6P5fP/Listeners', 02:08:31 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 02:08:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:08:31 INFO - 'USER': 'cltbld', 02:08:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:08:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:08:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:31 INFO - 'XPC_FLAGS': '0x0', 02:08:31 INFO - 'XPC_SERVICE_NAME': '0', 02:08:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:08:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:31 INFO - Downloading/unpacking jsonschema 02:08: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:08: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:08: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:08: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:08: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:08: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:08:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:08:34 INFO - Downloading/unpacking functools32 (from jsonschema) 02:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:35 INFO - Downloading functools32-3.2.3-2.tar.gz 02:08:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:08:35 INFO - warning: no files found matching '*.txt' 02:08:35 INFO - no previously-included directories found matching 'build' 02:08:35 INFO - no previously-included directories found matching 'dist' 02:08:35 INFO - no previously-included directories found matching '.git*' 02:08:35 INFO - Installing collected packages: jsonschema, functools32 02:08:35 INFO - Running setup.py install for functools32 02:08:35 INFO - warning: no files found matching '*.txt' 02:08:35 INFO - no previously-included directories found matching 'build' 02:08:35 INFO - no previously-included directories found matching 'dist' 02:08:35 INFO - no previously-included directories found matching '.git*' 02:08:35 INFO - Successfully installed jsonschema functools32 02:08:35 INFO - Cleaning up... 02:08:35 INFO - Return code: 0 02:08:35 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:08:35 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:08:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:35 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:08:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:35 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 0x102efda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f044c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe0b55c950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102da1d30>, '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 0x102c05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d98b20>, '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.TNuXnrDPqF/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.nEv4j6P5fP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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:08:35 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:08:35 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:08:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TNuXnrDPqF/Render', 02:08:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:08:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:08:35 INFO - 'HOME': '/Users/cltbld', 02:08:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:08:35 INFO - 'LOGNAME': 'cltbld', 02:08:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:35 INFO - 'MOZ_NO_REMOTE': '1', 02:08:35 INFO - 'NO_EM_RESTART': '1', 02:08:35 INFO - 'PAGER': '/bin/cat', 02:08:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:08:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:35 INFO - 'PWD': '/builds/slave/test', 02:08:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:08:35 INFO - 'SHELL': '/bin/bash', 02:08:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nEv4j6P5fP/Listeners', 02:08:35 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 02:08:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:08:35 INFO - 'USER': 'cltbld', 02:08:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:08:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:08:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:35 INFO - 'XPC_FLAGS': '0x0', 02:08:35 INFO - 'XPC_SERVICE_NAME': '0', 02:08:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:08:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:35 INFO - Downloading/unpacking flake8 02:08: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:08: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:08: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:08: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:08: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:08: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:08:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:08:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:08: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:08: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:08: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:08: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:08: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:08: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:08:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:08:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:08: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:08: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:08: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:08: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:08: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:08: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:08:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:08:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:08:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:08:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:08:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:08:39 INFO - no previously-included directories found matching 'docs/_build' 02:08:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:08:39 INFO - Running setup.py install for pep8 02:08:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:08:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:08:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:08:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:08:39 INFO - no previously-included directories found matching 'docs/_build' 02:08:39 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:08:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:08:39 INFO - Cleaning up... 02:08:40 INFO - Return code: 0 02:08:40 INFO - Running post-action listener: _resource_record_post_action 02:08:40 INFO - Running post-action listener: _start_resource_monitoring 02:08:40 INFO - Starting resource monitoring. 02:08:40 INFO - ##### 02:08:40 INFO - ##### Running install step. 02:08:40 INFO - ##### 02:08:40 INFO - Running pre-action listener: _resource_record_pre_action 02:08:40 INFO - Running main action method: install 02:08:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:08:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:08:40 INFO - Reading from file tmpfile_stdout 02:08:40 INFO - Detecting whether we're running mozinstall >=1.0... 02:08:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:08:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:08:40 INFO - Reading from file tmpfile_stdout 02:08:40 INFO - Output received: 02:08:40 INFO - Usage: mozinstall [options] installer 02:08:40 INFO - Options: 02:08:40 INFO - -h, --help show this help message and exit 02:08:40 INFO - -d DEST, --destination=DEST 02:08:40 INFO - Directory to install application into. [default: 02:08:40 INFO - "/builds/slave/test"] 02:08:40 INFO - --app=APP Application being installed. [default: firefox] 02:08:40 INFO - mkdir: /builds/slave/test/build/application 02:08:40 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:08:40 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:09:12 INFO - Reading from file tmpfile_stdout 02:09:12 INFO - Output received: 02:09:12 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:09:12 INFO - Running post-action listener: _resource_record_post_action 02:09:12 INFO - ##### 02:09:12 INFO - ##### Running run-tests step. 02:09:12 INFO - ##### 02:09:12 INFO - Running pre-action listener: _resource_record_pre_action 02:09:12 INFO - Running main action method: run_tests 02:09:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:09:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:09:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:09:12 INFO - 2016-03-08 02:09:12.361 screenresolution[1648:8060] starting screenresolution argv=screenresolution get 02:09:12 INFO - 2016-03-08 02:09:12.363 screenresolution[1648:8060] Display 0: 1600x1200x32@60 02:09:12 INFO - 2016-03-08 02:09:12.368 screenresolution[1649:8063] starting screenresolution argv=screenresolution list 02:09:12 INFO - Available Modes on Display 0 02:09:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:09:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:09:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:09:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:09:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:09:12 INFO - Intel Iris: 02:09:12 INFO - Chipset Model: Intel Iris 02:09:12 INFO - Type: GPU 02:09:12 INFO - Bus: Built-In 02:09:12 INFO - VRAM (Dynamic, Max): 1536 MB 02:09:12 INFO - Vendor: Intel (0x8086) 02:09:12 INFO - Device ID: 0x0a2e 02:09:12 INFO - Revision ID: 0x0009 02:09:12 INFO - Displays: 02:09:12 INFO - Display: 02:09:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:09:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:09:12 INFO - Display Serial Number: 1600x1200 60 02:09:12 INFO - Main Display: Yes 02:09:12 INFO - Mirror: Off 02:09:12 INFO - Online: Yes 02:09:12 INFO - Rotation: Supported 02:09:12 INFO - Return code: 0 02:09:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:09:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:09:12 INFO - Python 2.7.3 02:09:12 INFO - Return code: 0 02:09:12 INFO - grabbing minidump binary from tooltool 02:09: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:09:12 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 0x102da1d30>, '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 0x102c05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d98b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:09:12 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:09:12 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:09:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:09:12 INFO - Return code: 0 02:09:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:09:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:09:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:09:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:09:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:09:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:09:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:09:13 INFO - Return code: 0 02:09:13 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/MHL_SnqvREec-1EcMQlUxA/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0033', '--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:09:13 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/MHL_SnqvREec-1EcMQlUxA/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0033 --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:09:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TNuXnrDPqF/Render', 02:09:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:09:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:09:13 INFO - 'HOME': '/Users/cltbld', 02:09:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:09:13 INFO - 'LOGNAME': 'cltbld', 02:09:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:09:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:09:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:13 INFO - 'MOZ_NO_REMOTE': '1', 02:09:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:09:13 INFO - 'NO_EM_RESTART': '1', 02:09:13 INFO - 'PAGER': '/bin/cat', 02:09:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:09:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:13 INFO - 'PWD': '/builds/slave/test', 02:09:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:09:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:09:13 INFO - 'SHELL': '/bin/bash', 02:09:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nEv4j6P5fP/Listeners', 02:09:13 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 02:09:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:09:13 INFO - 'USER': 'cltbld', 02:09:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:09:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:09:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:13 INFO - 'XPC_FLAGS': '0x0', 02:09:13 INFO - 'XPC_SERVICE_NAME': '0', 02:09:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:09:13 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/MHL_SnqvREec-1EcMQlUxA/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0033', '--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:09:14 INFO - mozversion application_buildid: 20160308004005 02:09:14 INFO - mozversion application_changeset: ce9a5e723e4b21ce0dac5ede64e156023bb70534 02:09:14 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:09:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:09:14 INFO - mozversion application_name: Firefox 02:09:14 INFO - mozversion application_remotingname: firefox-dev 02:09:14 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:09:14 INFO - mozversion application_vendor: Mozilla 02:09:14 INFO - mozversion application_version: 47.0a2 02:09:14 INFO - mozversion platform_buildid: 20160308004005 02:09:14 INFO - mozversion platform_changeset: ce9a5e723e4b21ce0dac5ede64e156023bb70534 02:09:14 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:09:14 INFO - mozversion platform_version: 47.0a2 02:09:14 INFO - using testdate: 1457431754 02:09:14 INFO - actual date: 1457431754 02:09:14 INFO - starting webserver on 'localhost:49276' 02:09:14 INFO - SUITE-START | Running 2 tests 02:09:14 INFO - TEST-START | dromaeo_css 02:09:14 INFO - operating with platform_type : mac_ 02:09:14 INFO - Initialising browser for dromaeo_css test... 02:09:14 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/tmp6rxx8P/profile http://localhost:49276/getInfo.html) 02:09:16 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 02:09:16 INFO - PROCESS | 1667 | colorDepth:24 02:09:16 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 02:09:16 INFO - PROCESS | 1667 | __metrics 02:09:16 INFO - PROCESS | 1667 | 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:09:16 INFO - PROCESS | 1667 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:09:17 INFO - TEST-INFO | 1667: exit 0 02:09:17 INFO - Browser initialized. 02:09:17 INFO - Running cycle 1/1 for dromaeo_css test... 02:09:17 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/tmp6rxx8P/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:09:29 INFO - PROCESS | 1671 | RSS: Main: 210808832 02:09:29 INFO - PROCESS | 1671 | 02:10:20 INFO - PROCESS | 1671 | 1457431820225 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:12:30 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 02:12:31 INFO - PROCESS | 1671 | RSS: Main: 322002944 02:12:31 INFO - PROCESS | 1671 | 02:15:33 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 02:15:34 INFO - PROCESS | 1671 | RSS: Main: 347185152 02:15:34 INFO - PROCESS | 1671 | 02:18:36 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 02:18:36 INFO - PROCESS | 1671 | RSS: Main: 345071616 02:18:36 INFO - PROCESS | 1671 | 02:21:39 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 02:21:39 INFO - PROCESS | 1671 | RSS: Main: 306008064 02:21:39 INFO - PROCESS | 1671 | 02:24:42 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 02:24:43 INFO - PROCESS | 1671 | RSS: Main: 307585024 02:24:43 INFO - PROCESS | 1671 | 02:27:45 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 02:27:46 INFO - PROCESS | 1671 | RSS: Main: 368766976 02:27:46 INFO - PROCESS | 1671 | 02:27:46 INFO - PROCESS | 1671 | __start_tp_report 02:27:46 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 02:27:46 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 02:27:46 INFO - PROCESS | 1671 | |i|pagename|runs| 02:27:46 INFO - PROCESS | 1671 | |0;dojo.html;3451.5512983312165;3496.842642081106;3533.9646603533956;3539.5044693742866;3560.821958902054;5736.139579063142;5746.827595172146;5778.942210577893;5783.161441590967;5796.884062318756;5731.512821410175;5775.133729940511;5776.682282474462;5788.27646544182;5805.535557155428;5133.974330128344;5172.19830926207;5185.611079169059;5199.09015922214;5299.735013249341;5266.605004624649;5276.947230527684;5277.498637629438;5285.709285989269;5293.6294459387855;5224.8693782655355;5266.262723218752;5272.6836389816735;5282.418933917266;5290.285811415448;5285.841424757264;5292.973535132338;5305.098133317345;5319.122344813101;5323.574114070865;5028.673136246169;5221.242919776649;5227.503387178212;5234.16253399458;5244.370675518962;5643.984082865082;5646.26598542191;5648.943510564883;5667.773289068432;5667.971660141673;5168.586513078944;5278.630495865253;6071.865557969369;6199.597026193328;6225.128482012522;6156.3843615638525;6168.290646575656;6215.2541694996435;6263.342349053375;6269.529785266078;4733.952660473386;5602.467765562265;5606.159076138611;5607.719614019283;5632.549396048306;6190.81427557174;6216;6220.688965551704;6225.501959843202;6239;6177.505799536027;6180.47465965389;6191;6195.938040619536;6205.968970155121;6243.625382476975;6265.154204182468;6270.372962703785;6271.059341098871;6282.403171698681;5251.842444726664;6024.427679370453;6116.579253789288;6172.8765424691255;6216.129741836146;6172.197614310111;6207.596506227081;6232.0963460298;6243.719032643542;6249.6562689051625;4882.780274887638;4888.437829649564;4888.804447822118;4897.510248975074;4919.877003074952;4303.956960430418;4362.541933097043;4416.712913660666;4439.800208990603;4461.196984542814;5798.449147330997;5819.243498345273;5821.301443826768;5827.475527202488;5857;6296.181496405438;6323.367663233732;6325.683715814191;6327.462165715966;6337.9683101585115;5412.3505179377935;5454.209139674725;5728.914066289009;5803.82588522345;5808;4594.862154135314;5368.91946620801;5369.275147855068;5378.058839703114;5387.4073851876265;6251.99968005117;6296.433321001132;6299.338569450233;6315.179026726496;6326.6836658165985;6191.442770150708;6232.065190221503;6301.905471417841;6317.96841015792;6330.52521060913;6331.145295385064;6340.397662222082;6353.904691429725;6354.618722876642;6384.712687929147;6236.251649801871;6249.0626406039455;6249.781257656142;6251.3123556407845;6264.060390941395;6159.784407545714;6221.06683997404;6249.1563638908165;6343.841403964938;6345.90481142774;6133.080037994337;6145.10895920098;6175.907361389673;6187.3503282154725;6189.5048396129105;6057.121717351048;6177.907331390123;6257.405546473078;6259.812205633838;6263.311035786151;5818.33089194748;5899.91150132757;5939.287285525765;6006.785867088552;6030.969845150747;6141.785037523665;6156.445919867234;6157.415045570664;6160.722767475385;6168.506519478341;5975.820725378246;6012.549058820693;6014.6391216527145;6043.972524670904;6049.304330002106 02:27:46 INFO - PROCESS | 1671 | |1;ext.html;524.1744252801833;529.7748456905814;582.9213056237406;666.3835951744635;670.098717225332;25603;32111.51832722511;32229.677703222933;39364;39694.8091557253;45124.54875451244;45493.090138197214;45773.54226457734;45856.3121553177;45864.54135458644;9747.512624368788;9973.052560006823;9974.301798874081;9975.251856110785;9986.850197247048;9687.467189304585;9772.120509154174;9828.705138845846;9833.360831545962;9854.01459854016;9736;9851.950740246324;9854.852177217312;9855.704328870146;9861.704148875546;9769.511524423786;9817.950910245403;9828.213742900622;9843.60625574976;9857.704268871945;9790.75523111928;9894.30739848211;9923.404595724207;9925.156361709263;9952.651657192037;42026;42266;42439;42461.363079553834;42677.786611066746;3518.4194607889667;3790.0918310787597;3904.1606054698377;3906.00396898789;3906.687465002793;29082.27294317659;29332.853335733398;29514.114576562737;29555.852220738972;29761;2673.31830383251;2690.865456727156;2714.4978179036743;2720.9591856122174;2743.931401714953;469301;469788;471203;473025;473975;70905.64547177231;71181.64409178024;71335.64332178306;71340.2865971344;71425.28574714187;73988.63005684938;77396.83904741434;79105;79152.60423697844;79216;18134.274629014693;18192.545186370447;18311.54221144482;18353;18356.08219589015;13829.03196776216;13907;13919.721605567833;13926.025178237629;13929.86070139306;22521.436964075703;22880;22884.65673014906;22935.426614334774;22965.540689186124;9436.669716559887;9626.66306679263;9641;9651.9034809651;9656;959.9952000239954;1006.9748256293504;1014.8832884218261;1109.7281166114353;1164.2781475485253;28933.71066289352;29017.12948611545;29124;29688.703112969026;29778.10665680033;1113.8607674040745;1119.1103073056938;1180.1620849196995;1209.2260952990093;1249.7562975219926;14168.291585420688;14196.432142714175;15756.76364854528;16847.9891206528;16851.41020064292;658276;666936;666947;667414;668400;64190.358096419375;64652;64858.675706621165;64889.351106489274;65255.67372163109;1396.9092009019382;1415.1625989890204;1508.5172744721583;1531.7472617018068;1540.645651500139;29709.5543566851;29856.402871942875;30016;30659.693403065685;30700.692993070676;49475;50133;50144.24783628321;50223.744406390135;50352.49647503478;384491;385396;386309;386367.81793092506;386752;33202.00393988184;35093.82453087718;35118.29763404666;35120;35135.64864351324;44803;45641.77179114083;47389.28916066193;47427.28859067186;48511.27233091436;36788;37500.62499374971;38329.6167038326;38782.80608596939;39442.802785985885;37401.064973375884;37719.434208486346;37775.433368500046;38388.61611383962;38470.80764596159;38079.04802379962;38888.416673750486;38903.80548097355;39017.609823901395;39269.821905342884;33076.842310519016;33593.99218023463;34379.14052148716;34438.48342274818;34440.65559344374;25314.240572782845;25390.492190156463;25618.359541011625;25772.226833195033;25885.09402170915 02:27:46 INFO - PROCESS | 1671 | |2;jquery.html;338.3166004670564;383.12264913348434;391.1609597413548;397.03916522016715;397.9005248687828;19080.23679052836;20282;20895.895520522394;21747.912604369798;21781.891090544526;11594.710132246699;12405.193662411937;12514.684783315093;12536.997040236782;12548;5263.921041184376;5586.385497595261;6116.969415152918;6131.3868613138775;6134.785282515113;6059.242594675666;6083.996140636812;6115.816525504242;6124.755009799603;6136.9079463808075;5835.35811060783;6126.050462178369;6127.908081378783;6131.294901086365;6144.539159563028;6022;6054.910116179086;6084.6349219047;6085.208922840025;6085.969570152165;5684.033714268584;5834.037383831663;5856.912146317809;5860.589758716891;5875.35371109182;14439.927800361036;14560.344784484723;19209;26665.333366665796;26724.931002759866;2145.10977944153;2146.0450099705636;2228.765979572138;2259.762724913877;2662.8668566571787;10409.271351005433;10564.418956957365;10707.917882720903;12948.741025179537;14580;1769.4956937272943;1851.4075495841337;1861.3392245752698;1862.7671541057368;1884.8125680820995;84517;86583.56708216481;97084.51457742666;105564.41653375205;108523.45738271337;11882.940585297018;12050.457729402198;12057.0957178212;12074.637760867188;12176.756464870654;14547.490837820626;14585.927070364793;14601.342939567745;14616.853831461762;14632.853671463148;9121.270298376114;9143.908560914306;9174.990751017383;9188.724338269729;9249.861252081224;9315.254779617615;9332.16010559053;9339.626414943326;9424.528773561295;9431.528423578793;3820.178661587772;4751;4766.855954570948;4783.23468245086;4797.832075877397;1956.5814784281283;1997.211101614854;2013.496625843539;2017.1225516899901;2055.1368425261126;932.8787257656597;977.5112443778111;978.6427953796955;1044.3577200021932;1102.7849569334064;20275.594488110157;21012.47468813292;21018.894905525376;21404.464888377915;21472.892635536722;990.9487361162325;992.4243938515643;1034.7413146713322;1039.3815679670583;1065.824139017069;10963.890361096286;11477;11496.827547586792;11510.02164816;11525.020373268366;655807;658002;663513;669621;676463;73031.26968730244;80893.59553202197;88581.67127493092;117684.41157794156;127786.36106819593;1012.9240306977006;1016.2733645443543;1041.859348987877;1042.4683411460057;1045.4997079191232;18229.361972330906;19059;19156.992551721476;19174.80825191786;19233.230670773013;39453.60546394614;52115;52176.47823521868;52230.738846305525;52747.47252527579;60573;71840;74318.62840685762;74740;75553.24446755461;8264.876026859722;8325.458845175044;8389.454685445426;8422.91577084246;8435.493870367798;9672.468014259002;13027.674308142372;13487.59537213846;13915.443382265;13916.304184790923;10636;11054.61817272841;11542.884571154182;12009.579664711693;12022.819657705317;9889.950550247202;11345.829812552653;11732.882671173178;11895.76208475843;12173.39133043362;11883.108766842348;11908.880911191123;12008.579699710817;12195.085368597569;12210.816837747263;8248.752537423887;8322.50064996102;8357.038940521918;8584.957075214834;8638.956805216185;8757.299416046573;9821.558029888814;11034.337939723642;11694.415279235835;12037.03703703684 02:27:46 INFO - PROCESS | 1671 | |3;mootools.html;1483.451123084459;1609.9839001609985;1631.314847763939;1969.5863868587596;2068.007356468895;8261.256486916176;8468.026176989648;8480.703175388862;8485.490870547765;8867.955660221689;8898.555072246378;8956.596953137108;9070.183683468487;9077.273818094553;9079.092090790917;2196.439907823503;2574.9485010299877;2579.21333993132;2585.31489155374;2586.780123689489;1961.9313324033662;2259.1189436119926;2260.7174103237094;2261.977380226201;2520.6345079963394;2280.464090938628;2524.0408644714985;2582.0704546363295;2584.914335978893;2588.0682954136496;2503.824732268742;2533.07542746897;2546.808989325799;2557.7698007179442;2564.705058918211;2490.8007359411386;2534.911278105276;2538.6953565572067;2541.644169816227;2560.142352311978;9099.363044586882;9184.494852783095;9211.401258918217;9214.308926830514;9328.766780830465;4817.879553011167;5750.971245143747;5761.279840019997;5762.164486149527;5763.991301522259;3702.0374702577524;3731.2350968051483;3807.067268519203;3809.866654667101;3811.7331786774935;932.4312169576552;1001.9849702254472;1034.6947650443062;1053.436411519841;1125.2123513540473;12490;12502.687432814162;12503.312317822516;12516.81224781629;12537.498500059986;4215.325547912381;5022.121128802445;5071.619628527875;5109.489051094861;5144.922826157535;10677.626283080055;10695.304805187638;10697.465126743631;10700.625478108384;10740.355578665305;5821.09772985188;5821.417858214145;5828.358880523139;5837.445442682938;5868.94131058684;5045.268436076748;5143.7428128594165;5184.092783762826;5190.844274671766;5206.609504287194;4184.958150418457;4196.187731535778;4201.411802347674;4233.195692818416;4235.512916014636;1184.2716729211472;1239.962801115968;1260.3950103950156;1292.6445227562308;1349.372541768063;1081.3674000709673;1093.3931667924378;1109.2567979453786;1175.694319476925;1363.6318194087542;8340.666373344999;8443.408961372768;8450.535220562806;8456.408051436463;8468.915310846813;1250.1061740855332;1250.1811313589612;1250.8061250506187;1274.350081458463;1289.8065290206544;6194.628322300677;6252.343503932113;6317.557770955989;6334;6334.3032266450655;9857.507124643738;10835.241533092609;11199.440027998568;11223.887761122447;11405.828912566318;11250.212485125963;11295.661130166109;11358.886411135783;11378.487968041458;11389.943050284695;8449.57752112392;8717.084706105768;8739.650413983496;8739.737807865775;8792.47245165292;8469.322454203771;8541.188587084218;8578.65685372578;8589.226969572768;8591;9403.34176607631;9574.760630984003;9966.40201587907;9966.800663986825;10132.544035518273;9922.454265015205;10071.949640251752;10097.495125243562;10179.898201018192;10245.948770256102;7783.688652453839;7885;7912.32745216663;7914;7930.920690793018;8265.256126948603;8474.491530508189;8478.109798471072;8514.957425212835;8537.274331681876;7756.910362933956;7836.882446763189;7867.9606601966625;7869.803254918673;7938.166492518433;7584.976028236118;7631.885521717068;7678.500897441649;7696.8460630788195;7714.807129821575;8109;8188.7952801180445;8198.057223419382;8208.302294304813;8210.507369557845;7083.114610673666;7332.120145582564;7418.814529636802;7429.257074292527;7430.851382972202;7375.483716139819;7446.776596702108;7453.142888567667;7454.739084132029;7470.103587569526 02:27:46 INFO - PROCESS | 1671 | |4;prototype.html;287.7784106238196;335.39126485428943;340.7580617761389;341.28330505937527;342.91941393772476;6584.934150658492;6590;6648.1025061616665;6690.832729181773;6691.4312283455965;6596.604203747766;6607.306232845542;6614.338566143383;6617.834554136149;6619.271880093186;4760.880977975561;4798.808047678106;4870.805167793284;4910.698664853817;4987.75061246938;3951.5455722591837;4875.341828853113;4894.755262236892;4906.092372911005;4916.1642520771375;4860.829870954517;4907.5583197512215;4915.213565829468;4915.975420122894;4929.679570827885;4688.648351373644;4761.952380476186;4855.36880205571;4874.731889746063;4883.829065982709;3444.8794292199905;4191.1827193697245;4191.203671302443;4197.887559796656;4201.2017716633745;5978.8505287367725;6227.906581401283;6303.905441418382;6337;6360.109584658151;5088.92366614501;5542.251796007568;5790.189373487715;5804.564657650693;5819.79630712923;5622.775088996476;6909.067275917737;6986.61573613451;6988.580685158907;7001.719931202746;4597.080583883237;4767.904641907143;4768.260919557474;4774;4774.498677638868;6155.292141403751;7455.776326710262;7465.552066876005;7481.102267727853;7495.812604684872;3977.2840888639744;4840.419149702058;4868;4873.9025219496125;4880.097182021337;4931.3835770528685;4940.752962351868;4946.431160416526;4953.702777833341;4962.379702537183;5819.854503637443;5827.155062515996;5832.154337621021;5833.795817146464;5833.854153646193;5389.407165211824;5683.77264909399;7081.681324340417;7083.574985500886;7088.751893683696;1450.2676148545129;1584.1128967778081;1691.5855615374066;1726.0592976827659;1726.5252055684787;1063.3460421840666;1095.2935356694886;1116.542217690743;1119.776044791045;1141.3893566941647;6471.838204044937;6532.444742196966;6532.640704761284;6543.247526534415;6555.475561955032;7222.061132052904;7225.1329840419485;7227.16887557927;7232.710691572278;7251.347378735939;6345.4770854995395;6511.153550038464;6511.316311787289;6511.511636627272;6532.640704761284;3192.9042128736173;3716.7612201568036;3832.4442955771256;3834.7123965702126;3843.481130047464;7226.385757210696;7414.443916706268;7531.058617672791;7538.623068846536;7540.849183016309;5622.353429355677;6332.303446620868;7142.107236595426;7455.4408419368765;7462.365698915653;7527.397808175333;7527.510711803715;7539.434542409451;7551.886721699179;7552.131504877009;6922.992332223599;7188.892166617609;7212.537981768885;7214.386777124003;7217.133943926762;7064.152301723826;7081.327273908971;7083.82290442743;7097.609631470319;7102.254263302279;7417.629118544159;7499.62501874915;7504.812379690551;7512.962435187789;7518.511296765692;4864.270359446112;4873.220284754422;4873.878153046202;4877.487863774252;4881.829135980223;6928.792136235921;7163.31948464895;7169.103862017248;7170.103737032871;7199.604021778852;6912.585244885323;6934.653267336714;6945.652717364011;6949.65251737401;6960.8955865663065;6849.1096157499205;6931.930680693128;6934.618595977269;6935.653217339012;6953.548019378724;6738.66306684654;6739.528233023641;6741.056252124608;6746.325367463214;6757.358050985148;6706.429953454011;6908.723651053901;6917.7232910685025;6931.341522555349;6936.0636314098965;5491.917621235605;5611.719414029364;6628.900566491603;6806.251312355538;6947.5831450113155 02:27:46 INFO - PROCESS | 1671 | |5;yui.html;628.1939424155553;715.5384776818951;718.8490417012428;740.9147947985983;755.4938191411753;14756.704865902675;15007;15311.84688153118;15320.923395383008;15358.846411535882;14189.92905035476;14274.357653905574;14285.78571321431;14299.428022879098;14299.92850035751;788.45202584204;797.4776521378507;962.7015625156189;969.5249327829383;992.7937555869617;980.901909809017;982.832918403873;984.566790612132;986.0189111833736;986.634945070325;1031.520343040486;1035.616821775944;1036.176239889286;1036.4144258493927;1038.4184856480358;831.4637059096879;1022.5500779656927;1047.3715770537692;1048.8951104889527;1052.7683909539928;774.500447211551;775.166695802015;776.7009701265054;777.1063277231173;782.5774081995772;14910.850891491054;14950.551483455514;14963.177025263607;15297.388104475918;15347.00244484105;12402.441890114966;12415.44130514129;12572.497100115985;12774.61676149717;12793;10082.445465499395;10098.9495052525;10215;10276.383416995004;10302.845457318146;3382.5602671652773;3411.1131105912395;3558.7864728116397;3569.678728914384;3569.7679650822615;78712.60643696744;79329.60335198288;85489.71765423461;90232.5488372554;91822.5408872958;9626.90373096274;9632.807343853083;9698.175655069257;9755.512224388895;9879.407235565888;21961.90190490469;22000.669989950162;22038.669419958715;22362.776372236396;22635.88682056612;7672.578008209491;7682.807929801688;7765;7913.762587122395;8018.438709290293;3902.414637804295;4126.628603425706;4181.790910454465;4224.978875105605;4415.4259946206785;3211.951820722691;3718.5537735471917;3756.7182461314965;3763.6424539668687;3767.7927713975996;603.3574243430733;659.9274079851212;685.4173952140641;711.2283172757512;736.4439847914897;577.4600748300353;595.9135925290808;597.3429227849331;613.9386061393914;620.7765204526366;8016.759497214976;8225.506469611842;8335.749927502186;8343.582820858932;8510.78723031929;535.2052202479315;582.979595714148;599.0834023943373;626.1328060636051;628.6887990444759;3886.2227554489214;3924.843006279717;4055.087605288845;4060.4721386219603;4080.777233873747;82808.58595706982;83895;84078;84182.15817841866;88242.55878720565;85901.28197436016;86299.13700862911;86837.13162868416;87175.1282487167;87184.1281587176;74035.62982185162;74326.6283668589;74335.62832185805;74386.25613743793;75449;7417.703291868264;7684.577348245676;7807.9849619549095;7880.960595196987;8107.22981316774;50704.746476267384;51129;51409.74295128501;51596.22605660843;51599.484005159466;50021.749891250314;69298.65350673214;69395.65302173457;70167.59664806574;70554.29445705477;11155;11219.046381057375;11410.771784564427;11418;11587.652370428901;11708.648740537797;12090.395480226129;12351.320677362832;12410.441530130985;12427.005839532634;11693.88306116928;11721.593408791;11785.233959792586;11894.762104757683;12036.879631203576;11493.54025838957;11586.246893951866;11761.529538818351;12106.213096148722;12467.93766031164;11114.666560003212;11427.314361138358;11501.769964600828;11513.424328783694;11730.002949749367;9454.335271636342;9564.856527151958;9709.465979371202;9877.901220987986;10083.193344532567;9639.71080867575;9708.22334213247;9778.706638800562;9891;9899.307048506535 02:27:46 INFO - PROCESS | 1671 | __end_tp_report 02:27:46 INFO - PROCESS | 1671 | __start_cc_report 02:27:46 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,1039 02:27:46 INFO - PROCESS | 1671 | __end_cc_report 02:27:46 INFO - PROCESS | 1671 | __startTimestamp1457432866080__endTimestamp 02:27:46 INFO - PROCESS | 1671 | 02:27:46 INFO - PROCESS | 1671 | ------- Summary: start ------- 02:27:46 INFO - PROCESS | 1671 | Number of tests: 6 02:27:46 INFO - PROCESS | 1671 | 02:27:46 INFO - PROCESS | 1671 | [#0] dojo.html Cycles:165 Average:5741.65 Median:6006.79 stddev:640.52 (10.7%) stddev-sans-first:616.78 02:27:46 INFO - PROCESS | 1671 | Values: 3451.6 3496.8 3534.0 3539.5 3560.8 5736.1 5746.8 5778.9 5783.2 5796.9 5731.5 5775.1 5776.7 5788.3 5805.5 5134.0 5172.2 5185.6 5199.1 5299.7 5266.6 5276.9 5277.5 5285.7 5293.6 5224.9 5266.3 5272.7 5282.4 5290.3 5285.8 5293.0 5305.1 5319.1 5323.6 5028.7 5221.2 5227.5 5234.2 5244.4 5644.0 5646.3 5648.9 5667.8 5668.0 5168.6 5278.6 6071.9 6199.6 6225.1 6156.4 6168.3 6215.3 6263.3 6269.5 4734.0 5602.5 5606.2 5607.7 5632.5 6190.8 6216.0 6220.7 6225.5 6239.0 6177.5 6180.5 6191.0 6195.9 6206.0 6243.6 6265.2 6270.4 6271.1 6282.4 5251.8 6024.4 6116.6 6172.9 6216.1 6172.2 6207.6 6232.1 6243.7 6249.7 4882.8 4888.4 4888.8 4897.5 4919.9 4304.0 4362.5 4416.7 4439.8 4461.2 5798.4 5819.2 5821.3 5827.5 5857.0 6296.2 6323.4 6325.7 6327.5 6338.0 5412.4 5454.2 5728.9 5803.8 5808.0 4594.9 5368.9 5369.3 5378.1 5387.4 6252.0 6296.4 6299.3 6315.2 6326.7 6191.4 6232.1 6301.9 6318.0 6330.5 6331.1 6340.4 6353.9 6354.6 6384.7 6236.3 6249.1 6249.8 6251.3 6264.1 6159.8 6221.1 6249.2 6343.8 6345.9 6133.1 6145.1 6175.9 6187.4 6189.5 6057.1 6177.9 6257.4 6259.8 6263.3 5818.3 5899.9 5939.3 6006.8 6031.0 6141.8 6156.4 6157.4 6160.7 6168.5 5975.8 6012.5 6014.6 6044.0 6049.3 02:27:46 INFO - PROCESS | 1671 | 02:27:46 INFO - PROCESS | 1671 | [#1] ext.html Cycles:180 Average:66494.26 Median:38960.71 stddev:139035.66 (356.9%) stddev-sans-first:139337.46 02:27:46 INFO - PROCESS | 1671 | Values: 524.2 529.8 582.9 666.4 670.1 25603.0 32111.5 32229.7 39364.0 39694.8 45124.5 45493.1 45773.5 45856.3 45864.5 9747.5 9973.1 9974.3 9975.3 9986.9 9687.5 9772.1 9828.7 9833.4 9854.0 9736.0 9852.0 9854.9 9855.7 9861.7 9769.5 9818.0 9828.2 9843.6 9857.7 9790.8 9894.3 9923.4 9925.2 9952.7 42026.0 42266.0 42439.0 42461.4 42677.8 3518.4 3790.1 3904.2 3906.0 3906.7 29082.3 29332.9 29514.1 29555.9 29761.0 2673.3 2690.9 2714.5 2721.0 2743.9 469301.0 469788.0 471203.0 473025.0 473975.0 70905.6 71181.6 71335.6 71340.3 71425.3 73988.6 77396.8 79105.0 79152.6 79216.0 18134.3 18192.5 18311.5 18353.0 18356.1 13829.0 13907.0 13919.7 13926.0 13929.9 22521.4 22880.0 22884.7 22935.4 22965.5 9436.7 9626.7 9641.0 9651.9 9656.0 960.0 1007.0 1014.9 1109.7 1164.3 28933.7 29017.1 29124.0 29688.7 29778.1 1113.9 1119.1 1180.2 1209.2 1249.8 14168.3 14196.4 15756.8 16848.0 16851.4 658276.0 666936.0 666947.0 667414.0 668400.0 64190.4 64652.0 64858.7 64889.4 65255.7 1396.9 1415.2 1508.5 1531.7 1540.6 29709.6 29856.4 30016.0 30659.7 30700.7 49475.0 50133.0 50144.2 50223.7 50352.5 384491.0 385396.0 386309.0 386367.8 386752.0 33202.0 35093.8 35118.3 35120.0 35135.6 44803.0 45641.8 47389.3 47427.3 48511.3 36788.0 37500.6 38329.6 38782.8 39442.8 37401.1 37719.4 37775.4 38388.6 38470.8 38079.0 38888.4 38903.8 39017.6 39269.8 33076.8 33594.0 34379.1 34438.5 34440.7 25314.2 25390.5 25618.4 25772.2 25885.1 02:27:46 INFO - PROCESS | 1671 | 02:27:46 INFO - PROCESS | 1671 | [#2] jquery.html Cycles:180 Average:35026.92 Median:2244.26 stddev:109388.65 (4874.1%) stddev-sans-first:109664.51 02:27:46 INFO - PROCESS | 1671 | Values: 338.3 383.1 391.2 397.0 397.9 19080.2 20282.0 20895.9 21747.9 21781.9 11594.7 12405.2 12514.7 12537.0 12548.0 5263.9 5586.4 6117.0 6131.4 6134.8 6059.2 6084.0 6115.8 6124.8 6136.9 5835.4 6126.1 6127.9 6131.3 6144.5 6022.0 6054.9 6084.6 6085.2 6086.0 5684.0 5834.0 5856.9 5860.6 5875.4 14439.9 14560.3 19209.0 26665.3 26724.9 2145.1 2146.0 2228.8 2259.8 2662.9 10409.3 10564.4 10707.9 12948.7 14580.0 1769.5 1851.4 1861.3 1862.8 1884.8 84517.0 86583.6 97084.5 105564.4 108523.5 11882.9 12050.5 12057.1 12074.6 12176.8 14547.5 14585.9 14601.3 14616.9 14632.9 9121.3 9143.9 9175.0 9188.7 9249.9 9315.3 9332.2 9339.6 9424.5 9431.5 3820.2 4751.0 4766.9 4783.2 4797.8 1956.6 1997.2 2013.5 2017.1 2055.1 932.9 977.5 978.6 1044.4 1102.8 20275.6 21012.5 21018.9 21404.5 21472.9 990.9 992.4 1034.7 1039.4 1065.8 10963.9 11477.0 11496.8 11510.0 11525.0 655807.0 658002.0 663513.0 669621.0 676463.0 73031.3 80893.6 88581.7 117684.4 127786.4 1012.9 1016.3 1041.9 1042.5 1045.5 18229.4 19059.0 19157.0 19174.8 19233.2 39453.6 52115.0 52176.5 52230.7 52747.5 60573.0 71840.0 74318.6 74740.0 75553.2 8264.9 8325.5 8389.5 8422.9 8435.5 9672.5 13027.7 13487.6 13915.4 13916.3 10636.0 11054.6 11542.9 12009.6 12022.8 9890.0 11345.8 11732.9 11895.8 12173.4 11883.1 11908.9 12008.6 12195.1 12210.8 8248.8 8322.5 8357.0 8585.0 8639.0 8757.3 9821.6 11034.3 11694.4 12037.0 02:27:46 INFO - PROCESS | 1671 | 02:27:46 INFO - PROCESS | 1671 | [#3] mootools.html Cycles:180 Average:6309.78 Median:5164.51 stddev:3339.82 (64.7%) stddev-sans-first:3329.48 02:27:46 INFO - PROCESS | 1671 | Values: 1483.5 1610.0 1631.3 1969.6 2068.0 8261.3 8468.0 8480.7 8485.5 8868.0 8898.6 8956.6 9070.2 9077.3 9079.1 2196.4 2574.9 2579.2 2585.3 2586.8 1961.9 2259.1 2260.7 2262.0 2520.6 2280.5 2524.0 2582.1 2584.9 2588.1 2503.8 2533.1 2546.8 2557.8 2564.7 2490.8 2534.9 2538.7 2541.6 2560.1 9099.4 9184.5 9211.4 9214.3 9328.8 4817.9 5751.0 5761.3 5762.2 5764.0 3702.0 3731.2 3807.1 3809.9 3811.7 932.4 1002.0 1034.7 1053.4 1125.2 12490.0 12502.7 12503.3 12516.8 12537.5 4215.3 5022.1 5071.6 5109.5 5144.9 10677.6 10695.3 10697.5 10700.6 10740.4 5821.1 5821.4 5828.4 5837.4 5868.9 5045.3 5143.7 5184.1 5190.8 5206.6 4185.0 4196.2 4201.4 4233.2 4235.5 1184.3 1240.0 1260.4 1292.6 1349.4 1081.4 1093.4 1109.3 1175.7 1363.6 8340.7 8443.4 8450.5 8456.4 8468.9 1250.1 1250.2 1250.8 1274.4 1289.8 6194.6 6252.3 6317.6 6334.0 6334.3 9857.5 10835.2 11199.4 11223.9 11405.8 11250.2 11295.7 11358.9 11378.5 11389.9 8449.6 8717.1 8739.7 8739.7 8792.5 8469.3 8541.2 8578.7 8589.2 8591.0 9403.3 9574.8 9966.4 9966.8 10132.5 9922.5 10071.9 10097.5 10179.9 10245.9 7783.7 7885.0 7912.3 7914.0 7930.9 8265.3 8474.5 8478.1 8515.0 8537.3 7756.9 7836.9 7868.0 7869.8 7938.2 7585.0 7631.9 7678.5 7696.8 7714.8 8109.0 8188.8 8198.1 8208.3 8210.5 7083.1 7332.1 7418.8 7429.3 7430.9 7375.5 7446.8 7453.1 7454.7 7470.1 02:27:46 INFO - PROCESS | 1671 | 02:27:46 INFO - PROCESS | 1671 | [#4] prototype.html Cycles:180 Average:5703.40 Median:6511.23 stddev:1788.89 (27.5%) stddev-sans-first:1747.11 02:27:46 INFO - PROCESS | 1671 | Values: 287.8 335.4 340.8 341.3 342.9 6584.9 6590.0 6648.1 6690.8 6691.4 6596.6 6607.3 6614.3 6617.8 6619.3 4760.9 4798.8 4870.8 4910.7 4987.8 3951.5 4875.3 4894.8 4906.1 4916.2 4860.8 4907.6 4915.2 4916.0 4929.7 4688.6 4762.0 4855.4 4874.7 4883.8 3444.9 4191.2 4191.2 4197.9 4201.2 5978.9 6227.9 6303.9 6337.0 6360.1 5088.9 5542.3 5790.2 5804.6 5819.8 5622.8 6909.1 6986.6 6988.6 7001.7 4597.1 4767.9 4768.3 4774.0 4774.5 6155.3 7455.8 7465.6 7481.1 7495.8 3977.3 4840.4 4868.0 4873.9 4880.1 4931.4 4940.8 4946.4 4953.7 4962.4 5819.9 5827.2 5832.2 5833.8 5833.9 5389.4 5683.8 7081.7 7083.6 7088.8 1450.3 1584.1 1691.6 1726.1 1726.5 1063.3 1095.3 1116.5 1119.8 1141.4 6471.8 6532.4 6532.6 6543.2 6555.5 7222.1 7225.1 7227.2 7232.7 7251.3 6345.5 6511.2 6511.3 6511.5 6532.6 3192.9 3716.8 3832.4 3834.7 3843.5 7226.4 7414.4 7531.1 7538.6 7540.8 5622.4 6332.3 7142.1 7455.4 7462.4 7527.4 7527.5 7539.4 7551.9 7552.1 6923.0 7188.9 7212.5 7214.4 7217.1 7064.2 7081.3 7083.8 7097.6 7102.3 7417.6 7499.6 7504.8 7513.0 7518.5 4864.3 4873.2 4873.9 4877.5 4881.8 6928.8 7163.3 7169.1 7170.1 7199.6 6912.6 6934.7 6945.7 6949.7 6960.9 6849.1 6931.9 6934.6 6935.7 6953.5 6738.7 6739.5 6741.1 6746.3 6757.4 6706.4 6908.7 6917.7 6931.3 6936.1 5491.9 5611.7 6628.9 6806.3 6947.6 02:27:46 INFO - PROCESS | 1671 | 02:27:46 INFO - PROCESS | 1671 | [#5] yui.html Cycles:180 Average:18668.36 Median:26067.34 stddev:26236.39 (100.6%) stddev-sans-first:26275.02 02:27:46 INFO - PROCESS | 1671 | Values: 628.2 715.5 718.8 740.9 755.5 14756.7 15007.0 15311.8 15320.9 15358.8 14189.9 14274.4 14285.8 14299.4 14299.9 788.5 797.5 962.7 969.5 992.8 980.9 982.8 984.6 986.0 986.6 1031.5 1035.6 1036.2 1036.4 1038.4 831.5 1022.6 1047.4 1048.9 1052.8 774.5 775.2 776.7 777.1 782.6 14910.9 14950.6 14963.2 15297.4 15347.0 12402.4 12415.4 12572.5 12774.6 12793.0 10082.4 10098.9 10215.0 10276.4 10302.8 3382.6 3411.1 3558.8 3569.7 3569.8 78712.6 79329.6 85489.7 90232.5 91822.5 9626.9 9632.8 9698.2 9755.5 9879.4 21961.9 22000.7 22038.7 22362.8 22635.9 7672.6 7682.8 7765.0 7913.8 8018.4 3902.4 4126.6 4181.8 4225.0 4415.4 3212.0 3718.6 3756.7 3763.6 3767.8 603.4 659.9 685.4 711.2 736.4 577.5 595.9 597.3 613.9 620.8 8016.8 8225.5 8335.7 8343.6 8510.8 535.2 583.0 599.1 626.1 628.7 3886.2 3924.8 4055.1 4060.5 4080.8 82808.6 83895.0 84078.0 84182.2 88242.6 85901.3 86299.1 86837.1 87175.1 87184.1 74035.6 74326.6 74335.6 74386.3 75449.0 7417.7 7684.6 7808.0 7881.0 8107.2 50704.7 51129.0 51409.7 51596.2 51599.5 50021.7 69298.7 69395.7 70167.6 70554.3 11155.0 11219.0 11410.8 11418.0 11587.7 11708.6 12090.4 12351.3 12410.4 12427.0 11693.9 11721.6 11785.2 11894.8 12036.9 11493.5 11586.2 11761.5 12106.2 12467.9 11114.7 11427.3 11501.8 11513.4 11730.0 9454.3 9564.9 9709.5 9877.9 10083.2 9639.7 9708.2 9778.7 9891.0 9899.3 02:27:46 INFO - PROCESS | 1671 | -------- Summary: end -------- 02:27:46 INFO - PROCESS | 1671 | 02:27:46 INFO - TEST-INFO | 1671: exit 0 02:27:46 INFO - TEST-OK | dromaeo_css | took 1112422ms 02:27:46 INFO - TEST-START | kraken 02:27:46 INFO - operating with platform_type : mac_ 02:27:46 INFO - Initialising browser for kraken test... 02:27:46 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/tmpqLVWjC/profile http://localhost:49276/getInfo.html) 02:27:48 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 02:27:48 INFO - PROCESS | 1676 | colorDepth:24 02:27:48 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 02:27:48 INFO - PROCESS | 1676 | __metrics 02:27:48 INFO - PROCESS | 1676 | 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:27:48 INFO - PROCESS | 1676 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:27:49 INFO - TEST-INFO | 1676: exit 0 02:27:49 INFO - Browser initialized. 02:27:49 INFO - Running cycle 1/1 for kraken test... 02:27:49 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/tmpqLVWjC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:28:01 INFO - PROCESS | 1679 | RSS: Main: 210575360 02:28:01 INFO - PROCESS | 1679 | 02:28:03 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 02:28:04 INFO - PROCESS | 1679 | RSS: Main: 264654848 02:28:04 INFO - PROCESS | 1679 | 02:28:06 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 02:28:07 INFO - PROCESS | 1679 | RSS: Main: 275738624 02:28:07 INFO - PROCESS | 1679 | 02:28:10 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 02:28:11 INFO - PROCESS | 1679 | RSS: Main: 264769536 02:28:11 INFO - PROCESS | 1679 | 02:28:13 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 02:28:13 INFO - PROCESS | 1679 | RSS: Main: 267345920 02:28:13 INFO - PROCESS | 1679 | 02:28:15 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:28:16 INFO - PROCESS | 1679 | RSS: Main: 268632064 02:28:16 INFO - PROCESS | 1679 | 02:28:19 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 02:28:19 INFO - PROCESS | 1679 | RSS: Main: 268783616 02:28:19 INFO - PROCESS | 1679 | 02:28:22 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 02:28:23 INFO - PROCESS | 1679 | RSS: Main: 268181504 02:28:23 INFO - PROCESS | 1679 | 02:28:25 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 02:28:26 INFO - PROCESS | 1679 | RSS: Main: 267390976 02:28:26 INFO - PROCESS | 1679 | 02:28:28 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:28:28 INFO - PROCESS | 1679 | RSS: Main: 300380160 02:28:28 INFO - PROCESS | 1679 | 02:28:30 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:28:31 INFO - PROCESS | 1679 | RSS: Main: 300789760 02:28:31 INFO - PROCESS | 1679 | 02:28:33 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:28:33 INFO - PROCESS | 1679 | RSS: Main: 306438144 02:28:33 INFO - PROCESS | 1679 | 02:28:36 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:28:36 INFO - PROCESS | 1679 | RSS: Main: 309276672 02:28:36 INFO - PROCESS | 1679 | 02:28:39 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:28:40 INFO - PROCESS | 1679 | RSS: Main: 308486144 02:28:40 INFO - PROCESS | 1679 | 02:28:41 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 02:28:42 INFO - PROCESS | 1679 | RSS: Main: 368664576 02:28:42 INFO - PROCESS | 1679 | 02:28:42 INFO - PROCESS | 1679 | __start_tp_report 02:28:42 INFO - PROCESS | 1679 | _x_x_mozilla_page_load 02:28:42 INFO - PROCESS | 1679 | _x_x_mozilla_page_load_details 02:28:42 INFO - PROCESS | 1679 | |i|pagename|runs| 02:28:42 INFO - PROCESS | 1679 | |0;ai-astar;111;111;111;110;112;112;117;112;112;111 02:28:42 INFO - PROCESS | 1679 | |1;audio-beat-detection;154;118;154;143;119;137;118;149;147;116 02:28:42 INFO - PROCESS | 1679 | |2;audio-dft;188;183;187;187;186;186;183;186;187;185 02:28:42 INFO - PROCESS | 1679 | |3;audio-fft;75;75;72;113;56;57;57;59;114;56 02:28:42 INFO - PROCESS | 1679 | |4;audio-oscillator;90;95;132;79;77;83;115;76;78;117 02:28:42 INFO - PROCESS | 1679 | |5;imaging-gaussian-blur;88;84;88;86;88;86;126;86;88;84 02:28:42 INFO - PROCESS | 1679 | |6;imaging-darkroom;92;93;92;94;94;93;92;122;106;93 02:28:42 INFO - PROCESS | 1679 | |7;imaging-desaturate;84;87;87;86;87;87;85;86;87;84 02:28:42 INFO - PROCESS | 1679 | |8;json-parse-financial;55;57;57;57;57;57;57;68;51;51 02:28:42 INFO - PROCESS | 1679 | |9;json-stringify-tinderbox;62;62;68;76;71;68;64;64;65;71 02:28:42 INFO - PROCESS | 1679 | |10;stanford-crypto-aes;80;94;103;80;81;79;80;80;81;85 02:28:42 INFO - PROCESS | 1679 | |11;stanford-crypto-ccm;122;125;105;126;124;126;125;119;123;113 02:28:42 INFO - PROCESS | 1679 | |12;stanford-crypto-pbkdf2;131;148;132;133;148;167;153;134;157;134 02:28:42 INFO - PROCESS | 1679 | |13;stanford-crypto-sha256-iterative;66;65;66;66;66;66;66;66;65;65 02:28:42 INFO - PROCESS | 1679 | __end_tp_report 02:28:42 INFO - PROCESS | 1679 | __start_cc_report 02:28:42 INFO - PROCESS | 1679 | _x_x_mozilla_cycle_collect,1205 02:28:42 INFO - PROCESS | 1679 | __end_cc_report 02:28:42 INFO - PROCESS | 1679 | __startTimestamp1457432922076__endTimestamp 02:28:42 INFO - PROCESS | 1679 | 02:28:42 INFO - PROCESS | 1679 | ------- Summary: start ------- 02:28:42 INFO - PROCESS | 1679 | Number of tests: 14 02:28:42 INFO - PROCESS | 1679 | 02:28:42 INFO - PROCESS | 1679 | [#0] ai-astar Cycles:10 Average:111.90 Median:112.00 stddev:1.91 (1.7%) stddev-sans-first:2.00 02:28:42 INFO - PROCESS | 1679 | Values: 111.0 111.0 111.0 110.0 112.0 112.0 117.0 112.0 112.0 111.0 02:28:42 INFO - PROCESS | 1679 | 02:28:42 INFO - PROCESS | 1679 | [#1] audio-beat-detection Cycles:10 Average:135.50 Median:145.00 stddev:16.06 (11.1%) stddev-sans-first:15.58 02:28:42 INFO - PROCESS | 1679 | Values: 154.0 118.0 154.0 143.0 119.0 137.0 118.0 149.0 147.0 116.0 02:28:42 INFO - PROCESS | 1679 | 02:28:42 INFO - PROCESS | 1679 | [#2] audio-dft Cycles:10 Average:185.80 Median:186.50 stddev:1.69 (0.9%) stddev-sans-first:1.59 02:28:42 INFO - PROCESS | 1679 | Values: 188.0 183.0 187.0 187.0 186.0 186.0 183.0 186.0 187.0 185.0 02:28:42 INFO - PROCESS | 1679 | 02:28:42 INFO - PROCESS | 1679 | [#3] audio-fft Cycles:10 Average:73.40 Median:58.00 stddev:22.54 (38.9%) stddev-sans-first:23.90 02:28:42 INFO - PROCESS | 1679 | Values: 75.0 75.0 72.0 113.0 56.0 57.0 57.0 59.0 114.0 56.0 02:28:42 INFO - PROCESS | 1679 | 02:28:42 INFO - PROCESS | 1679 | [#4] audio-oscillator Cycles:10 Average:94.20 Median:78.50 stddev:20.13 (25.6%) stddev-sans-first:21.29 02:28:42 INFO - PROCESS | 1679 | Values: 90.0 95.0 132.0 79.0 77.0 83.0 115.0 76.0 78.0 117.0 02:28:42 INFO - PROCESS | 1679 | 02:28:42 INFO - PROCESS | 1679 | [#5] imaging-gaussian-blur Cycles:10 Average:90.40 Median:87.00 stddev:12.61 (14.5%) stddev-sans-first:13.34 02:28:42 INFO - PROCESS | 1679 | Values: 88.0 84.0 88.0 86.0 88.0 86.0 126.0 86.0 88.0 84.0 02:28:42 INFO - PROCESS | 1679 | 02:28:42 INFO - PROCESS | 1679 | [#6] imaging-darkroom Cycles:10 Average:97.10 Median:93.00 stddev:9.70 (10.4%) stddev-sans-first:10.11 02:28:42 INFO - PROCESS | 1679 | Values: 92.0 93.0 92.0 94.0 94.0 93.0 92.0 122.0 106.0 93.0 02:28:42 INFO - PROCESS | 1679 | 02:28:42 INFO - PROCESS | 1679 | [#7] imaging-desaturate Cycles:10 Average:86.00 Median:87.00 stddev:1.25 (1.4%) stddev-sans-first:1.09 02:28:42 INFO - PROCESS | 1679 | Values: 84.0 87.0 87.0 86.0 87.0 87.0 85.0 86.0 87.0 84.0 02:28:42 INFO - PROCESS | 1679 | 02:28:42 INFO - PROCESS | 1679 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:57.00 stddev:4.67 (8.2%) stddev-sans-first:4.91 02:28:42 INFO - PROCESS | 1679 | Values: 55.0 57.0 57.0 57.0 57.0 57.0 57.0 68.0 51.0 51.0 02:28:42 INFO - PROCESS | 1679 | 02:28:42 INFO - PROCESS | 1679 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:68.00 stddev:4.56 (6.7%) stddev-sans-first:4.44 02:28:42 INFO - PROCESS | 1679 | Values: 62.0 62.0 68.0 76.0 71.0 68.0 64.0 64.0 65.0 71.0 02:28:42 INFO - PROCESS | 1679 | 02:28:42 INFO - PROCESS | 1679 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:80.50 stddev:7.94 (9.9%) stddev-sans-first:8.27 02:28:42 INFO - PROCESS | 1679 | Values: 80.0 94.0 103.0 80.0 81.0 79.0 80.0 80.0 81.0 85.0 02:28:42 INFO - PROCESS | 1679 | 02:28:42 INFO - PROCESS | 1679 | [#11] stanford-crypto-ccm Cycles:10 Average:120.80 Median:124.50 stddev:6.83 (5.5%) stddev-sans-first:7.23 02:28:42 INFO - PROCESS | 1679 | Values: 122.0 125.0 105.0 126.0 124.0 126.0 125.0 119.0 123.0 113.0 02:28:42 INFO - PROCESS | 1679 | 02:28:42 INFO - PROCESS | 1679 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.70 Median:148.00 stddev:12.67 (8.6%) stddev-sans-first:12.57 02:28:42 INFO - PROCESS | 1679 | Values: 131.0 148.0 132.0 133.0 148.0 167.0 153.0 134.0 157.0 134.0 02:28:42 INFO - PROCESS | 1679 | 02:28:42 INFO - PROCESS | 1679 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:66.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 02:28:42 INFO - PROCESS | 1679 | Values: 66.0 65.0 66.0 66.0 66.0 66.0 66.0 66.0 65.0 65.0 02:28:42 INFO - PROCESS | 1679 | -------- Summary: end -------- 02:28:42 INFO - PROCESS | 1679 | 02:28:42 INFO - TEST-INFO | 1679: exit 0 02:28:42 INFO - TEST-OK | kraken | took 56434ms 02:28:42 INFO - SUITE-END | took 1168s 02:28:43 INFO - Completed test suite (00:19:29) 02:28:43 INFO - javascript benchmark 02:28:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3451.5512983312165, 3496.842642081106, 3533.9646603533956, 3539.5044693742866, 3560.821958902054, 5736.139579063142, 5746.827595172146, 5778.942210577893, 5783.161441590967, 5796.884062318756, 5731.512821410175, 5775.133729940511, 5776.682282474462, 5788.27646544182, 5805.535557155428, 5133.974330128344, 5172.19830926207, 5185.611079169059, 5199.09015922214, 5299.735013249341, 5266.605004624649, 5276.947230527684, 5277.498637629438, 5285.709285989269, 5293.6294459387855, 5224.8693782655355, 5266.262723218752, 5272.6836389816735, 5282.418933917266, 5290.285811415448, 5285.841424757264, 5292.973535132338, 5305.098133317345, 5319.122344813101, 5323.574114070865, 5028.673136246169, 5221.242919776649, 5227.503387178212, 5234.16253399458, 5244.370675518962, 5643.984082865082, 5646.26598542191, 5648.943510564883, 5667.773289068432, 5667.971660141673, 5168.586513078944, 5278.630495865253, 6071.865557969369, 6199.597026193328, 6225.128482012522, 6156.3843615638525, 6168.290646575656, 6215.2541694996435, 6263.342349053375, 6269.529785266078, 4733.952660473386, 5602.467765562265, 5606.159076138611, 5607.719614019283, 5632.549396048306, 6190.81427557174, 6216.0, 6220.688965551704, 6225.501959843202, 6239.0, 6177.505799536027, 6180.47465965389, 6191.0, 6195.938040619536, 6205.968970155121, 6243.625382476975, 6265.154204182468, 6270.372962703785, 6271.059341098871, 6282.403171698681, 5251.842444726664, 6024.427679370453, 6116.579253789288, 6172.8765424691255, 6216.129741836146, 6172.197614310111, 6207.596506227081, 6232.0963460298, 6243.719032643542, 6249.6562689051625, 4882.780274887638, 4888.437829649564, 4888.804447822118, 4897.510248975074, 4919.877003074952, 4303.956960430418, 4362.541933097043, 4416.712913660666, 4439.800208990603, 4461.196984542814, 5798.449147330997, 5819.243498345273, 5821.301443826768, 5827.475527202488, 5857.0, 6296.181496405438, 6323.367663233732, 6325.683715814191, 6327.462165715966, 6337.9683101585115, 5412.3505179377935, 5454.209139674725, 5728.914066289009, 5803.82588522345, 5808.0, 4594.862154135314, 5368.91946620801, 5369.275147855068, 5378.058839703114, 5387.4073851876265, 6251.99968005117, 6296.433321001132, 6299.338569450233, 6315.179026726496, 6326.6836658165985, 6191.442770150708, 6232.065190221503, 6301.905471417841, 6317.96841015792, 6330.52521060913, 6331.145295385064, 6340.397662222082, 6353.904691429725, 6354.618722876642, 6384.712687929147, 6236.251649801871, 6249.0626406039455, 6249.781257656142, 6251.3123556407845, 6264.060390941395, 6159.784407545714, 6221.06683997404, 6249.1563638908165, 6343.841403964938, 6345.90481142774, 6133.080037994337, 6145.10895920098, 6175.907361389673, 6187.3503282154725, 6189.5048396129105, 6057.121717351048, 6177.907331390123, 6257.405546473078, 6259.812205633838, 6263.311035786151, 5818.33089194748, 5899.91150132757, 5939.287285525765, 6006.785867088552, 6030.969845150747, 6141.785037523665, 6156.445919867234, 6157.415045570664, 6160.722767475385, 6168.506519478341, 5975.820725378246, 6012.549058820693, 6014.6391216527145, 6043.972524670904, 6049.304330002106], "unit": "score", "name": "dojo.html", "value": 5702.3218739899285}, {"lowerIsBetter": false, "replicates": [524.1744252801833, 529.7748456905814, 582.9213056237406, 666.3835951744635, 670.098717225332, 25603.0, 32111.51832722511, 32229.677703222933, 39364.0, 39694.8091557253, 45124.54875451244, 45493.090138197214, 45773.54226457734, 45856.3121553177, 45864.54135458644, 9747.512624368788, 9973.052560006823, 9974.301798874081, 9975.251856110785, 9986.850197247048, 9687.467189304585, 9772.120509154174, 9828.705138845846, 9833.360831545962, 9854.01459854016, 9736.0, 9851.950740246324, 9854.852177217312, 9855.704328870146, 9861.704148875546, 9769.511524423786, 9817.950910245403, 9828.213742900622, 9843.60625574976, 9857.704268871945, 9790.75523111928, 9894.30739848211, 9923.404595724207, 9925.156361709263, 9952.651657192037, 42026.0, 42266.0, 42439.0, 42461.363079553834, 42677.786611066746, 3518.4194607889667, 3790.0918310787597, 3904.1606054698377, 3906.00396898789, 3906.687465002793, 29082.27294317659, 29332.853335733398, 29514.114576562737, 29555.852220738972, 29761.0, 2673.31830383251, 2690.865456727156, 2714.4978179036743, 2720.9591856122174, 2743.931401714953, 469301.0, 469788.0, 471203.0, 473025.0, 473975.0, 70905.64547177231, 71181.64409178024, 71335.64332178306, 71340.2865971344, 71425.28574714187, 73988.63005684938, 77396.83904741434, 79105.0, 79152.60423697844, 79216.0, 18134.274629014693, 18192.545186370447, 18311.54221144482, 18353.0, 18356.08219589015, 13829.03196776216, 13907.0, 13919.721605567833, 13926.025178237629, 13929.86070139306, 22521.436964075703, 22880.0, 22884.65673014906, 22935.426614334774, 22965.540689186124, 9436.669716559887, 9626.66306679263, 9641.0, 9651.9034809651, 9656.0, 959.9952000239954, 1006.9748256293504, 1014.8832884218261, 1109.7281166114353, 1164.2781475485253, 28933.71066289352, 29017.12948611545, 29124.0, 29688.703112969026, 29778.10665680033, 1113.8607674040745, 1119.1103073056938, 1180.1620849196995, 1209.2260952990093, 1249.7562975219926, 14168.291585420688, 14196.432142714175, 15756.76364854528, 16847.9891206528, 16851.41020064292, 658276.0, 666936.0, 666947.0, 667414.0, 668400.0, 64190.358096419375, 64652.0, 64858.675706621165, 64889.351106489274, 65255.67372163109, 1396.9092009019382, 1415.1625989890204, 1508.5172744721583, 1531.7472617018068, 1540.645651500139, 29709.5543566851, 29856.402871942875, 30016.0, 30659.693403065685, 30700.692993070676, 49475.0, 50133.0, 50144.24783628321, 50223.744406390135, 50352.49647503478, 384491.0, 385396.0, 386309.0, 386367.81793092506, 386752.0, 33202.00393988184, 35093.82453087718, 35118.29763404666, 35120.0, 35135.64864351324, 44803.0, 45641.77179114083, 47389.28916066193, 47427.28859067186, 48511.27233091436, 36788.0, 37500.62499374971, 38329.6167038326, 38782.80608596939, 39442.802785985885, 37401.064973375884, 37719.434208486346, 37775.433368500046, 38388.61611383962, 38470.80764596159, 38079.04802379962, 38888.416673750486, 38903.80548097355, 39017.609823901395, 39269.821905342884, 33076.842310519016, 33593.99218023463, 34379.14052148716, 34438.48342274818, 34440.65559344374, 25314.240572782845, 25390.492190156463, 25618.359541011625, 25772.226833195033, 25885.09402170915], "unit": "score", "name": "ext.html", "value": 20767.52566957252}, {"lowerIsBetter": false, "replicates": [338.3166004670564, 383.12264913348434, 391.1609597413548, 397.03916522016715, 397.9005248687828, 19080.23679052836, 20282.0, 20895.895520522394, 21747.912604369798, 21781.891090544526, 11594.710132246699, 12405.193662411937, 12514.684783315093, 12536.997040236782, 12548.0, 5263.921041184376, 5586.385497595261, 6116.969415152918, 6131.3868613138775, 6134.785282515113, 6059.242594675666, 6083.996140636812, 6115.816525504242, 6124.755009799603, 6136.9079463808075, 5835.35811060783, 6126.050462178369, 6127.908081378783, 6131.294901086365, 6144.539159563028, 6022.0, 6054.910116179086, 6084.6349219047, 6085.208922840025, 6085.969570152165, 5684.033714268584, 5834.037383831663, 5856.912146317809, 5860.589758716891, 5875.35371109182, 14439.927800361036, 14560.344784484723, 19209.0, 26665.333366665796, 26724.931002759866, 2145.10977944153, 2146.0450099705636, 2228.765979572138, 2259.762724913877, 2662.8668566571787, 10409.271351005433, 10564.418956957365, 10707.917882720903, 12948.741025179537, 14580.0, 1769.4956937272943, 1851.4075495841337, 1861.3392245752698, 1862.7671541057368, 1884.8125680820995, 84517.0, 86583.56708216481, 97084.51457742666, 105564.41653375205, 108523.45738271337, 11882.940585297018, 12050.457729402198, 12057.0957178212, 12074.637760867188, 12176.756464870654, 14547.490837820626, 14585.927070364793, 14601.342939567745, 14616.853831461762, 14632.853671463148, 9121.270298376114, 9143.908560914306, 9174.990751017383, 9188.724338269729, 9249.861252081224, 9315.254779617615, 9332.16010559053, 9339.626414943326, 9424.528773561295, 9431.528423578793, 3820.178661587772, 4751.0, 4766.855954570948, 4783.23468245086, 4797.832075877397, 1956.5814784281283, 1997.211101614854, 2013.496625843539, 2017.1225516899901, 2055.1368425261126, 932.8787257656597, 977.5112443778111, 978.6427953796955, 1044.3577200021932, 1102.7849569334064, 20275.594488110157, 21012.47468813292, 21018.894905525376, 21404.464888377915, 21472.892635536722, 990.9487361162325, 992.4243938515643, 1034.7413146713322, 1039.3815679670583, 1065.824139017069, 10963.890361096286, 11477.0, 11496.827547586792, 11510.02164816, 11525.020373268366, 655807.0, 658002.0, 663513.0, 669621.0, 676463.0, 73031.26968730244, 80893.59553202197, 88581.67127493092, 117684.41157794156, 127786.36106819593, 1012.9240306977006, 1016.2733645443543, 1041.859348987877, 1042.4683411460057, 1045.4997079191232, 18229.361972330906, 19059.0, 19156.992551721476, 19174.80825191786, 19233.230670773013, 39453.60546394614, 52115.0, 52176.47823521868, 52230.738846305525, 52747.47252527579, 60573.0, 71840.0, 74318.62840685762, 74740.0, 75553.24446755461, 8264.876026859722, 8325.458845175044, 8389.454685445426, 8422.91577084246, 8435.493870367798, 9672.468014259002, 13027.674308142372, 13487.59537213846, 13915.443382265, 13916.304184790923, 10636.0, 11054.61817272841, 11542.884571154182, 12009.579664711693, 12022.819657705317, 9889.950550247202, 11345.829812552653, 11732.882671173178, 11895.76208475843, 12173.39133043362, 11883.108766842348, 11908.880911191123, 12008.579699710817, 12195.085368597569, 12210.816837747263, 8248.752537423887, 8322.50064996102, 8357.038940521918, 8584.957075214834, 8638.956805216185, 8757.299416046573, 9821.558029888814, 11034.337939723642, 11694.415279235835, 12037.03703703684], "unit": "score", "name": "jquery.html", "value": 9524.92693043464}, {"lowerIsBetter": false, "replicates": [1483.451123084459, 1609.9839001609985, 1631.314847763939, 1969.5863868587596, 2068.007356468895, 8261.256486916176, 8468.026176989648, 8480.703175388862, 8485.490870547765, 8867.955660221689, 8898.555072246378, 8956.596953137108, 9070.183683468487, 9077.273818094553, 9079.092090790917, 2196.439907823503, 2574.9485010299877, 2579.21333993132, 2585.31489155374, 2586.780123689489, 1961.9313324033662, 2259.1189436119926, 2260.7174103237094, 2261.977380226201, 2520.6345079963394, 2280.464090938628, 2524.0408644714985, 2582.0704546363295, 2584.914335978893, 2588.0682954136496, 2503.824732268742, 2533.07542746897, 2546.808989325799, 2557.7698007179442, 2564.705058918211, 2490.8007359411386, 2534.911278105276, 2538.6953565572067, 2541.644169816227, 2560.142352311978, 9099.363044586882, 9184.494852783095, 9211.401258918217, 9214.308926830514, 9328.766780830465, 4817.879553011167, 5750.971245143747, 5761.279840019997, 5762.164486149527, 5763.991301522259, 3702.0374702577524, 3731.2350968051483, 3807.067268519203, 3809.866654667101, 3811.7331786774935, 932.4312169576552, 1001.9849702254472, 1034.6947650443062, 1053.436411519841, 1125.2123513540473, 12490.0, 12502.687432814162, 12503.312317822516, 12516.81224781629, 12537.498500059986, 4215.325547912381, 5022.121128802445, 5071.619628527875, 5109.489051094861, 5144.922826157535, 10677.626283080055, 10695.304805187638, 10697.465126743631, 10700.625478108384, 10740.355578665305, 5821.09772985188, 5821.417858214145, 5828.358880523139, 5837.445442682938, 5868.94131058684, 5045.268436076748, 5143.7428128594165, 5184.092783762826, 5190.844274671766, 5206.609504287194, 4184.958150418457, 4196.187731535778, 4201.411802347674, 4233.195692818416, 4235.512916014636, 1184.2716729211472, 1239.962801115968, 1260.3950103950156, 1292.6445227562308, 1349.372541768063, 1081.3674000709673, 1093.3931667924378, 1109.2567979453786, 1175.694319476925, 1363.6318194087542, 8340.666373344999, 8443.408961372768, 8450.535220562806, 8456.408051436463, 8468.915310846813, 1250.1061740855332, 1250.1811313589612, 1250.8061250506187, 1274.350081458463, 1289.8065290206544, 6194.628322300677, 6252.343503932113, 6317.557770955989, 6334.0, 6334.3032266450655, 9857.507124643738, 10835.241533092609, 11199.440027998568, 11223.887761122447, 11405.828912566318, 11250.212485125963, 11295.661130166109, 11358.886411135783, 11378.487968041458, 11389.943050284695, 8449.57752112392, 8717.084706105768, 8739.650413983496, 8739.737807865775, 8792.47245165292, 8469.322454203771, 8541.188587084218, 8578.65685372578, 8589.226969572768, 8591.0, 9403.34176607631, 9574.760630984003, 9966.40201587907, 9966.800663986825, 10132.544035518273, 9922.454265015205, 10071.949640251752, 10097.495125243562, 10179.898201018192, 10245.948770256102, 7783.688652453839, 7885.0, 7912.32745216663, 7914.0, 7930.920690793018, 8265.256126948603, 8474.491530508189, 8478.109798471072, 8514.957425212835, 8537.274331681876, 7756.910362933956, 7836.882446763189, 7867.9606601966625, 7869.803254918673, 7938.166492518433, 7584.976028236118, 7631.885521717068, 7678.500897441649, 7696.8460630788195, 7714.807129821575, 8109.0, 8188.7952801180445, 8198.057223419382, 8208.302294304813, 8210.507369557845, 7083.114610673666, 7332.120145582564, 7418.814529636802, 7429.257074292527, 7430.851382972202, 7375.483716139819, 7446.776596702108, 7453.142888567667, 7454.739084132029, 7470.103587569526], "unit": "score", "name": "mootools.html", "value": 5114.433016720431}, {"lowerIsBetter": false, "replicates": [287.7784106238196, 335.39126485428943, 340.7580617761389, 341.28330505937527, 342.91941393772476, 6584.934150658492, 6590.0, 6648.1025061616665, 6690.832729181773, 6691.4312283455965, 6596.604203747766, 6607.306232845542, 6614.338566143383, 6617.834554136149, 6619.271880093186, 4760.880977975561, 4798.808047678106, 4870.805167793284, 4910.698664853817, 4987.75061246938, 3951.5455722591837, 4875.341828853113, 4894.755262236892, 4906.092372911005, 4916.1642520771375, 4860.829870954517, 4907.5583197512215, 4915.213565829468, 4915.975420122894, 4929.679570827885, 4688.648351373644, 4761.952380476186, 4855.36880205571, 4874.731889746063, 4883.829065982709, 3444.8794292199905, 4191.1827193697245, 4191.203671302443, 4197.887559796656, 4201.2017716633745, 5978.8505287367725, 6227.906581401283, 6303.905441418382, 6337.0, 6360.109584658151, 5088.92366614501, 5542.251796007568, 5790.189373487715, 5804.564657650693, 5819.79630712923, 5622.775088996476, 6909.067275917737, 6986.61573613451, 6988.580685158907, 7001.719931202746, 4597.080583883237, 4767.904641907143, 4768.260919557474, 4774.0, 4774.498677638868, 6155.292141403751, 7455.776326710262, 7465.552066876005, 7481.102267727853, 7495.812604684872, 3977.2840888639744, 4840.419149702058, 4868.0, 4873.9025219496125, 4880.097182021337, 4931.3835770528685, 4940.752962351868, 4946.431160416526, 4953.702777833341, 4962.379702537183, 5819.854503637443, 5827.155062515996, 5832.154337621021, 5833.795817146464, 5833.854153646193, 5389.407165211824, 5683.77264909399, 7081.681324340417, 7083.574985500886, 7088.751893683696, 1450.2676148545129, 1584.1128967778081, 1691.5855615374066, 1726.0592976827659, 1726.5252055684787, 1063.3460421840666, 1095.2935356694886, 1116.542217690743, 1119.776044791045, 1141.3893566941647, 6471.838204044937, 6532.444742196966, 6532.640704761284, 6543.247526534415, 6555.475561955032, 7222.061132052904, 7225.1329840419485, 7227.16887557927, 7232.710691572278, 7251.347378735939, 6345.4770854995395, 6511.153550038464, 6511.316311787289, 6511.511636627272, 6532.640704761284, 3192.9042128736173, 3716.7612201568036, 3832.4442955771256, 3834.7123965702126, 3843.481130047464, 7226.385757210696, 7414.443916706268, 7531.058617672791, 7538.623068846536, 7540.849183016309, 5622.353429355677, 6332.303446620868, 7142.107236595426, 7455.4408419368765, 7462.365698915653, 7527.397808175333, 7527.510711803715, 7539.434542409451, 7551.886721699179, 7552.131504877009, 6922.992332223599, 7188.892166617609, 7212.537981768885, 7214.386777124003, 7217.133943926762, 7064.152301723826, 7081.327273908971, 7083.82290442743, 7097.609631470319, 7102.254263302279, 7417.629118544159, 7499.62501874915, 7504.812379690551, 7512.962435187789, 7518.511296765692, 4864.270359446112, 4873.220284754422, 4873.878153046202, 4877.487863774252, 4881.829135980223, 6928.792136235921, 7163.31948464895, 7169.103862017248, 7170.103737032871, 7199.604021778852, 6912.585244885323, 6934.653267336714, 6945.652717364011, 6949.65251737401, 6960.8955865663065, 6849.1096157499205, 6931.930680693128, 6934.618595977269, 6935.653217339012, 6953.548019378724, 6738.66306684654, 6739.528233023641, 6741.056252124608, 6746.325367463214, 6757.358050985148, 6706.429953454011, 6908.723651053901, 6917.7232910685025, 6931.341522555349, 6936.0636314098965, 5491.917621235605, 5611.719414029364, 6628.900566491603, 6806.251312355538, 6947.5831450113155], "unit": "score", "name": "prototype.html", "value": 5111.212283428692}, {"lowerIsBetter": false, "replicates": [628.1939424155553, 715.5384776818951, 718.8490417012428, 740.9147947985983, 755.4938191411753, 14756.704865902675, 15007.0, 15311.84688153118, 15320.923395383008, 15358.846411535882, 14189.92905035476, 14274.357653905574, 14285.78571321431, 14299.428022879098, 14299.92850035751, 788.45202584204, 797.4776521378507, 962.7015625156189, 969.5249327829383, 992.7937555869617, 980.901909809017, 982.832918403873, 984.566790612132, 986.0189111833736, 986.634945070325, 1031.520343040486, 1035.616821775944, 1036.176239889286, 1036.4144258493927, 1038.4184856480358, 831.4637059096879, 1022.5500779656927, 1047.3715770537692, 1048.8951104889527, 1052.7683909539928, 774.500447211551, 775.166695802015, 776.7009701265054, 777.1063277231173, 782.5774081995772, 14910.850891491054, 14950.551483455514, 14963.177025263607, 15297.388104475918, 15347.00244484105, 12402.441890114966, 12415.44130514129, 12572.497100115985, 12774.61676149717, 12793.0, 10082.445465499395, 10098.9495052525, 10215.0, 10276.383416995004, 10302.845457318146, 3382.5602671652773, 3411.1131105912395, 3558.7864728116397, 3569.678728914384, 3569.7679650822615, 78712.60643696744, 79329.60335198288, 85489.71765423461, 90232.5488372554, 91822.5408872958, 9626.90373096274, 9632.807343853083, 9698.175655069257, 9755.512224388895, 9879.407235565888, 21961.90190490469, 22000.669989950162, 22038.669419958715, 22362.776372236396, 22635.88682056612, 7672.578008209491, 7682.807929801688, 7765.0, 7913.762587122395, 8018.438709290293, 3902.414637804295, 4126.628603425706, 4181.790910454465, 4224.978875105605, 4415.4259946206785, 3211.951820722691, 3718.5537735471917, 3756.7182461314965, 3763.6424539668687, 3767.7927713975996, 603.3574243430733, 659.9274079851212, 685.4173952140641, 711.2283172757512, 736.4439847914897, 577.4600748300353, 595.9135925290808, 597.3429227849331, 613.9386061393914, 620.7765204526366, 8016.759497214976, 8225.506469611842, 8335.749927502186, 8343.582820858932, 8510.78723031929, 535.2052202479315, 582.979595714148, 599.0834023943373, 626.1328060636051, 628.6887990444759, 3886.2227554489214, 3924.843006279717, 4055.087605288845, 4060.4721386219603, 4080.777233873747, 82808.58595706982, 83895.0, 84078.0, 84182.15817841866, 88242.55878720565, 85901.28197436016, 86299.13700862911, 86837.13162868416, 87175.1282487167, 87184.1281587176, 74035.62982185162, 74326.6283668589, 74335.62832185805, 74386.25613743793, 75449.0, 7417.703291868264, 7684.577348245676, 7807.9849619549095, 7880.960595196987, 8107.22981316774, 50704.746476267384, 51129.0, 51409.74295128501, 51596.22605660843, 51599.484005159466, 50021.749891250314, 69298.65350673214, 69395.65302173457, 70167.59664806574, 70554.29445705477, 11155.0, 11219.046381057375, 11410.771784564427, 11418.0, 11587.652370428901, 11708.648740537797, 12090.395480226129, 12351.320677362832, 12410.441530130985, 12427.005839532634, 11693.88306116928, 11721.593408791, 11785.233959792586, 11894.762104757683, 12036.879631203576, 11493.54025838957, 11586.246893951866, 11761.529538818351, 12106.213096148722, 12467.93766031164, 11114.666560003212, 11427.314361138358, 11501.769964600828, 11513.424328783694, 11730.002949749367, 9454.335271636342, 9564.856527151958, 9709.465979371202, 9877.901220987986, 10083.193344532567, 9639.71080867575, 9708.22334213247, 9778.706638800562, 9891.0, 9899.307048506535], "unit": "score", "name": "yui.html", "value": 7082.010694472318}], "name": "dromaeo_css", "value": 7702.56342409063}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 111.0, 111.0, 110.0, 112.0, 112.0, 117.0, 112.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.9}, {"lowerIsBetter": true, "replicates": [154.0, 118.0, 154.0, 143.0, 119.0, 137.0, 118.0, 149.0, 147.0, 116.0], "unit": "score", "name": "audio-beat-detection", "value": 135.5}, {"lowerIsBetter": true, "replicates": [188.0, 183.0, 187.0, 187.0, 186.0, 186.0, 183.0, 186.0, 187.0, 185.0], "unit": "score", "name": "audio-dft", "value": 185.8}, {"lowerIsBetter": true, "replicates": [75.0, 75.0, 72.0, 113.0, 56.0, 57.0, 57.0, 59.0, 114.0, 56.0], "unit": "score", "name": "audio-fft", "value": 73.4}, {"lowerIsBetter": true, "replicates": [90.0, 95.0, 132.0, 79.0, 77.0, 83.0, 115.0, 76.0, 78.0, 117.0], "unit": "score", "name": "audio-oscillator", "value": 94.2}, {"lowerIsBetter": true, "replicates": [88.0, 84.0, 88.0, 86.0, 88.0, 86.0, 126.0, 86.0, 88.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 90.4}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 92.0, 94.0, 94.0, 93.0, 92.0, 122.0, 106.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 97.1}, {"lowerIsBetter": true, "replicates": [84.0, 87.0, 87.0, 86.0, 87.0, 87.0, 85.0, 86.0, 87.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 86.0}, {"lowerIsBetter": true, "replicates": [55.0, 57.0, 57.0, 57.0, 57.0, 57.0, 57.0, 68.0, 51.0, 51.0], "unit": "score", "name": "json-parse-financial", "value": 56.7}, {"lowerIsBetter": true, "replicates": [62.0, 62.0, 68.0, 76.0, 71.0, 68.0, 64.0, 64.0, 65.0, 71.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.1}, {"lowerIsBetter": true, "replicates": [80.0, 94.0, 103.0, 80.0, 81.0, 79.0, 80.0, 80.0, 81.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.3}, {"lowerIsBetter": true, "replicates": [122.0, 125.0, 105.0, 126.0, 124.0, 126.0, 125.0, 119.0, 123.0, 113.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.8}, {"lowerIsBetter": true, "replicates": [131.0, 148.0, 132.0, 133.0, 148.0, 167.0, 153.0, 134.0, 157.0, 134.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.7}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 65.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.7}], "name": "kraken", "value": 1412.6000000000001}]} 02:28:43 INFO - Return code: 0 02:28:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:28:43 INFO - # TBPL SUCCESS # 02:28:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:28:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:28:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:28:43 INFO - 2016-03-08 02:28:43.415 screenresolution[1683:10112] starting screenresolution argv=screenresolution get 02:28:43 INFO - 2016-03-08 02:28:43.418 screenresolution[1683:10112] Display 0: 1600x1200x32@60 02:28:43 INFO - 2016-03-08 02:28:43.424 screenresolution[1684:10115] starting screenresolution argv=screenresolution list 02:28:43 INFO - Available Modes on Display 0 02:28:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:28:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:28:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:28:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:28:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:28:43 INFO - Intel Iris: 02:28:43 INFO - Chipset Model: Intel Iris 02:28:43 INFO - Type: GPU 02:28:43 INFO - Bus: Built-In 02:28:43 INFO - VRAM (Dynamic, Max): 1536 MB 02:28:43 INFO - Vendor: Intel (0x8086) 02:28:43 INFO - Device ID: 0x0a2e 02:28:43 INFO - Revision ID: 0x0009 02:28:43 INFO - Displays: 02:28:43 INFO - Display: 02:28:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:28:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:28:43 INFO - Display Serial Number: 1600x1200 60 02:28:43 INFO - Main Display: Yes 02:28:43 INFO - Mirror: Off 02:28:43 INFO - Online: Yes 02:28:43 INFO - Rotation: Supported 02:28:43 INFO - Return code: 0 02:28:43 INFO - Running post-action listener: _resource_record_post_action 02:28:43 INFO - Running post-run listener: _resource_record_post_run 02:28:44 INFO - Total resource usage - Wall time: 1203s; CPU: 53.0%; Read bytes: 32267776; Write bytes: 664974848; Read time: 320; Write time: 1867 02:28:44 INFO - install - Wall time: 32s; CPU: 55.0%; Read bytes: 357943808; Write bytes: 353679360; Read time: 28109; Write time: 701 02:28:44 INFO - run-tests - Wall time: 1171s; CPU: 52.0%; Read bytes: 30428672; Write bytes: 300125696; Read time: 300; Write time: 1137 02:28:44 INFO - Running post-run listener: _upload_blobber_files 02:28:44 INFO - Blob upload gear active. 02:28:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:28:44 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:28:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:28:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:28:45 INFO - (blobuploader) - INFO - Open directory for files ... 02:28:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:28:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:28:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:28:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:28:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:28:48 INFO - (blobuploader) - INFO - Done attempting. 02:28:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:28:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:28:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:28:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:28:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:28:50 INFO - (blobuploader) - INFO - Done attempting. 02:28:50 INFO - (blobuploader) - INFO - Iteration through files over. 02:28:50 INFO - Return code: 0 02:28:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:28:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:28:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7965042c9d3bc1fec6a9522fe513feb97275067abb55b999a4770ea43ab646dfc0f49f04418c6220e6ac9d23c300b119ba69a67b534a47ddfa355b361c475a4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1b9aee5575b0098a3cb150d1e271571ace5fa9be4b0f96981d964104ff128bddb660427d5f731cb941cc15a118efcd5042ff439ee76acf1f94dfe269620dc7bc"} 02:28:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:28:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:28:50 INFO - Contents: 02:28:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7965042c9d3bc1fec6a9522fe513feb97275067abb55b999a4770ea43ab646dfc0f49f04418c6220e6ac9d23c300b119ba69a67b534a47ddfa355b361c475a4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1b9aee5575b0098a3cb150d1e271571ace5fa9be4b0f96981d964104ff128bddb660427d5f731cb941cc15a118efcd5042ff439ee76acf1f94dfe269620dc7bc"} 02:28:50 INFO - Running post-run listener: copy_logs_to_upload_dir 02:28:50 INFO - Copying logs to upload dir... 02:28:50 INFO - mkdir: /builds/slave/test/build/upload/logs 02:28:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.747394 ========= master_lag: 3.34 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-03-08 02:28:53.719617) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 16 secs) (at 2016-03-08 02:28:53.729051) ========= 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.TNuXnrDPqF/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.nEv4j6P5fP/Listeners TMPDIR=/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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/e7965042c9d3bc1fec6a9522fe513feb97275067abb55b999a4770ea43ab646dfc0f49f04418c6220e6ac9d23c300b119ba69a67b534a47ddfa355b361c475a4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1b9aee5575b0098a3cb150d1e271571ace5fa9be4b0f96981d964104ff128bddb660427d5f731cb941cc15a118efcd5042ff439ee76acf1f94dfe269620dc7bc"} build_url:https://queue.taskcluster.net/v1/task/MHL_SnqvREec-1EcMQlUxA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010961 build_url: 'https://queue.taskcluster.net/v1/task/MHL_SnqvREec-1EcMQlUxA/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/e7965042c9d3bc1fec6a9522fe513feb97275067abb55b999a4770ea43ab646dfc0f49f04418c6220e6ac9d23c300b119ba69a67b534a47ddfa355b361c475a4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1b9aee5575b0098a3cb150d1e271571ace5fa9be4b0f96981d964104ff128bddb660427d5f731cb941cc15a118efcd5042ff439ee76acf1f94dfe269620dc7bc"}' ========= master_lag: 16.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 16 secs) (at 2016-03-08 02:29:09.770351) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-03-08 02:29:09.770681) ========= 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.TNuXnrDPqF/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.nEv4j6P5fP/Listeners TMPDIR=/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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.005543 ========= master_lag: 4.46 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-03-08 02:29:14.233394) ========= ========= Started reboot skipped (results: 3, elapsed: 7 secs) (at 2016-03-08 02:29:14.233704) ========= ========= Finished reboot skipped (results: 3, elapsed: 7 secs) (at 2016-03-08 02:29:21.883481) ========= ========= Total master_lag: 142.78 =========