builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0137 starttime: 1459858456.24 results: success (0) buildid: 20160405030214 builduid: ece8baee345b4f4eab7accb393bd22f3 revision: d9f50aa0a1aaf90499b85c31e0f329b762e80fdd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-05 05:14:16.238054) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-05 05:14:16.238538) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-05 05:14:16.238903) ========= 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.xJyDAr3JbO/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.VItqKtS5rG/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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.005470 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-05 05:14:16.283342) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-05 05:14:16.283653) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-05 05:14:16.361415) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 05:14:16.362120) ========= 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.xJyDAr3JbO/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.VItqKtS5rG/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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.005597 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 05:14:16.448746) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-05 05:14:16.449437) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-05 05:14:16.449990) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 05:14:16.450301) ========= 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.xJyDAr3JbO/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.VItqKtS5rG/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-05 05:14:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.45M=0.002s 2016-04-05 05:14:16 (7.45 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.239406 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 05:14:16.723360) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 05:14:16.723714) ========= 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.xJyDAr3JbO/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.VItqKtS5rG/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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.026279 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 05:14:16.806367) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-04-05 05:14:16.807159) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d9f50aa0a1aaf90499b85c31e0f329b762e80fdd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev d9f50aa0a1aaf90499b85c31e0f329b762e80fdd --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xJyDAr3JbO/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.VItqKtS5rG/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-05 05:14:16,898 truncating revision to first 12 chars 2016-04-05 05:14:16,898 Setting DEBUG logging. 2016-04-05 05:14:16,898 attempt 1/10 2016-04-05 05:14:16,898 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d9f50aa0a1aa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-05 05:14:17,651 unpacking tar archive at: mozilla-central-d9f50aa0a1aa/testing/mozharness/ program finished with exit code 0 elapsedTime=1.249623 ========= master_lag: 3.26 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-04-05 05:14:21.317856) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-05 05:14:21.318210) ========= echo d9f50aa0a1aaf90499b85c31e0f329b762e80fdd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'd9f50aa0a1aaf90499b85c31e0f329b762e80fdd'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xJyDAr3JbO/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.VItqKtS5rG/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 d9f50aa0a1aaf90499b85c31e0f329b762e80fdd program finished with exit code 0 elapsedTime=0.005963 script_repo_revision: 'd9f50aa0a1aaf90499b85c31e0f329b762e80fdd' ========= master_lag: 0.42 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-05 05:14:21.745328) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-05 05:14:21.745634) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-05 05:14:21.761321) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-04-05 05:14:21.762280) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xJyDAr3JbO/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.VItqKtS5rG/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 05:14:21 INFO - MultiFileLogger online at 20160405 05:14:21 in /builds/slave/test 05:14:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:14:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:14:21 INFO - {'append_to_log': False, 05:14:21 INFO - 'base_work_dir': '/builds/slave/test', 05:14:21 INFO - 'blob_upload_branch': 'Firefox', 05:14:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:14:21 INFO - 'branch': 'Firefox', 05:14:21 INFO - 'buildbot_json_path': 'buildprops.json', 05:14:21 INFO - 'config_files': ('talos/mac_config.py',), 05:14:21 INFO - 'default_actions': ('clobber', 05:14:21 INFO - 'read-buildbot-config', 05:14:21 INFO - 'download-and-extract', 05:14:21 INFO - 'populate-webroot', 05:14:21 INFO - 'create-virtualenv', 05:14:21 INFO - 'install', 05:14:21 INFO - 'run-tests'), 05:14:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:14:21 INFO - 'download_minidump_stackwalk': True, 05:14:21 INFO - 'download_symbols': 'ondemand', 05:14:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:14:21 INFO - 'tooltool.py': '/tools/tooltool.py', 05:14:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:14:21 INFO - '/tools/misc-python/virtualenv.py')}, 05:14:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:14:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:14:21 INFO - 'installer_path': 'installer.exe', 05:14:21 INFO - 'log_level': 'info', 05:14:21 INFO - 'log_name': 'talos', 05:14:21 INFO - 'log_to_console': True, 05:14:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:14:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:14:21 INFO - 'opt_config_files': (), 05:14:21 INFO - 'pip_index': False, 05:14:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:14:21 INFO - 'cmd': ('bash', 05:14:21 INFO - '-c', 05:14:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:14:21 INFO - 'enabled': True, 05:14:21 INFO - 'halt_on_failure': False, 05:14:21 INFO - 'name': 'check_screen_resolution'},), 05:14:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:14:21 INFO - 'cmd': ('bash', 05:14:21 INFO - '-c', 05:14:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:14:21 INFO - 'enabled': True, 05:14:21 INFO - 'halt_on_failure': False, 05:14:21 INFO - 'name': 'check_screen_resolution'},), 05:14:21 INFO - 'run_cmd_checks_enabled': True, 05:14:21 INFO - 'sps_profile': False, 05:14:21 INFO - 'sps_profile_interval': 0, 05:14:21 INFO - 'suite': 'dromaeojs', 05:14:21 INFO - 'system_bits': '32', 05:14:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:14:21 INFO - 'title': 't-yosemite-r7-0137', 05:14:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:14:21 INFO - 'use_talos_json': True, 05:14:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:14:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:14:21 INFO - 'work_dir': 'build'} 05:14:21 INFO - ##### 05:14:21 INFO - ##### Running clobber step. 05:14:21 INFO - ##### 05:14:21 INFO - Running pre-action listener: _resource_record_pre_action 05:14:21 INFO - Running main action method: clobber 05:14:21 INFO - rmtree: /builds/slave/test/build 05:14:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:14:23 INFO - Running post-action listener: _resource_record_post_action 05:14:23 INFO - ##### 05:14:23 INFO - ##### Running read-buildbot-config step. 05:14:23 INFO - ##### 05:14:23 INFO - Running pre-action listener: _resource_record_pre_action 05:14:23 INFO - Running main action method: read_buildbot_config 05:14:23 INFO - Using buildbot properties: 05:14:23 INFO - { 05:14:23 INFO - "project": "", 05:14:23 INFO - "product": "firefox", 05:14:23 INFO - "script_repo_revision": "production", 05:14:23 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:14:23 INFO - "repository": "", 05:14:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:14:23 INFO - "buildid": "20160405030214", 05:14:23 INFO - "stage_platform": "macosx64", 05:14:23 INFO - "basedir": "/builds/slave/test", 05:14:23 INFO - "nightly_build": "True", 05:14:23 INFO - "buildnumber": 203, 05:14:23 INFO - "slavename": "t-yosemite-r7-0137", 05:14:23 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:14:23 INFO - "platform": "yosemite_r7", 05:14:23 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:14:23 INFO - "branch": "mozilla-central", 05:14:23 INFO - "repo_path": "mozilla-central", 05:14:23 INFO - "revision": "d9f50aa0a1aaf90499b85c31e0f329b762e80fdd", 05:14:23 INFO - "pgo_build": "False", 05:14:23 INFO - "builduid": "ece8baee345b4f4eab7accb393bd22f3", 05:14:23 INFO - "slavebuilddir": "test" 05:14:23 INFO - } 05:14:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/GxG6j7tfTmibZPC6Vf9bmw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 05:14:23 INFO - Running post-action listener: _resource_record_post_action 05:14:23 INFO - ##### 05:14:23 INFO - ##### Running download-and-extract step. 05:14:23 INFO - ##### 05:14:23 INFO - Running pre-action listener: _resource_record_pre_action 05:14:23 INFO - Running main action method: download_and_extract 05:14:23 INFO - mkdir: /builds/slave/test/build/tests 05:14:23 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')]} 05:14:23 INFO - https://queue.taskcluster.net/v1/task/GxG6j7tfTmibZPC6Vf9bmw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:14:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxG6j7tfTmibZPC6Vf9bmw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:14:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxG6j7tfTmibZPC6Vf9bmw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:14:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxG6j7tfTmibZPC6Vf9bmw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:14:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxG6j7tfTmibZPC6Vf9bmw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 05:14:25 INFO - Downloaded 1199 bytes. 05:14:25 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:14:25 INFO - Using the following test package requirements: 05:14:25 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:14:25 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:14:25 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 05:14:25 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:14:25 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 05:14:25 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:14:25 INFO - u'jsshell-mac.zip'], 05:14:25 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:14:25 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 05:14:25 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:14:25 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:14:25 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 05:14:25 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:14:25 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 05:14:25 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:14:25 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 05:14:25 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:14:25 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 05:14:25 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:14:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:25 INFO - https://queue.taskcluster.net/v1/task/GxG6j7tfTmibZPC6Vf9bmw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:14:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxG6j7tfTmibZPC6Vf9bmw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:14:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxG6j7tfTmibZPC6Vf9bmw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:14:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxG6j7tfTmibZPC6Vf9bmw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:14:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxG6j7tfTmibZPC6Vf9bmw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:14:26 INFO - Downloaded 17960044 bytes. 05:14:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:14:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:14:29 INFO - Return code: 0 05:14:29 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:14:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:29 INFO - https://queue.taskcluster.net/v1/task/GxG6j7tfTmibZPC6Vf9bmw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:14:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxG6j7tfTmibZPC6Vf9bmw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:14:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxG6j7tfTmibZPC6Vf9bmw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:14:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxG6j7tfTmibZPC6Vf9bmw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:14:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxG6j7tfTmibZPC6Vf9bmw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:14:30 INFO - Downloaded 17960044 bytes. 05:14:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:14:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:14:34 INFO - Return code: 0 05:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:34 INFO - https://queue.taskcluster.net/v1/task/GxG6j7tfTmibZPC6Vf9bmw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:14:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxG6j7tfTmibZPC6Vf9bmw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:14:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxG6j7tfTmibZPC6Vf9bmw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:14:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxG6j7tfTmibZPC6Vf9bmw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:14:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxG6j7tfTmibZPC6Vf9bmw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:14:35 INFO - Downloaded 10847584 bytes. 05:14:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:14:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:14:35 INFO - Return code: 0 05:14: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')]} 05:14:35 INFO - https://queue.taskcluster.net/v1/task/GxG6j7tfTmibZPC6Vf9bmw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:14:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxG6j7tfTmibZPC6Vf9bmw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:14:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxG6j7tfTmibZPC6Vf9bmw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:14:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxG6j7tfTmibZPC6Vf9bmw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 05:14:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxG6j7tfTmibZPC6Vf9bmw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 05:14:39 INFO - Downloaded 111485244 bytes. 05:14:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GxG6j7tfTmibZPC6Vf9bmw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:14:39 INFO - mkdir: /builds/slave/test/properties 05:14:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:14:39 INFO - Writing to file /builds/slave/test/properties/build_url 05:14:39 INFO - Contents: 05:14:39 INFO - build_url:https://queue.taskcluster.net/v1/task/GxG6j7tfTmibZPC6Vf9bmw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:14:40 INFO - Running post-action listener: _resource_record_post_action 05:14:40 INFO - Running post-action listener: set_extra_try_arguments 05:14:40 INFO - ##### 05:14:40 INFO - ##### Running populate-webroot step. 05:14:40 INFO - ##### 05:14:40 INFO - Running pre-action listener: _resource_record_pre_action 05:14:40 INFO - Running main action method: populate_webroot 05:14:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:14:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:14:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:14:40 INFO - '--tppagecycles', 05:14:40 INFO - '7'], 05:14:40 INFO - 'tests': ['tsvgm']}}, 05:14:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:14:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:14:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:14:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:14:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:14:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:14:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:14:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:40 INFO - 'talos_options': ['--e10s'], 05:14:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:14:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:40 INFO - 'tests': ['damp', 'tps']}, 05:14:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:40 INFO - 'talos_options': ['--e10s'], 05:14:40 INFO - 'tests': ['damp', 'tps']}, 05:14:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:14:40 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 05:14:40 INFO - 'tests': ['dromaeo_dom']}, 05:14:40 INFO - 'other': {'tests': ['a11yr', 05:14:40 INFO - 'ts_paint', 05:14:40 INFO - 'tpaint', 05:14:40 INFO - 'sessionrestore', 05:14:40 INFO - 'sessionrestore_no_auto_restore', 05:14:40 INFO - 'tabpaint']}, 05:14:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:14:40 INFO - 'tests': ['a11yr', 05:14:40 INFO - 'ts_paint', 05:14:40 INFO - 'tpaint', 05:14:40 INFO - 'sessionrestore', 05:14:40 INFO - 'sessionrestore_no_auto_restore', 05:14:40 INFO - 'tabpaint']}, 05:14:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:14:40 INFO - 'tests': ['a11yr', 05:14:40 INFO - 'ts_paint', 05:14:40 INFO - 'tpaint', 05:14:40 INFO - 'sessionrestore', 05:14:40 INFO - 'sessionrestore_no_auto_restore', 05:14:40 INFO - 'tabpaint']}, 05:14:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:14:40 INFO - 'tests': ['a11yr', 05:14:40 INFO - 'ts_paint', 05:14:40 INFO - 'tpaint', 05:14:40 INFO - 'sessionrestore', 05:14:40 INFO - 'sessionrestore_no_auto_restore', 05:14:40 INFO - 'tabpaint']}, 05:14:40 INFO - 'other_l64': {'tests': ['a11yr', 05:14:40 INFO - 'ts_paint', 05:14:40 INFO - 'tpaint', 05:14:40 INFO - 'sessionrestore', 05:14:40 INFO - 'sessionrestore_no_auto_restore', 05:14:40 INFO - 'tabpaint']}, 05:14:40 INFO - 'other_nol64': {'tests': ['a11yr', 05:14:40 INFO - 'ts_paint', 05:14:40 INFO - 'tpaint', 05:14:40 INFO - 'sessionrestore', 05:14:40 INFO - 'sessionrestore_no_auto_restore', 05:14:40 INFO - 'tabpaint']}, 05:14:40 INFO - 'svgr': {'tests': ['tsvgx', 05:14:40 INFO - 'tsvgr_opacity', 05:14:40 INFO - 'tart', 05:14:40 INFO - 'tscrollx', 05:14:40 INFO - 'cart']}, 05:14:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:14:40 INFO - 'tests': ['tsvgx', 05:14:40 INFO - 'tsvgr_opacity', 05:14:40 INFO - 'tart', 05:14:40 INFO - 'tscrollx', 05:14:40 INFO - 'cart']}, 05:14:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:40 INFO - 'tests': ['tp5o']}, 05:14:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:40 INFO - 'talos_options': ['--e10s'], 05:14:40 INFO - 'tests': ['tp5o']}, 05:14:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:40 INFO - 'talos_options': ['--xperf_path', 05:14:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:14:40 INFO - 'tests': ['tp5n']}, 05:14:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:40 INFO - 'talos_options': ['--e10s', 05:14:40 INFO - '--xperf_path', 05:14:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:14:40 INFO - 'tests': ['tp5n']}}, 05:14:40 INFO - 'talos.zip': {'path': '', 05:14:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:14:40 INFO - Running post-action listener: _resource_record_post_action 05:14:40 INFO - ##### 05:14:40 INFO - ##### Running create-virtualenv step. 05:14:40 INFO - ##### 05:14:40 INFO - Running pre-action listener: _resource_record_pre_action 05:14:40 INFO - Running main action method: create_virtualenv 05:14:40 INFO - Creating virtualenv /builds/slave/test/build/venv 05:14:40 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 05:14:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:14:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:14:41 INFO - Using real prefix '/tools/python27' 05:14:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:14:41 INFO - Installing distribute.............................................................................................................................................................................................done. 05:14:44 INFO - Installing pip.................done. 05:14:44 INFO - Return code: 0 05:14:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10152fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10153f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facfb58c380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013cee00>, '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 0x1011f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1013c9b20>, '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.xJyDAr3JbO/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.VItqKtS5rG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 05:14:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:14:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:14:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xJyDAr3JbO/Render', 05:14:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:14:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:14:44 INFO - 'HOME': '/Users/cltbld', 05:14:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:14:44 INFO - 'LOGNAME': 'cltbld', 05:14:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:44 INFO - 'MOZ_NO_REMOTE': '1', 05:14:44 INFO - 'NO_EM_RESTART': '1', 05:14:44 INFO - 'PAGER': '/bin/cat', 05:14:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:14:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:44 INFO - 'PWD': '/builds/slave/test', 05:14:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:14:44 INFO - 'SHELL': '/bin/bash', 05:14:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VItqKtS5rG/Listeners', 05:14:44 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 05:14:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:14:44 INFO - 'USER': 'cltbld', 05:14:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:14:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:14:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:44 INFO - 'XPC_FLAGS': '0x0', 05:14:44 INFO - 'XPC_SERVICE_NAME': '0', 05:14:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:14:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:44 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 05:14:44 INFO - Cleaning up... 05:14:44 INFO - Return code: 0 05:14:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10152fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10153f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facfb58c380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013cee00>, '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 0x1011f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1013c9b20>, '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.xJyDAr3JbO/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.VItqKtS5rG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 05:14:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:14:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:14:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xJyDAr3JbO/Render', 05:14:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:14:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:14:44 INFO - 'HOME': '/Users/cltbld', 05:14:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:14:44 INFO - 'LOGNAME': 'cltbld', 05:14:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:44 INFO - 'MOZ_NO_REMOTE': '1', 05:14:44 INFO - 'NO_EM_RESTART': '1', 05:14:44 INFO - 'PAGER': '/bin/cat', 05:14:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:14:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:44 INFO - 'PWD': '/builds/slave/test', 05:14:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:14:44 INFO - 'SHELL': '/bin/bash', 05:14:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VItqKtS5rG/Listeners', 05:14:44 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 05:14:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:14:44 INFO - 'USER': 'cltbld', 05:14:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:14:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:14:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:44 INFO - 'XPC_FLAGS': '0x0', 05:14:44 INFO - 'XPC_SERVICE_NAME': '0', 05:14:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:14:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:45 INFO - Downloading/unpacking psutil>=0.7.1 05:14:45 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 05:14:45 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 05:14:45 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 05:14:45 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 05:14:45 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 05:14:45 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 05:14:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:14:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:14:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:14:48 INFO - Installing collected packages: psutil 05:14:48 INFO - Running setup.py install for psutil 05:14:48 INFO - building 'psutil._psutil_osx' extension 05:14:48 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 05:14:48 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 05:14:48 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 05:14:48 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 05:14:49 INFO - building 'psutil._psutil_posix' extension 05:14:49 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 05:14:49 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:14:49 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:14:49 INFO - ^ 05:14:49 INFO - 1 warning generated. 05:14:49 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 05:14:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:14:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:14:49 INFO - Successfully installed psutil 05:14:49 INFO - Cleaning up... 05:14:49 INFO - Return code: 0 05:14:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:14: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')]} 05:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14: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')]} 05:14:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:49 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 0x10152fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10153f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facfb58c380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013cee00>, '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 0x1011f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1013c9b20>, '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.xJyDAr3JbO/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.VItqKtS5rG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 05:14:49 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 05:14:49 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 05:14:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xJyDAr3JbO/Render', 05:14:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:14:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:14:49 INFO - 'HOME': '/Users/cltbld', 05:14:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:14:49 INFO - 'LOGNAME': 'cltbld', 05:14:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:49 INFO - 'MOZ_NO_REMOTE': '1', 05:14:49 INFO - 'NO_EM_RESTART': '1', 05:14:49 INFO - 'PAGER': '/bin/cat', 05:14:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:14:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:49 INFO - 'PWD': '/builds/slave/test', 05:14:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:14:49 INFO - 'SHELL': '/bin/bash', 05:14:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VItqKtS5rG/Listeners', 05:14:49 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 05:14:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:14:49 INFO - 'USER': 'cltbld', 05:14:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:14:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:14:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:49 INFO - 'XPC_FLAGS': '0x0', 05:14:49 INFO - 'XPC_SERVICE_NAME': '0', 05:14:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:14:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:14:49 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 05:14:49 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 05:14:49 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 05:14:49 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 05:14:49 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 05:14:49 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 05:14:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:14:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:14:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:14:52 INFO - Installing collected packages: mozsystemmonitor 05:14:52 INFO - Running setup.py install for mozsystemmonitor 05:14:52 INFO - Successfully installed mozsystemmonitor 05:14:52 INFO - Cleaning up... 05:14:52 INFO - Return code: 0 05:14:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:52 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 0x10152fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10153f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facfb58c380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013cee00>, '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 0x1011f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1013c9b20>, '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.xJyDAr3JbO/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.VItqKtS5rG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 05:14:52 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 05:14:52 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 05:14:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xJyDAr3JbO/Render', 05:14:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:14:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:14:52 INFO - 'HOME': '/Users/cltbld', 05:14:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:14:52 INFO - 'LOGNAME': 'cltbld', 05:14:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:52 INFO - 'MOZ_NO_REMOTE': '1', 05:14:52 INFO - 'NO_EM_RESTART': '1', 05:14:52 INFO - 'PAGER': '/bin/cat', 05:14:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:14:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:52 INFO - 'PWD': '/builds/slave/test', 05:14:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:14:52 INFO - 'SHELL': '/bin/bash', 05:14:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VItqKtS5rG/Listeners', 05:14:52 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 05:14:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:14:52 INFO - 'USER': 'cltbld', 05:14:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:14:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:14:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:52 INFO - 'XPC_FLAGS': '0x0', 05:14:52 INFO - 'XPC_SERVICE_NAME': '0', 05:14:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:14:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:52 INFO - Downloading/unpacking blobuploader==1.2.4 05:14:52 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 05:14:52 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 05:14:52 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 05:14:52 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 05:14:52 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 05:14:52 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 05:14:55 INFO - Downloading blobuploader-1.2.4.tar.gz 05:14:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:14:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:14:55 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 05:14:55 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 05:14:55 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 05:14:55 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 05:14:55 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 05:14:55 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 05:14:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:14:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:14:55 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 05:14:55 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 05:14:55 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 05:14:55 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 05:14:55 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 05:14:55 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 05:14:56 INFO - Downloading docopt-0.6.1.tar.gz 05:14:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:14:56 INFO - Installing collected packages: blobuploader, requests, docopt 05:14:56 INFO - Running setup.py install for blobuploader 05:14:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:14:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:14:56 INFO - Running setup.py install for requests 05:14:57 INFO - Running setup.py install for docopt 05:14:57 INFO - Successfully installed blobuploader requests docopt 05:14:57 INFO - Cleaning up... 05:14:57 INFO - Return code: 0 05:14:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:14:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:57 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 0x10152fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10153f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facfb58c380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013cee00>, '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 0x1011f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1013c9b20>, '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.xJyDAr3JbO/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.VItqKtS5rG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 05:14:57 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 05:14:57 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 05:14:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xJyDAr3JbO/Render', 05:14:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:14:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:14:57 INFO - 'HOME': '/Users/cltbld', 05:14:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:14:57 INFO - 'LOGNAME': 'cltbld', 05:14:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:57 INFO - 'MOZ_NO_REMOTE': '1', 05:14:57 INFO - 'NO_EM_RESTART': '1', 05:14:57 INFO - 'PAGER': '/bin/cat', 05:14:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:14:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:57 INFO - 'PWD': '/builds/slave/test', 05:14:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:14:57 INFO - 'SHELL': '/bin/bash', 05:14:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VItqKtS5rG/Listeners', 05:14:57 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 05:14:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:14:57 INFO - 'USER': 'cltbld', 05:14:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:14:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:14:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:57 INFO - 'XPC_FLAGS': '0x0', 05:14:57 INFO - 'XPC_SERVICE_NAME': '0', 05:14:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:14:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:14:57 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-ZRmlI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:14:57 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-rSyjxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:14:57 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-U2EnV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:14:57 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-o7kOVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:14:57 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-USmb2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:14:58 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-pV917v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:14:58 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-L45Tv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:14:58 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-HDdbZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:14:58 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-Z2Wym7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:14:58 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-zWMk9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:14:58 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-IonzCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:14:58 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-FByCpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:14:58 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-jUxIsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:14:58 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-8PPuFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:14:58 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-RG6J3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:14:59 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-WiOIqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:14:59 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-RXlCoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:14:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:14:59 INFO - Running setup.py install for manifestparser 05:14:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:14:59 INFO - Running setup.py install for mozcrash 05:14:59 INFO - Running setup.py install for mozdebug 05:14:59 INFO - Running setup.py install for mozdevice 05:14:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:14:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:14:59 INFO - Running setup.py install for mozfile 05:15:00 INFO - Running setup.py install for mozhttpd 05:15:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:15:00 INFO - Running setup.py install for mozinfo 05:15:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:15:00 INFO - Running setup.py install for mozInstall 05:15:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:15:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:15:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:15:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:15:00 INFO - Running setup.py install for mozleak 05:15:00 INFO - Running setup.py install for mozlog 05:15:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:15:00 INFO - Running setup.py install for moznetwork 05:15:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:15:00 INFO - Running setup.py install for mozprocess 05:15:01 INFO - Running setup.py install for mozprofile 05:15:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:15:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:15:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:15:01 INFO - Running setup.py install for mozrunner 05:15:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:15:01 INFO - Running setup.py install for mozscreenshot 05:15:01 INFO - Running setup.py install for moztest 05:15:01 INFO - Running setup.py install for mozversion 05:15:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:15:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:15:01 INFO - Cleaning up... 05:15:01 INFO - Return code: 0 05:15:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:01 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 0x10152fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10153f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facfb58c380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013cee00>, '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 0x1011f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1013c9b20>, '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.xJyDAr3JbO/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.VItqKtS5rG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 05:15:01 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 05:15:01 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 05:15:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xJyDAr3JbO/Render', 05:15:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:01 INFO - 'HOME': '/Users/cltbld', 05:15:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:01 INFO - 'LOGNAME': 'cltbld', 05:15:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:01 INFO - 'MOZ_NO_REMOTE': '1', 05:15:01 INFO - 'NO_EM_RESTART': '1', 05:15:01 INFO - 'PAGER': '/bin/cat', 05:15:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:01 INFO - 'PWD': '/builds/slave/test', 05:15:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:01 INFO - 'SHELL': '/bin/bash', 05:15:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VItqKtS5rG/Listeners', 05:15:01 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 05:15:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:01 INFO - 'USER': 'cltbld', 05:15:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:01 INFO - 'XPC_FLAGS': '0x0', 05:15:01 INFO - 'XPC_SERVICE_NAME': '0', 05:15:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:15:02 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-McSbMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:15:02 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)) 05:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:15:02 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-1AqkCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:15:02 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)) 05:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:15:02 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-o4tjAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:15:02 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)) 05:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:15:02 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-JqwVBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:15:02 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)) 05:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:15:02 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-hVCEEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:15:02 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)) 05:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:15:02 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-EwIkHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:15:02 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)) 05:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:15:02 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-3Yp72O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:15:02 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)) 05:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:15:02 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-VzCRsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:15:02 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)) 05:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:15:02 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-c08q6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:15:02 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)) 05:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:15:03 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-pSMVz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:15:03 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)) 05:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:15:03 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-RPkYcf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:15:03 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)) 05:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:15:03 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-j0cbcF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:15:03 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)) 05:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:15:03 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-F4DVIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:15:03 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)) 05:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:15:03 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-qEobKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:15:03 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)) 05:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:15:03 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-5x2ZXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:15:03 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)) 05:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:15:03 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-kCtoiA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:15:03 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)) 05:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:15:03 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-dKiU6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:15:03 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)) 05:15:03 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)) 05:15:03 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)) 05:15:03 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)) 05:15:03 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)) 05:15:03 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)) 05:15:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:15:03 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 05:15:03 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 05:15:03 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 05:15:03 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 05:15:03 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 05:15:03 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 05:15:06 INFO - Downloading blessings-1.6.tar.gz 05:15:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:15:06 INFO - Installing collected packages: blessings 05:15:06 INFO - Running setup.py install for blessings 05:15:06 INFO - Successfully installed blessings 05:15:06 INFO - Cleaning up... 05:15:06 INFO - Return code: 0 05:15:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:15:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:15:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:15:06 INFO - Reading from file tmpfile_stdout 05:15:06 INFO - Current package versions: 05:15:06 INFO - blessings == 1.6 05:15:06 INFO - blobuploader == 1.2.4 05:15:06 INFO - docopt == 0.6.1 05:15:06 INFO - manifestparser == 1.1 05:15:06 INFO - mozInstall == 1.12 05:15:06 INFO - mozcrash == 0.17 05:15:06 INFO - mozdebug == 0.1 05:15:06 INFO - mozdevice == 0.48 05:15:06 INFO - mozfile == 1.2 05:15:06 INFO - mozhttpd == 0.7 05:15:06 INFO - mozinfo == 0.9 05:15:06 INFO - mozleak == 0.1 05:15:06 INFO - mozlog == 3.1 05:15:06 INFO - moznetwork == 0.27 05:15:06 INFO - mozprocess == 0.22 05:15:06 INFO - mozprofile == 0.28 05:15:06 INFO - mozrunner == 6.11 05:15:06 INFO - mozscreenshot == 0.1 05:15:06 INFO - mozsystemmonitor == 0.0 05:15:06 INFO - moztest == 0.7 05:15:06 INFO - mozversion == 1.4 05:15:06 INFO - psutil == 3.1.1 05:15:06 INFO - requests == 1.2.3 05:15:06 INFO - wsgiref == 0.1.2 05:15:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:15: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')]} 05:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15: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')]} 05:15:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:06 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 0x10152fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10153f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facfb58c380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013cee00>, '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 0x1011f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1013c9b20>, '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.xJyDAr3JbO/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.VItqKtS5rG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 05:15:06 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 05:15:06 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 05:15:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xJyDAr3JbO/Render', 05:15:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:06 INFO - 'HOME': '/Users/cltbld', 05:15:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:06 INFO - 'LOGNAME': 'cltbld', 05:15:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:06 INFO - 'MOZ_NO_REMOTE': '1', 05:15:06 INFO - 'NO_EM_RESTART': '1', 05:15:06 INFO - 'PAGER': '/bin/cat', 05:15:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:06 INFO - 'PWD': '/builds/slave/test', 05:15:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:06 INFO - 'SHELL': '/bin/bash', 05:15:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VItqKtS5rG/Listeners', 05:15:06 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 05:15:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:06 INFO - 'USER': 'cltbld', 05:15:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:06 INFO - 'XPC_FLAGS': '0x0', 05:15:06 INFO - 'XPC_SERVICE_NAME': '0', 05:15:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:07 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)) 05:15:07 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)) 05:15:07 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)) 05:15:07 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)) 05:15:07 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)) 05:15:07 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)) 05:15:07 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)) 05:15:07 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)) 05:15:07 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)) 05:15:07 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)) 05:15:07 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)) 05:15:07 INFO - Cleaning up... 05:15:07 INFO - Return code: 0 05:15:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:15:07 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')]} 05:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:07 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')]} 05:15:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:07 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 0x10152fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10153f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facfb58c380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013cee00>, '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 0x1011f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1013c9b20>, '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.xJyDAr3JbO/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.VItqKtS5rG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 05:15:07 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 05:15:07 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 05:15:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xJyDAr3JbO/Render', 05:15:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:07 INFO - 'HOME': '/Users/cltbld', 05:15:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:07 INFO - 'LOGNAME': 'cltbld', 05:15:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:07 INFO - 'MOZ_NO_REMOTE': '1', 05:15:07 INFO - 'NO_EM_RESTART': '1', 05:15:07 INFO - 'PAGER': '/bin/cat', 05:15:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:07 INFO - 'PWD': '/builds/slave/test', 05:15:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:07 INFO - 'SHELL': '/bin/bash', 05:15:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VItqKtS5rG/Listeners', 05:15:07 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 05:15:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:07 INFO - 'USER': 'cltbld', 05:15:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:07 INFO - 'XPC_FLAGS': '0x0', 05:15:07 INFO - 'XPC_SERVICE_NAME': '0', 05:15:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:07 INFO - Downloading/unpacking jsonschema 05:15: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 05:15: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 05:15: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 05:15: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 05:15: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 05:15: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 05:15:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:15:09 INFO - Downloading/unpacking functools32 (from jsonschema) 05:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:10 INFO - Downloading functools32-3.2.3-2.tar.gz 05:15:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:15:10 INFO - warning: no files found matching '*.txt' 05:15:10 INFO - no previously-included directories found matching 'build' 05:15:10 INFO - no previously-included directories found matching 'dist' 05:15:10 INFO - no previously-included directories found matching '.git*' 05:15:10 INFO - Installing collected packages: jsonschema, functools32 05:15:10 INFO - Running setup.py install for functools32 05:15:10 INFO - warning: no files found matching '*.txt' 05:15:10 INFO - no previously-included directories found matching 'build' 05:15:10 INFO - no previously-included directories found matching 'dist' 05:15:10 INFO - no previously-included directories found matching '.git*' 05:15:10 INFO - Successfully installed jsonschema functools32 05:15:10 INFO - Cleaning up... 05:15:10 INFO - Return code: 0 05:15:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:15:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:10 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 0x10152fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10153f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facfb58c380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013cee00>, '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 0x1011f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1013c9b20>, '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.xJyDAr3JbO/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.VItqKtS5rG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 05:15:10 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 05:15:10 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 05:15:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xJyDAr3JbO/Render', 05:15:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:10 INFO - 'HOME': '/Users/cltbld', 05:15:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:10 INFO - 'LOGNAME': 'cltbld', 05:15:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:10 INFO - 'MOZ_NO_REMOTE': '1', 05:15:10 INFO - 'NO_EM_RESTART': '1', 05:15:10 INFO - 'PAGER': '/bin/cat', 05:15:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:10 INFO - 'PWD': '/builds/slave/test', 05:15:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:10 INFO - 'SHELL': '/bin/bash', 05:15:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VItqKtS5rG/Listeners', 05:15:10 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 05:15:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:10 INFO - 'USER': 'cltbld', 05:15:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:10 INFO - 'XPC_FLAGS': '0x0', 05:15:10 INFO - 'XPC_SERVICE_NAME': '0', 05:15:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:10 INFO - Downloading/unpacking flake8 05:15:10 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 05:15:10 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 05:15:10 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 05:15:10 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 05:15:10 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 05:15:10 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 05:15:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:15:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:15:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:15:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:15:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:15:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:15:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:15:14 INFO - no previously-included directories found matching 'docs/_build' 05:15:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:15:14 INFO - Running setup.py install for pep8 05:15:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:15:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:15:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:15:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:15:14 INFO - no previously-included directories found matching 'docs/_build' 05:15:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:15:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:15:14 INFO - Cleaning up... 05:15:14 INFO - Return code: 0 05:15:14 INFO - Running post-action listener: _resource_record_post_action 05:15:14 INFO - Running post-action listener: _start_resource_monitoring 05:15:14 INFO - Starting resource monitoring. 05:15:14 INFO - ##### 05:15:14 INFO - ##### Running install step. 05:15:14 INFO - ##### 05:15:14 INFO - Running pre-action listener: _resource_record_pre_action 05:15:14 INFO - Running main action method: install 05:15:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:15:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:15:15 INFO - Reading from file tmpfile_stdout 05:15:15 INFO - Detecting whether we're running mozinstall >=1.0... 05:15:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:15:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:15:15 INFO - Reading from file tmpfile_stdout 05:15:15 INFO - Output received: 05:15:15 INFO - Usage: mozinstall [options] installer 05:15:15 INFO - Options: 05:15:15 INFO - -h, --help show this help message and exit 05:15:15 INFO - -d DEST, --destination=DEST 05:15:15 INFO - Directory to install application into. [default: 05:15:15 INFO - "/builds/slave/test"] 05:15:15 INFO - --app=APP Application being installed. [default: firefox] 05:15:15 INFO - mkdir: /builds/slave/test/build/application 05:15:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:15:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:15:49 INFO - Reading from file tmpfile_stdout 05:15:49 INFO - Output received: 05:15:49 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:15:49 INFO - Running post-action listener: _resource_record_post_action 05:15:49 INFO - ##### 05:15:49 INFO - ##### Running run-tests step. 05:15:49 INFO - ##### 05:15:49 INFO - Running pre-action listener: _resource_record_pre_action 05:15:49 INFO - Running main action method: run_tests 05:15:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:15:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:15:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:15:49 INFO - 2016-04-05 05:15:49.149 screenresolution[1639:7791] starting screenresolution argv=screenresolution get 05:15:49 INFO - 2016-04-05 05:15:49.151 screenresolution[1639:7791] Display 0: 1600x1200x32@60 05:15:49 INFO - 2016-04-05 05:15:49.157 screenresolution[1640:7793] starting screenresolution argv=screenresolution list 05:15:49 INFO - Available Modes on Display 0 05:15:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:15:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:15:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:15:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:15:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:15:49 INFO - Intel Iris: 05:15:49 INFO - Chipset Model: Intel Iris 05:15:49 INFO - Type: GPU 05:15:49 INFO - Bus: Built-In 05:15:49 INFO - VRAM (Dynamic, Max): 1536 MB 05:15:49 INFO - Vendor: Intel (0x8086) 05:15:49 INFO - Device ID: 0x0a2e 05:15:49 INFO - Revision ID: 0x0009 05:15:49 INFO - Displays: 05:15:49 INFO - Display: 05:15:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:15:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:15:49 INFO - Display Serial Number: 1600x1200 60 05:15:49 INFO - Main Display: Yes 05:15:49 INFO - Mirror: Off 05:15:49 INFO - Online: Yes 05:15:49 INFO - Rotation: Supported 05:15:49 INFO - Return code: 0 05:15:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:15:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:15:49 INFO - Python 2.7.3 05:15:49 INFO - Return code: 0 05:15:49 INFO - grabbing minidump binary from tooltool 05:15: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')]} 05:15:49 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 0x1013cee00>, '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 0x1011f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1013c9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:15:49 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 05:15:49 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 05:15:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:15:49 INFO - Return code: 0 05:15:49 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:15:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:15:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:15:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:15:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:15:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:15:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:15:50 INFO - Return code: 0 05:15:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GxG6j7tfTmibZPC6Vf9bmw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0137', '--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 05:15:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GxG6j7tfTmibZPC6Vf9bmw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0137 --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 05:15:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xJyDAr3JbO/Render', 05:15:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:50 INFO - 'HOME': '/Users/cltbld', 05:15:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:50 INFO - 'LOGNAME': 'cltbld', 05:15:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:15:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:50 INFO - 'MOZ_NO_REMOTE': '1', 05:15:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:15:50 INFO - 'NO_EM_RESTART': '1', 05:15:50 INFO - 'PAGER': '/bin/cat', 05:15:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:50 INFO - 'PWD': '/builds/slave/test', 05:15:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:15:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:50 INFO - 'SHELL': '/bin/bash', 05:15:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VItqKtS5rG/Listeners', 05:15:50 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 05:15:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:50 INFO - 'USER': 'cltbld', 05:15:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:50 INFO - 'XPC_FLAGS': '0x0', 05:15:50 INFO - 'XPC_SERVICE_NAME': '0', 05:15:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GxG6j7tfTmibZPC6Vf9bmw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0137', '--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 05:15:50 INFO - mozversion application_buildid: 20160405030214 05:15:50 INFO - mozversion application_changeset: d9f50aa0a1aaf90499b85c31e0f329b762e80fdd 05:15:50 INFO - mozversion application_display_name: Nightly 05:15:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:15:50 INFO - mozversion application_name: Firefox 05:15:50 INFO - mozversion application_remotingname: firefox 05:15:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:15:50 INFO - mozversion application_vendor: Mozilla 05:15:50 INFO - mozversion application_version: 48.0a1 05:15:50 INFO - mozversion platform_buildid: 20160405030214 05:15:50 INFO - mozversion platform_changeset: d9f50aa0a1aaf90499b85c31e0f329b762e80fdd 05:15:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:15:50 INFO - mozversion platform_version: 48.0a1 05:15:50 INFO - using testdate: 1459858550 05:15:50 INFO - actual date: 1459858550 05:15:50 INFO - starting webserver on 'localhost:49278' 05:15:50 INFO - SUITE-START | Running 2 tests 05:15:50 INFO - TEST-START | dromaeo_css 05:15:50 INFO - operating with platform_type : mac_ 05:15:50 INFO - Initialising browser for dromaeo_css test... 05:15:50 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/tmpnLxFhC/profile http://localhost:49278/getInfo.html) 05:15:53 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 05:15:53 INFO - PROCESS | 1658 | colorDepth:24 05:15:53 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 05:15:53 INFO - PROCESS | 1658 | __metrics 05:15:53 INFO - PROCESS | 1658 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:15:53 ERROR - PROCESS | 1658 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:15:53 INFO - TEST-INFO | 1658: exit 0 05:15:53 INFO - Browser initialized. 05:15:53 INFO - Running cycle 1/1 for dromaeo_css test... 05:15:53 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/tmpnLxFhC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:16:05 INFO - PROCESS | 1660 | RSS: Main: 236187648 05:16:05 INFO - PROCESS | 1660 | 05:16:57 INFO - PROCESS | 1660 | 1459858617248 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:19:07 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 05:19:08 INFO - PROCESS | 1660 | RSS: Main: 340410368 05:19:08 INFO - PROCESS | 1660 | 05:22:11 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 05:22:11 INFO - PROCESS | 1660 | RSS: Main: 367390720 05:22:11 INFO - PROCESS | 1660 | 05:25:13 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 05:25:14 INFO - PROCESS | 1660 | RSS: Main: 367501312 05:25:14 INFO - PROCESS | 1660 | 05:28:16 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 05:28:17 INFO - PROCESS | 1660 | RSS: Main: 325398528 05:28:17 INFO - PROCESS | 1660 | 05:31:20 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 05:31:20 INFO - PROCESS | 1660 | RSS: Main: 329023488 05:31:20 INFO - PROCESS | 1660 | 05:34:23 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 05:34:23 INFO - PROCESS | 1660 | RSS: Main: 384126976 05:34:23 INFO - PROCESS | 1660 | 05:34:23 INFO - PROCESS | 1660 | __start_tp_report 05:34:23 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 05:34:23 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 05:34:23 INFO - PROCESS | 1660 | |i|pagename|runs| 05:34:23 INFO - PROCESS | 1660 | |0;dojo.html;3422.2984288220914;3487.9476807847873;3523.0663874073357;3525.242072954315;3562.1094726318406;5568.888622227563;5648.661080335172;5734.4265573442635;5747.568932330077;5748.827535173947;5633.380328163909;5690.743916523756;5700.6579605223715;5710.486056254937;5715.514181294595;5177.119889618755;5184.662996905189;5213.061648903196;5217.165253559431;5274.235235890794;5271.077561426754;5279.894402111955;5282.894342113155;5290.0477913975465;5291.814786482474;5164.974175129119;5202.089634313998;5214;5224.268602395668;5274.498922602365;5223.660462069973;5259.815906443295;5274.604404669627;5282.181261904411;5313.521783039545;5025.6733312334945;5143.022825663112;5178.533931946143;5195.350581177353;5234.7120908350025;4552.9772351138035;5523.171524271352;5546.611737178399;5555.8888822223735;5673.149027645845;6178.814635560895;6186.164867742842;6188.87622247557;6196.194494715658;6204.968975155095;6121.387861213888;6169.321374648785;6201.317855035943;6263.843403914893;6324.683765811737;5758.049921762946;5763.308402991668;5766.481016708516;5770.076787713946;5778.797742079007;5561.499465048084;6015.39846015395;6275.1842260506755;6289.779857704958;6313.96843015782;5996.640201587918;6088.056351265561;6145.231846019247;6145.279321789906;6164.321924588292;6091.269047714302;6101.556509355996;6107.15847211733;6120.873812997669;6129.786714141072;5968.403159683997;6002.54980876436;6020.69896505173;6078.483328917092;6085.148079268906;6091.116788065706;6100.127044624488;6166.669153226816;6210.285817131088;6212.285587157535;4841.515848415131;4844.103840789465;4846.951530484721;4877.146499362598;4898.118338698997;4283.421738065384;4407.735535867858;4408.691391602557;4412.0734645724115;4413.624841888475;5044.394672639307;5288.68267903927;5598.888022239533;5607.831765047055;5620.887582248332;6125.754969801247;6174.073888916699;6174.783882564088;6176.81469555914;6178.351273116348;5502.669839809624;5616.6068375213345;5639.210510528529;5661.094224923992;5680.801171958961;5315.096433606296;5333.519983201453;5335.039692855245;5339.3058902342445;5347.973260133675;5676.751114754665;5968.194293770459;6297.244330680348;6308.653024083719;6385.521085918482;6145.84635384119;6174.228221472316;6189.288231853395;6194.628322300677;6200.627962322275;6263.68681565929;6272.6236425814595;6289.308176100534;6308.432241098323;6311.526635502264;6119.44924956756;6162.7534898605345;6162.907556386568;6163.9383606163365;6183.412575805291;6071.7571297147615;6136;6190.535709821871;6250.624962502265;6284.968575157095;5805.274340707411;6081.908771368521;6112.868254063078;6129.664444256008;6134.834601026268;5976.491998180203;5983.431574000463;5994.790182343771;6004.609700369462;6027.30685971119;5750.482456578928;5766;5798.391168927371;5846.386129456346;5879.2944846618675;6035.78874739382;6055.878882422415;6080.604760690541;6084.361142080018;6100.1154832548145;5825.50483208915;5828.271466066742;5846.9183201107935;5862.472377486047;5871.266091738533 05:34:23 INFO - PROCESS | 1660 | |1;ext.html;494.81245011971265;542.5930552085936;579.2643342954448;632.1308201223318;632.336047150492;33795;38368.04079898001;38964.415533767016;39009.41485877714;39130.021749456275;41706.58293417065;42024;42284.15431691364;42351.78824105875;42455.575444245624;9381.15569598736;9589.041095890425;9604.135627793497;9604.951975240114;9643.421394716304;9361.110694484047;9567.521623918776;9589.328746987714;9667.854982175239;9682.273829462818;9508.667196648119;9666.75833104171;9691.224702023821;9698.369605975624;9724.416535007887;9478.241740660731;9656.662016829412;9666.130048295618;9666.854997175047;9690.612375504972;9532.714018579454;9652.227821774311;9660.661876834278;9665.226781857435;9667.371620844622;40149;40569.391459128135;40598.18803623941;40622.796886015676;40690.59309406898;3267.8202698851555;3353.3796247694254;3438.7420943429343;3456.3605732939236;3717.931734887604;28679.28301792451;28803.711962880312;28878;28990.565141522893;29559.113226603236;2582.780463660591;2662.1081937550944;2680.67831860178;2692.421129457176;2735.3161709572605;489252;490895;491011.544942273;491177;492099.53950230737;44955.55044449579;63335.683321584016;63531.36468635254;63775.72448551096;63866;44577.777111114236;44859.77570112129;44874.55125448769;44904;44920.87697807515;15146.318415671321;15472.994255373365;15502.5349239523;15503.612409689622;15505.922470387575;12398.194117382522;12472.563460278847;12507.187032842836;12507.93746031264;12540.498380064695;14398.640033999025;14419.567412977627;14744.631384215267;14765.12730953186;14973;4978.726170060609;6069.968105422089;6235.345288744707;6243.843903902439;6252.249730032425;900.2348004196381;945.2626950978248;1023.9283250172416;1066.6106870992187;1078.0890147825075;28574.714252857622;29001.85499072491;29235.877091245748;29639.407211856073;29710.702892970792;1070.1652710885521;1075.5643964194514;1081.0594782539242;1118.0887576625025;1175.2772045192146;14759;14786.260686965608;15172.468963586221;15186.924065379824;15244.618884527976;474290;480364;481851.18148818065;482085;484004;58513.829723405295;59170.704146478995;59217;59259;59559.404405955385;1343.3887581150552;1376.1880490510646;1453.6365908522869;1464.6704491489543;1590.9443169489011;24073.27780166598;27738.583921240795;28479.43041139207;29688.55467167951;29867.402651946406;47255.763721181174;47411;47776.7611161942;47836.52163478321;47842.760786195846;336887;338958;339094;340180;340237;28093.157205283875;32077.518837217925;32992.67007329992;33087.66912330846;33102.50346244856;33740;41025.384619230135;41394.79302603468;41408.58591414047;43113;34732.65267347294;34923.65076349305;35324;35400.645993539736;35683;33767.662323376455;33782;34350;34458.82770586131;36375.45436818397;35675.46486802752;35818.10454738548;36004.4599331005;37398.8130059348;38551.03622409462;30820.69179308268;31417.37165256728;31424.685753142177;31436.685633143377;31485.685143148276;23395;23978.40053998664;24048.51902961896;24135.275941721775;24185.75814241835 05:34:23 INFO - PROCESS | 1660 | |2;jquery.html;357.3478401916502;360.5817251987695;361.9366610843102;366.7048026338798;371.1871002504513;19248.037598120092;19716.70424943627;21287;21326.89336553315;21350.145994160233;12275.14074014817;17855.19651615677;19778.40664780055;20541.281055163072;20580.176792928265;4578.97710511447;5150.484951504847;5257.316548848645;5338.973305133488;5343.1985202219785;3909.706771992098;4103.589641035887;5267.341582302212;7048.577085374868;7637.350825179867;7180.964095179516;7588.468807183499;7595.924040759604;7612.314891659749;7614.505057171294;7354.705811767523;7392.7042918283205;7407.370373518257;7410.888836667455;7421.962890185541;4409.933850992237;4544.113897789933;6750.122484077087;6971.6862741176765;7066.364027237573;25920;26011.21966340994;26539.46921061568;26850;26917.596236056474;2088.697138914849;2473.1467643663086;2680.383511792279;3093.9845300773577;3265.510173473974;12423.93788031063;14832.25838708071;15940;16638.417655382123;16955.406560770436;1816.5277027972822;1828.7622609060736;1919.299455698674;1934.8161924617139;2039.7552293724848;109929.90070099276;110885;113439;113750.43124784488;115961;18568.907155464138;18682.813171868107;18971;19021.953792541266;19041.42875713731;28937;28982.85508572486;29040;29069.273268168043;29095;10260.127889129359;10605.045545900906;10612.25714200014;10634.30876992993;10768.030877221088;8953.820923581492;8978.191962723386;8982.775430614287;9071.546422678839;9132.99537050924;8423.368247381472;8544.40189186751;8554.91445085541;8583.141685831368;8596.8710469343;2790.8465034423302;3336.5819526701057;3360.7479439042168;3417.7778444401033;3484.5121682964404;382.63267263426866;435.97602131882417;768.7386288661882;872.3631748823394;962.6042238753695;11127.054200392895;11677.76644467123;11792.41037948099;11798.941005294919;12027.21823081497;398.94081214375876;411.36444193720774;444.6154076723611;450.33800313539047;452.97735113244204;6033.426824451758;6057.515398768088;6192.040233763774;6220.34686357935;6227.626342419469;245181;245374;245729;446436;517624;117173;118183.40908295404;120921;123573.38213309056;123594.38202809109;456.6301295950291;465.85325622428826;468.0428523669105;471.0437811243182;472.16662590527744;10718.73203169927;10938.289011214245;11079.279846809932;11208.719782005515;11220.66338009861;47485.69947980028;48004.75997620129;48363.516364837305;48385.75807120942;48892.75553622209;71125.64437177988;72821;73607.89588156075;73926;73991.63004184945;7816.570088644951;7817.0619525657285;7889.921100788919;7929.5242285463055;8223.876641850258;9867.55595998196;12272.668193043293;12619.87380126187;12801.10392272532;12867.163634363736;10086.596536138471;10588.84116738265;10886.455677216265;11099.334039957628;11150.442477876237;10305.53625086888;10360.533775979948;10468.371897686164;10506;10577.36535807854;10463.424511651932;10574.206934479791;10966.780664386828;11168.38573878412;11196.94401527987;6313.43179113882;7914.722984695508;7965.322947549524;7977.242161994601;8036.276735093869;10702.020126276664;10813.67558973232;11005.449727513753;11123.997680417602;11189.776204476027 05:34:23 INFO - PROCESS | 1660 | |3;mootools.html;1354.884834789043;1611.5326555298964;1821.5628249220192;1967.4687834284753;2001.2295266322471;8739.038705742363;8825.338099642537;8942.821143577125;8960.103989601044;8961.238294744939;7872.0947091084545;8078.151794061612;8424.663013479454;8644.956775216131;8722.738317850459;2473.072597775834;2511.196417146514;2517.5342561626157;2519.1560827122844;2523.3313172009434;2229.0972156276734;2479.938001549958;2563.7051739049966;2564.7178810330847;2570.8714564271804;2225.1321984426086;2411.8552886826847;2482.515909397668;2483.466054798218;2484.006397441029;2206.7131272934575;2303.9424014399606;2468.2101727447225;2482.156066937232;2482.3049546127113;2076.3459510254374;2240.932772016842;2324.418895276181;2364.2670772060546;2383.654370116341;8579.785505362353;8676.219140277342;8687.739367818975;8689.56552172389;8834.293256539462;5430.212619170198;5661.830145095653;5683.772649094031;5688.914666280009;5708.058170401879;3622.5652921649307;3711.183539621279;3747;3776.9433458498142;3789.4315852622326;1042.1089968077335;1056.7410984308895;1069.8823129455754;1071.132382769959;1079.4117206122683;12010.339431331273;12215.633530994084;12221.69445763863;12225.327606981613;12247.816282755677;4930.93984793264;4933;5034.924476132861;5046.798128074836;5060.7722652480725;10290.176785857113;10310.381377117397;10317.587296508205;10320.741981450374;10323.793524129625;4603.516630753789;5180.637355385163;5565.2486914266865;5576.665400076008;5576.972115139399;4163.437935878617;4958.231474121517;5004.074246264453;5006.374203224597;5008.198688209869;3436.639152888961;3786.469894214812;3808.8857334280015;3839.7504162229366;3839.9040023999623;1125.6566747142037;1138.1691365303375;1139.7777433400572;1145.3128123126057;1189.4647408666135;1033.178622994721;1100.9394483303336;1179.823026546008;1183.3964678014102;1228.1280290993316;8016.398770092266;8071.515709057476;8171.591420428955;8180.83638327242;8225.753227403187;1134.8411222428867;1166.288563975974;1209.2865209526421;1211.8606360268507;1233.3155098920006;6232.439080482778;6236.438720515175;6241.032639940817;6252;6259.71831267594;10058.698239052841;10462.110720588684;10473.214508911862;10503.842442363371;10584.57661693539;10062.24533160016;10443.530041148015;10473.109785668303;10484.26610137283;10488.947555262328;8122;8230.588470576567;8360.790980225544;8364.916350836414;8371.665133394717;6453.967730161507;7739.110002349802;8057.5165490070785;8136.87794683092;8142.18578142181;9434.386764860263;9459.810803783748;9497.43015419077;9497.525123743648;9521.523923803921;8336.29141522953;8745.256653184551;9797.118259356692;9956.103950644478;9970.900290996997;7451.850962980819;7526.9623651883585;7573.2048134945035;7623.504472209289;7626.923730762622;8056.919430805617;8199.0980992092;8210.876836847332;8314.584270786558;8356.122607126164;6480.189976252968;7395.7041718330665;7397.593132377771;7494.138174109829;7554.093508778982;6028.186194863637;7256.7822965311125;7312.670929808278;7333.413326933939;7397.075365579302;7575.204603516771;7722.3049925506975;7734.8839767402405;7737.690492380242;7738.2261773822165;6901.827454313682;7011.1586609607175;7021;7022.754203602849;7023.297670232936;6811.761588344384;7065.328793764585;7066.010758493712;7087.7164913402885;7092.290770922867 05:34:23 INFO - PROCESS | 1660 | |4;prototype.html;312.1353849835953;318.4999550705393;318.99202519937;327.08579520240926;327.508736894658;6335.524835637329;6518.804435866919;6544.312847151046;6574.145361103062;6587.967060164705;6323.557350985433;6506.284308726036;6549.312322206171;6558.147440832697;6570.014497825328;4580.656450766189;4664.463586687523;4704.6001089907395;4787.186178349689;4819.855404337875;4756.215224487973;4762.6428017898625;4790.281457781326;4793.712377257376;4795.976020119894;4718.834840780573;4738.97630511847;4745.90508189836;4751.40607424072;4782.856514304576;4531.796069176895;4569.543045695421;4713.952860471386;4716.575508204278;4729.408823897013;3602.423612222058;3762.097096696773;4020.2763502569524;4036.616521430459;4057.411675307064;4889.584385327252;6204.81385558434;6252.6561039142825;6320.304766475684;6405.967970160119;5471.124620060811;5480.314960629921;5486.561075113981;5501.14732216503;5502.394736579013;6822.079019332426;6840.589564626139;6843.349881761224;6851.280615535346;6855.211650660188;4302.935455968163;4456.821727130911;4481.955180448219;4490.685652004361;4499.460064792213;7148.642567871586;7215.639218039077;7228.746993855189;7229.2047874733735;7241;4535.818567257273;4541.954580454153;4549.909001819945;4562.749048802281;4565.292379681155;3726.900564333528;3855.51806024247;4632.814687412533;4641.8375356863025;4646.97676511622;5480.698561579072;5488.423715509894;5489.615726899158;5495.53287970527;5499.945000550023;6121.357257487989;6610.041543976096;6656.83357916056;6921.965390173118;6925.099737034153;1574.4332040465424;1598.0811033655461;1609.91145486997;1613.0805440898575;1614.9111798851177;958.9520523973773;1014.6905193915926;1020.3928662445833;1035.4770840725384;1040.6409788622914;6161.260648722182;6284.497240220863;6443.742250309935;6481.740730370732;6498.122753428322;7129.18014428337;7155.141383034069;7223.133224013047;7223.602701851449;7261.455390845707;6433.517486188554;6448.871022579522;6457.741690332428;6470.22357317125;6474.028895665594;3764.284785890672;3801.7148713846573;3808.5429748430365;3815;3821.7898015609408;7214.170370407471;7539.607176770475;7562.773116806505;7568.735094271674;7579.734709285149;7444.367228785505;7446.702131914771;7456.40348772097;7477.513961592588;7484.32641062307;7538.811529711801;7547.207543207994;7551.093868735787;7552.169261381244;7561.281678240558;6977.825554361181;7213.944025952578;7216.1340639121545;7218.205997340184;7255.274472552703;7115;7119.786406407816;7124.893126603209;7135.714571417086;7139.964300178466;7440.479166458296;7523.623818808928;7534.54792712439;7535.660895259617;7536.8492630148185;4697.6711630185555;4756.310335001474;4762.618990480684;4768.094062128184;4772.093302272557;7172.426205903619;7176;7177.461690373348;7190.532615379983;7209.531380460253;6651.700673469609;6923.411510021705;6934.549254298455;6947.4789390796905;6992.685329160098;6888.724451021903;6957.234704182435;6977.406920411619;6984.546004509691;7005.404540614105;6812.863742725217;6814;6818.18181818185;6827.146606674166;6827.863442731018;6751.265312110282;6905.75829845953;6992.860142797013;7003.089598352181;7012.403945664676;6531.738730450728;6661.1340525733285;6743.819831529365;6828.419584335387;6842.657867106725 05:34:23 INFO - PROCESS | 1660 | |5;yui.html;680.7447207297264;738.4535443771609;741.9851602967941;749.8237914090184;758.3667637522668;14665.340059697313;14843.332050057747;14991.925040374797;15373.692526149498;15401.845981540182;14065;14217.146971181737;14273.357698903548;14276.78584821226;14284.142951422922;725.891116332549;738.0331765387333;901.8917729872425;920.5627327019679;922.2022950148107;895.1630225738922;916.8670542771295;919.246218101154;919.7102912582549;921.9539023048854;917.1287277086761;967.5162418790604;973.4694591447678;974.848898420746;976.653288082731;760.1903972269542;947.9336446448751;969.6121551379434;970.2092794372599;970.9805803883953;723.2911746488418;724.768074216251;725.4522835259345;725.4885305859409;726.7565365602529;15093.849061509354;15142.621434464116;15170.848291517164;15171.317290721943;15201.619959500991;12203.633890983285;12263.26420414778;12395;12597.93701031489;12680.74638507234;9376.578053987587;9844.409335439825;9946.950265248699;10239.539220735085;10433.843492347545;3530.6116327203986;3600.531930848973;3613.512175856278;3681.7238707097076;3711.4432835074685;69534.30465695329;71983;72259.19352016241;72391.55216895686;73020;9408.388454750419;9412.058794120534;9443.055694430639;9512.762180945394;9577.712668619952;20681;20688.689669654967;20693.89653051725;20726.378208653765;20729.378118656463;7343.118825740945;7437.85124297511;7531.435142364345;7588.62056897153;7763.9611801941755;3449.2411669432686;3502.9474557881144;3964.4053391991433;4030.7984600769846;4061;3345.531625572422;3373.2916087621875;3388.7119594834717;3389.1527118220447;3392.609849867297;643.1478291264094;655.3184687924601;656.8160914943824;664.0802488553388;680.8604236131581;480.38510706295995;576.7692922830901;577.1198921644442;601.0203368509389;624.6907780648518;8073.19268073188;8089.878651820228;8116.228958248957;8191.5921840592555;8219.2050858733;563.8336690676178;591.6568390333596;593.4243783529969;615.2831950777384;618.5299172628835;3661.56061272649;3701.9444708329397;3735.5143831301757;3805.3911374179997;3808.409696497047;88374;88630.25523316336;89030.55484722664;89219.55390223008;89717.55141224252;75030;75923;76189.47621047548;76225;78483;49414.50585494171;50601.74699126481;65553.67223163854;66587;69342.65328673324;7549.396048316012;7569.091708994735;7633.389328853567;7752.302292793675;7949.92050079515;48853.755731221114;48990.02019959652;49583.256251156985;50322;50360.24459633182;61471.77056458935;65889;66287.33712662812;67396.6630166846;67480.6625966867;9813.214942804416;9858.408495490294;9923.40459572428;10042.89957100449;10169.44068076263;10694.73263168427;10791.460426978463;10852.294600850919;10882.238243322892;11839.58561450345;10181.236407269633;10194.847077293698;10216.182705383402;10238.692839214835;10608.734781630521;10269.127124194527;10499.895001049892;10505.212109091695;10609.840852387066;10625.734356640836;9805.607775689177;10072.143867771321;10105.9494702526;10146.391216527032;10381.429021403896;8549.401541892008;8702.695405660772;8804.823903521765;9004.504752238428;9090.636374544943;8694.695685650971;8726.171013753938;8765.956170219108;8941.37410381293;8951.641934322553 05:34:23 INFO - PROCESS | 1660 | __end_tp_report 05:34:23 INFO - PROCESS | 1660 | __start_cc_report 05:34:23 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,1199 05:34:23 INFO - PROCESS | 1660 | __end_cc_report 05:34:23 INFO - PROCESS | 1660 | __startTimestamp1459859663868__endTimestamp 05:34:23 INFO - PROCESS | 1660 | 05:34:23 INFO - PROCESS | 1660 | ------- Summary: start ------- 05:34:23 INFO - PROCESS | 1660 | Number of tests: 6 05:34:23 INFO - PROCESS | 1660 | 05:34:23 INFO - PROCESS | 1660 | [#0] dojo.html Cycles:165 Average:5684.30 Median:5828.27 stddev:611.35 (10.5%) stddev-sans-first:586.91 05:34:23 INFO - PROCESS | 1660 | Values: 3422.3 3487.9 3523.1 3525.2 3562.1 5568.9 5648.7 5734.4 5747.6 5748.8 5633.4 5690.7 5700.7 5710.5 5715.5 5177.1 5184.7 5213.1 5217.2 5274.2 5271.1 5279.9 5282.9 5290.0 5291.8 5165.0 5202.1 5214.0 5224.3 5274.5 5223.7 5259.8 5274.6 5282.2 5313.5 5025.7 5143.0 5178.5 5195.4 5234.7 4553.0 5523.2 5546.6 5555.9 5673.1 6178.8 6186.2 6188.9 6196.2 6205.0 6121.4 6169.3 6201.3 6263.8 6324.7 5758.0 5763.3 5766.5 5770.1 5778.8 5561.5 6015.4 6275.2 6289.8 6314.0 5996.6 6088.1 6145.2 6145.3 6164.3 6091.3 6101.6 6107.2 6120.9 6129.8 5968.4 6002.5 6020.7 6078.5 6085.1 6091.1 6100.1 6166.7 6210.3 6212.3 4841.5 4844.1 4847.0 4877.1 4898.1 4283.4 4407.7 4408.7 4412.1 4413.6 5044.4 5288.7 5598.9 5607.8 5620.9 6125.8 6174.1 6174.8 6176.8 6178.4 5502.7 5616.6 5639.2 5661.1 5680.8 5315.1 5333.5 5335.0 5339.3 5348.0 5676.8 5968.2 6297.2 6308.7 6385.5 6145.8 6174.2 6189.3 6194.6 6200.6 6263.7 6272.6 6289.3 6308.4 6311.5 6119.4 6162.8 6162.9 6163.9 6183.4 6071.8 6136.0 6190.5 6250.6 6285.0 5805.3 6081.9 6112.9 6129.7 6134.8 5976.5 5983.4 5994.8 6004.6 6027.3 5750.5 5766.0 5798.4 5846.4 5879.3 6035.8 6055.9 6080.6 6084.4 6100.1 5825.5 5828.3 5846.9 5862.5 5871.3 05:34:23 INFO - PROCESS | 1660 | 05:34:23 INFO - PROCESS | 1660 | [#1] ext.html Cycles:180 Average:57896.75 Median:36189.96 stddev:117500.64 (324.7%) stddev-sans-first:117751.22 05:34:23 INFO - PROCESS | 1660 | Values: 494.8 542.6 579.3 632.1 632.3 33795.0 38368.0 38964.4 39009.4 39130.0 41706.6 42024.0 42284.2 42351.8 42455.6 9381.2 9589.0 9604.1 9605.0 9643.4 9361.1 9567.5 9589.3 9667.9 9682.3 9508.7 9666.8 9691.2 9698.4 9724.4 9478.2 9656.7 9666.1 9666.9 9690.6 9532.7 9652.2 9660.7 9665.2 9667.4 40149.0 40569.4 40598.2 40622.8 40690.6 3267.8 3353.4 3438.7 3456.4 3717.9 28679.3 28803.7 28878.0 28990.6 29559.1 2582.8 2662.1 2680.7 2692.4 2735.3 489252.0 490895.0 491011.5 491177.0 492099.5 44955.6 63335.7 63531.4 63775.7 63866.0 44577.8 44859.8 44874.6 44904.0 44920.9 15146.3 15473.0 15502.5 15503.6 15505.9 12398.2 12472.6 12507.2 12507.9 12540.5 14398.6 14419.6 14744.6 14765.1 14973.0 4978.7 6070.0 6235.3 6243.8 6252.2 900.2 945.3 1023.9 1066.6 1078.1 28574.7 29001.9 29235.9 29639.4 29710.7 1070.2 1075.6 1081.1 1118.1 1175.3 14759.0 14786.3 15172.5 15186.9 15244.6 474290.0 480364.0 481851.2 482085.0 484004.0 58513.8 59170.7 59217.0 59259.0 59559.4 1343.4 1376.2 1453.6 1464.7 1590.9 24073.3 27738.6 28479.4 29688.6 29867.4 47255.8 47411.0 47776.8 47836.5 47842.8 336887.0 338958.0 339094.0 340180.0 340237.0 28093.2 32077.5 32992.7 33087.7 33102.5 33740.0 41025.4 41394.8 41408.6 43113.0 34732.7 34923.7 35324.0 35400.6 35683.0 33767.7 33782.0 34350.0 34458.8 36375.5 35675.5 35818.1 36004.5 37398.8 38551.0 30820.7 31417.4 31424.7 31436.7 31485.7 23395.0 23978.4 24048.5 24135.3 24185.8 05:34:23 INFO - PROCESS | 1660 | 05:34:23 INFO - PROCESS | 1660 | [#2] jquery.html Cycles:180 Average:27569.70 Median:16094.49 stddev:62896.60 (390.8%) stddev-sans-first:63039.86 05:34:23 INFO - PROCESS | 1660 | Values: 357.3 360.6 361.9 366.7 371.2 19248.0 19716.7 21287.0 21326.9 21350.1 12275.1 17855.2 19778.4 20541.3 20580.2 4579.0 5150.5 5257.3 5339.0 5343.2 3909.7 4103.6 5267.3 7048.6 7637.4 7181.0 7588.5 7595.9 7612.3 7614.5 7354.7 7392.7 7407.4 7410.9 7422.0 4409.9 4544.1 6750.1 6971.7 7066.4 25920.0 26011.2 26539.5 26850.0 26917.6 2088.7 2473.1 2680.4 3094.0 3265.5 12423.9 14832.3 15940.0 16638.4 16955.4 1816.5 1828.8 1919.3 1934.8 2039.8 109929.9 110885.0 113439.0 113750.4 115961.0 18568.9 18682.8 18971.0 19022.0 19041.4 28937.0 28982.9 29040.0 29069.3 29095.0 10260.1 10605.0 10612.3 10634.3 10768.0 8953.8 8978.2 8982.8 9071.5 9133.0 8423.4 8544.4 8554.9 8583.1 8596.9 2790.8 3336.6 3360.7 3417.8 3484.5 382.6 436.0 768.7 872.4 962.6 11127.1 11677.8 11792.4 11798.9 12027.2 398.9 411.4 444.6 450.3 453.0 6033.4 6057.5 6192.0 6220.3 6227.6 245181.0 245374.0 245729.0 446436.0 517624.0 117173.0 118183.4 120921.0 123573.4 123594.4 456.6 465.9 468.0 471.0 472.2 10718.7 10938.3 11079.3 11208.7 11220.7 47485.7 48004.8 48363.5 48385.8 48892.8 71125.6 72821.0 73607.9 73926.0 73991.6 7816.6 7817.1 7889.9 7929.5 8223.9 9867.6 12272.7 12619.9 12801.1 12867.2 10086.6 10588.8 10886.5 11099.3 11150.4 10305.5 10360.5 10468.4 10506.0 10577.4 10463.4 10574.2 10966.8 11168.4 11196.9 6313.4 7914.7 7965.3 7977.2 8036.3 10702.0 10813.7 11005.4 11124.0 11189.8 05:34:23 INFO - PROCESS | 1660 | 05:34:23 INFO - PROCESS | 1660 | [#3] mootools.html Cycles:180 Average:6024.95 Median:5120.70 stddev:3171.63 (61.9%) stddev-sans-first:3161.10 05:34:23 INFO - PROCESS | 1660 | Values: 1354.9 1611.5 1821.6 1967.5 2001.2 8739.0 8825.3 8942.8 8960.1 8961.2 7872.1 8078.2 8424.7 8645.0 8722.7 2473.1 2511.2 2517.5 2519.2 2523.3 2229.1 2479.9 2563.7 2564.7 2570.9 2225.1 2411.9 2482.5 2483.5 2484.0 2206.7 2303.9 2468.2 2482.2 2482.3 2076.3 2240.9 2324.4 2364.3 2383.7 8579.8 8676.2 8687.7 8689.6 8834.3 5430.2 5661.8 5683.8 5688.9 5708.1 3622.6 3711.2 3747.0 3776.9 3789.4 1042.1 1056.7 1069.9 1071.1 1079.4 12010.3 12215.6 12221.7 12225.3 12247.8 4930.9 4933.0 5034.9 5046.8 5060.8 10290.2 10310.4 10317.6 10320.7 10323.8 4603.5 5180.6 5565.2 5576.7 5577.0 4163.4 4958.2 5004.1 5006.4 5008.2 3436.6 3786.5 3808.9 3839.8 3839.9 1125.7 1138.2 1139.8 1145.3 1189.5 1033.2 1100.9 1179.8 1183.4 1228.1 8016.4 8071.5 8171.6 8180.8 8225.8 1134.8 1166.3 1209.3 1211.9 1233.3 6232.4 6236.4 6241.0 6252.0 6259.7 10058.7 10462.1 10473.2 10503.8 10584.6 10062.2 10443.5 10473.1 10484.3 10488.9 8122.0 8230.6 8360.8 8364.9 8371.7 6454.0 7739.1 8057.5 8136.9 8142.2 9434.4 9459.8 9497.4 9497.5 9521.5 8336.3 8745.3 9797.1 9956.1 9970.9 7451.9 7527.0 7573.2 7623.5 7626.9 8056.9 8199.1 8210.9 8314.6 8356.1 6480.2 7395.7 7397.6 7494.1 7554.1 6028.2 7256.8 7312.7 7333.4 7397.1 7575.2 7722.3 7734.9 7737.7 7738.2 6901.8 7011.2 7021.0 7022.8 7023.3 6811.8 7065.3 7066.0 7087.7 7092.3 05:34:23 INFO - PROCESS | 1660 | 05:34:23 INFO - PROCESS | 1660 | [#4] prototype.html Cycles:180 Average:5670.82 Median:6489.93 stddev:1833.68 (28.3%) stddev-sans-first:1794.17 05:34:23 INFO - PROCESS | 1660 | Values: 312.1 318.5 319.0 327.1 327.5 6335.5 6518.8 6544.3 6574.1 6588.0 6323.6 6506.3 6549.3 6558.1 6570.0 4580.7 4664.5 4704.6 4787.2 4819.9 4756.2 4762.6 4790.3 4793.7 4796.0 4718.8 4739.0 4745.9 4751.4 4782.9 4531.8 4569.5 4714.0 4716.6 4729.4 3602.4 3762.1 4020.3 4036.6 4057.4 4889.6 6204.8 6252.7 6320.3 6406.0 5471.1 5480.3 5486.6 5501.1 5502.4 6822.1 6840.6 6843.3 6851.3 6855.2 4302.9 4456.8 4482.0 4490.7 4499.5 7148.6 7215.6 7228.7 7229.2 7241.0 4535.8 4542.0 4549.9 4562.7 4565.3 3726.9 3855.5 4632.8 4641.8 4647.0 5480.7 5488.4 5489.6 5495.5 5499.9 6121.4 6610.0 6656.8 6922.0 6925.1 1574.4 1598.1 1609.9 1613.1 1614.9 959.0 1014.7 1020.4 1035.5 1040.6 6161.3 6284.5 6443.7 6481.7 6498.1 7129.2 7155.1 7223.1 7223.6 7261.5 6433.5 6448.9 6457.7 6470.2 6474.0 3764.3 3801.7 3808.5 3815.0 3821.8 7214.2 7539.6 7562.8 7568.7 7579.7 7444.4 7446.7 7456.4 7477.5 7484.3 7538.8 7547.2 7551.1 7552.2 7561.3 6977.8 7213.9 7216.1 7218.2 7255.3 7115.0 7119.8 7124.9 7135.7 7140.0 7440.5 7523.6 7534.5 7535.7 7536.8 4697.7 4756.3 4762.6 4768.1 4772.1 7172.4 7176.0 7177.5 7190.5 7209.5 6651.7 6923.4 6934.5 6947.5 6992.7 6888.7 6957.2 6977.4 6984.5 7005.4 6812.9 6814.0 6818.2 6827.1 6827.9 6751.3 6905.8 6992.9 7003.1 7012.4 6531.7 6661.1 6743.8 6828.4 6842.7 05:34:23 INFO - PROCESS | 1660 | 05:34:23 INFO - PROCESS | 1660 | [#5] yui.html Cycles:180 Average:17338.55 Median:66088.17 stddev:24192.67 (36.6%) stddev-sans-first:24228.20 05:34:23 INFO - PROCESS | 1660 | Values: 680.7 738.5 742.0 749.8 758.4 14665.3 14843.3 14991.9 15373.7 15401.8 14065.0 14217.1 14273.4 14276.8 14284.1 725.9 738.0 901.9 920.6 922.2 895.2 916.9 919.2 919.7 922.0 917.1 967.5 973.5 974.8 976.7 760.2 947.9 969.6 970.2 971.0 723.3 724.8 725.5 725.5 726.8 15093.8 15142.6 15170.8 15171.3 15201.6 12203.6 12263.3 12395.0 12597.9 12680.7 9376.6 9844.4 9947.0 10239.5 10433.8 3530.6 3600.5 3613.5 3681.7 3711.4 69534.3 71983.0 72259.2 72391.6 73020.0 9408.4 9412.1 9443.1 9512.8 9577.7 20681.0 20688.7 20693.9 20726.4 20729.4 7343.1 7437.9 7531.4 7588.6 7764.0 3449.2 3502.9 3964.4 4030.8 4061.0 3345.5 3373.3 3388.7 3389.2 3392.6 643.1 655.3 656.8 664.1 680.9 480.4 576.8 577.1 601.0 624.7 8073.2 8089.9 8116.2 8191.6 8219.2 563.8 591.7 593.4 615.3 618.5 3661.6 3701.9 3735.5 3805.4 3808.4 88374.0 88630.3 89030.6 89219.6 89717.6 75030.0 75923.0 76189.5 76225.0 78483.0 49414.5 50601.7 65553.7 66587.0 69342.7 7549.4 7569.1 7633.4 7752.3 7949.9 48853.8 48990.0 49583.3 50322.0 50360.2 61471.8 65889.0 66287.3 67396.7 67480.7 9813.2 9858.4 9923.4 10042.9 10169.4 10694.7 10791.5 10852.3 10882.2 11839.6 10181.2 10194.8 10216.2 10238.7 10608.7 10269.1 10499.9 10505.2 10609.8 10625.7 9805.6 10072.1 10105.9 10146.4 10381.4 8549.4 8702.7 8804.8 9004.5 9090.6 8694.7 8726.2 8766.0 8941.4 8951.6 05:34:23 INFO - PROCESS | 1660 | -------- Summary: end -------- 05:34:23 INFO - PROCESS | 1660 | 05:34:24 INFO - TEST-INFO | 1660: exit 0 05:34:24 INFO - TEST-OK | dromaeo_css | took 1113437ms 05:34:24 INFO - TEST-START | kraken 05:34:24 INFO - operating with platform_type : mac_ 05:34:24 INFO - Initialising browser for kraken test... 05:34:24 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/tmpmQwRnt/profile http://localhost:49278/getInfo.html) 05:34:26 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 05:34:26 INFO - PROCESS | 1671 | colorDepth:24 05:34:26 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 05:34:26 INFO - PROCESS | 1671 | __metrics 05:34:26 INFO - PROCESS | 1671 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:34:26 ERROR - PROCESS | 1671 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:34:27 INFO - TEST-INFO | 1671: exit 0 05:34:27 INFO - Browser initialized. 05:34:27 INFO - Running cycle 1/1 for kraken test... 05:34:27 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/tmpmQwRnt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:34:39 INFO - PROCESS | 1674 | RSS: Main: 236175360 05:34:39 INFO - PROCESS | 1674 | 05:34:41 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 05:34:42 INFO - PROCESS | 1674 | RSS: Main: 282013696 05:34:42 INFO - PROCESS | 1674 | 05:34:44 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 05:34:45 INFO - PROCESS | 1674 | RSS: Main: 292589568 05:34:45 INFO - PROCESS | 1674 | 05:34:48 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 05:34:49 INFO - PROCESS | 1674 | RSS: Main: 279879680 05:34:49 INFO - PROCESS | 1674 | 05:34:51 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 05:34:51 INFO - PROCESS | 1674 | RSS: Main: 282210304 05:34:51 INFO - PROCESS | 1674 | 05:34:54 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:34:54 INFO - PROCESS | 1674 | RSS: Main: 283017216 05:34:54 INFO - PROCESS | 1674 | 05:34:57 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 05:34:57 INFO - PROCESS | 1674 | RSS: Main: 282972160 05:34:57 INFO - PROCESS | 1674 | 05:35:00 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 05:35:01 INFO - PROCESS | 1674 | RSS: Main: 283865088 05:35:01 INFO - PROCESS | 1674 | 05:35:04 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 05:35:04 INFO - PROCESS | 1674 | RSS: Main: 283373568 05:35:04 INFO - PROCESS | 1674 | 05:35:06 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:35:07 INFO - PROCESS | 1674 | RSS: Main: 316194816 05:35:07 INFO - PROCESS | 1674 | 05:35:08 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:35:09 INFO - PROCESS | 1674 | RSS: Main: 315764736 05:35:09 INFO - PROCESS | 1674 | 05:35:11 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:35:12 INFO - PROCESS | 1674 | RSS: Main: 322674688 05:35:12 INFO - PROCESS | 1674 | 05:35:14 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:35:15 INFO - PROCESS | 1674 | RSS: Main: 323760128 05:35:15 INFO - PROCESS | 1674 | 05:35:17 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:35:18 INFO - PROCESS | 1674 | RSS: Main: 324050944 05:35:18 INFO - PROCESS | 1674 | 05:35:20 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 05:35:20 INFO - PROCESS | 1674 | RSS: Main: 387444736 05:35:20 INFO - PROCESS | 1674 | 05:35:20 INFO - PROCESS | 1674 | __start_tp_report 05:35:20 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 05:35:20 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 05:35:20 INFO - PROCESS | 1674 | |i|pagename|runs| 05:35:20 INFO - PROCESS | 1674 | |0;ai-astar;110;107;110;110;111;113;117;111;109;112 05:35:20 INFO - PROCESS | 1674 | |1;audio-beat-detection;157;119;144;194;136;143;140;129;194;150 05:35:20 INFO - PROCESS | 1674 | |2;audio-dft;186;184;185;185;188;196;220;182;182;181 05:35:20 INFO - PROCESS | 1674 | |3;audio-fft;72;74;74;117;57;57;58;61;117;55 05:35:20 INFO - PROCESS | 1674 | |4;audio-oscillator;91;92;130;77;78;82;118;79;80;119 05:35:20 INFO - PROCESS | 1674 | |5;imaging-gaussian-blur;87;83;86;84;90;84;87;84;86;83 05:35:20 INFO - PROCESS | 1674 | |6;imaging-darkroom;92;94;93;94;94;93;93;96;92;93 05:35:20 INFO - PROCESS | 1674 | |7;imaging-desaturate;101;72;133;140;133;83;84;85;83;84 05:35:20 INFO - PROCESS | 1674 | |8;json-parse-financial;56;54;53;53;53;53;55;66;54;55 05:35:20 INFO - PROCESS | 1674 | |9;json-stringify-tinderbox;63;71;75;72;71;66;64;66;67;66 05:35:20 INFO - PROCESS | 1674 | |10;stanford-crypto-aes;84;83;84;83;83;83;82;84;84;85 05:35:20 INFO - PROCESS | 1674 | |11;stanford-crypto-ccm;123;126;142;109;134;127;132;140;122;119 05:35:20 INFO - PROCESS | 1674 | |12;stanford-crypto-pbkdf2;160;174;158;138;140;129;142;122;144;174 05:35:20 INFO - PROCESS | 1674 | |13;stanford-crypto-sha256-iterative;65;65;69;67;68;66;67;67;67;63 05:35:20 INFO - PROCESS | 1674 | __end_tp_report 05:35:20 INFO - PROCESS | 1674 | __start_cc_report 05:35:20 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,1278 05:35:20 INFO - PROCESS | 1674 | __end_cc_report 05:35:20 INFO - PROCESS | 1674 | __startTimestamp1459859720519__endTimestamp 05:35:20 INFO - PROCESS | 1674 | 05:35:20 INFO - PROCESS | 1674 | ------- Summary: start ------- 05:35:20 INFO - PROCESS | 1674 | Number of tests: 14 05:35:20 INFO - PROCESS | 1674 | 05:35:20 INFO - PROCESS | 1674 | [#0] ai-astar Cycles:10 Average:111.00 Median:111.00 stddev:2.67 (2.4%) stddev-sans-first:2.80 05:35:20 INFO - PROCESS | 1674 | Values: 110.0 107.0 110.0 110.0 111.0 113.0 117.0 111.0 109.0 112.0 05:35:20 INFO - PROCESS | 1674 | 05:35:20 INFO - PROCESS | 1674 | [#1] audio-beat-detection Cycles:10 Average:150.60 Median:147.00 stddev:25.17 (17.1%) stddev-sans-first:26.59 05:35:20 INFO - PROCESS | 1674 | Values: 157.0 119.0 144.0 194.0 136.0 143.0 140.0 129.0 194.0 150.0 05:35:20 INFO - PROCESS | 1674 | 05:35:20 INFO - PROCESS | 1674 | [#2] audio-dft Cycles:10 Average:188.90 Median:185.50 stddev:11.73 (6.3%) stddev-sans-first:12.40 05:35:20 INFO - PROCESS | 1674 | Values: 186.0 184.0 185.0 185.0 188.0 196.0 220.0 182.0 182.0 181.0 05:35:20 INFO - PROCESS | 1674 | 05:35:20 INFO - PROCESS | 1674 | [#3] audio-fft Cycles:10 Average:74.20 Median:59.50 stddev:23.72 (39.9%) stddev-sans-first:25.15 05:35:20 INFO - PROCESS | 1674 | Values: 72.0 74.0 74.0 117.0 57.0 57.0 58.0 61.0 117.0 55.0 05:35:20 INFO - PROCESS | 1674 | 05:35:20 INFO - PROCESS | 1674 | [#4] audio-oscillator Cycles:10 Average:94.60 Median:79.50 stddev:20.05 (25.2%) stddev-sans-first:21.22 05:35:20 INFO - PROCESS | 1674 | Values: 91.0 92.0 130.0 77.0 78.0 82.0 118.0 79.0 80.0 119.0 05:35:20 INFO - PROCESS | 1674 | 05:35:20 INFO - PROCESS | 1674 | [#5] imaging-gaussian-blur Cycles:10 Average:85.40 Median:86.00 stddev:2.22 (2.6%) stddev-sans-first:2.28 05:35:20 INFO - PROCESS | 1674 | Values: 87.0 83.0 86.0 84.0 90.0 84.0 87.0 84.0 86.0 83.0 05:35:20 INFO - PROCESS | 1674 | 05:35:20 INFO - PROCESS | 1674 | [#6] imaging-darkroom Cycles:10 Average:93.40 Median:93.50 stddev:1.17 (1.3%) stddev-sans-first:1.13 05:35:20 INFO - PROCESS | 1674 | Values: 92.0 94.0 93.0 94.0 94.0 93.0 93.0 96.0 92.0 93.0 05:35:20 INFO - PROCESS | 1674 | 05:35:20 INFO - PROCESS | 1674 | [#7] imaging-desaturate Cycles:10 Average:99.80 Median:83.00 stddev:25.56 (30.8%) stddev-sans-first:27.10 05:35:20 INFO - PROCESS | 1674 | Values: 101.0 72.0 133.0 140.0 133.0 83.0 84.0 85.0 83.0 84.0 05:35:20 INFO - PROCESS | 1674 | 05:35:20 INFO - PROCESS | 1674 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:54.50 stddev:3.94 (7.2%) stddev-sans-first:4.17 05:35:20 INFO - PROCESS | 1674 | Values: 56.0 54.0 53.0 53.0 53.0 53.0 55.0 66.0 54.0 55.0 05:35:20 INFO - PROCESS | 1674 | 05:35:20 INFO - PROCESS | 1674 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:69.00 stddev:3.90 (5.7%) stddev-sans-first:3.67 05:35:20 INFO - PROCESS | 1674 | Values: 63.0 71.0 75.0 72.0 71.0 66.0 64.0 66.0 67.0 66.0 05:35:20 INFO - PROCESS | 1674 | 05:35:20 INFO - PROCESS | 1674 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:84.00 stddev:0.85 (1.0%) stddev-sans-first:0.88 05:35:20 INFO - PROCESS | 1674 | Values: 84.0 83.0 84.0 83.0 83.0 83.0 82.0 84.0 84.0 85.0 05:35:20 INFO - PROCESS | 1674 | 05:35:20 INFO - PROCESS | 1674 | [#11] stanford-crypto-ccm Cycles:10 Average:127.40 Median:129.50 stddev:9.98 (7.7%) stddev-sans-first:10.46 05:35:20 INFO - PROCESS | 1674 | Values: 123.0 126.0 142.0 109.0 134.0 127.0 132.0 140.0 122.0 119.0 05:35:20 INFO - PROCESS | 1674 | 05:35:20 INFO - PROCESS | 1674 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.10 Median:151.00 stddev:17.79 (11.8%) stddev-sans-first:18.34 05:35:20 INFO - PROCESS | 1674 | Values: 160.0 174.0 158.0 138.0 140.0 129.0 142.0 122.0 144.0 174.0 05:35:20 INFO - PROCESS | 1674 | 05:35:20 INFO - PROCESS | 1674 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:67.00 stddev:1.71 (2.6%) stddev-sans-first:1.74 05:35:20 INFO - PROCESS | 1674 | Values: 65.0 65.0 69.0 67.0 68.0 66.0 67.0 67.0 67.0 63.0 05:35:20 INFO - PROCESS | 1674 | -------- Summary: end -------- 05:35:20 INFO - PROCESS | 1674 | 05:35:21 INFO - TEST-INFO | 1674: exit 0 05:35:21 INFO - TEST-OK | kraken | took 56764ms 05:35:21 INFO - SUITE-END | took 1170s 05:35:21 INFO - Completed test suite (00:19:30) 05:35:21 INFO - javascript benchmark 05:35:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3422.2984288220914, 3487.9476807847873, 3523.0663874073357, 3525.242072954315, 3562.1094726318406, 5568.888622227563, 5648.661080335172, 5734.4265573442635, 5747.568932330077, 5748.827535173947, 5633.380328163909, 5690.743916523756, 5700.6579605223715, 5710.486056254937, 5715.514181294595, 5177.119889618755, 5184.662996905189, 5213.061648903196, 5217.165253559431, 5274.235235890794, 5271.077561426754, 5279.894402111955, 5282.894342113155, 5290.0477913975465, 5291.814786482474, 5164.974175129119, 5202.089634313998, 5214.0, 5224.268602395668, 5274.498922602365, 5223.660462069973, 5259.815906443295, 5274.604404669627, 5282.181261904411, 5313.521783039545, 5025.6733312334945, 5143.022825663112, 5178.533931946143, 5195.350581177353, 5234.7120908350025, 4552.9772351138035, 5523.171524271352, 5546.611737178399, 5555.8888822223735, 5673.149027645845, 6178.814635560895, 6186.164867742842, 6188.87622247557, 6196.194494715658, 6204.968975155095, 6121.387861213888, 6169.321374648785, 6201.317855035943, 6263.843403914893, 6324.683765811737, 5758.049921762946, 5763.308402991668, 5766.481016708516, 5770.076787713946, 5778.797742079007, 5561.499465048084, 6015.39846015395, 6275.1842260506755, 6289.779857704958, 6313.96843015782, 5996.640201587918, 6088.056351265561, 6145.231846019247, 6145.279321789906, 6164.321924588292, 6091.269047714302, 6101.556509355996, 6107.15847211733, 6120.873812997669, 6129.786714141072, 5968.403159683997, 6002.54980876436, 6020.69896505173, 6078.483328917092, 6085.148079268906, 6091.116788065706, 6100.127044624488, 6166.669153226816, 6210.285817131088, 6212.285587157535, 4841.515848415131, 4844.103840789465, 4846.951530484721, 4877.146499362598, 4898.118338698997, 4283.421738065384, 4407.735535867858, 4408.691391602557, 4412.0734645724115, 4413.624841888475, 5044.394672639307, 5288.68267903927, 5598.888022239533, 5607.831765047055, 5620.887582248332, 6125.754969801247, 6174.073888916699, 6174.783882564088, 6176.81469555914, 6178.351273116348, 5502.669839809624, 5616.6068375213345, 5639.210510528529, 5661.094224923992, 5680.801171958961, 5315.096433606296, 5333.519983201453, 5335.039692855245, 5339.3058902342445, 5347.973260133675, 5676.751114754665, 5968.194293770459, 6297.244330680348, 6308.653024083719, 6385.521085918482, 6145.84635384119, 6174.228221472316, 6189.288231853395, 6194.628322300677, 6200.627962322275, 6263.68681565929, 6272.6236425814595, 6289.308176100534, 6308.432241098323, 6311.526635502264, 6119.44924956756, 6162.7534898605345, 6162.907556386568, 6163.9383606163365, 6183.412575805291, 6071.7571297147615, 6136.0, 6190.535709821871, 6250.624962502265, 6284.968575157095, 5805.274340707411, 6081.908771368521, 6112.868254063078, 6129.664444256008, 6134.834601026268, 5976.491998180203, 5983.431574000463, 5994.790182343771, 6004.609700369462, 6027.30685971119, 5750.482456578928, 5766.0, 5798.391168927371, 5846.386129456346, 5879.2944846618675, 6035.78874739382, 6055.878882422415, 6080.604760690541, 6084.361142080018, 6100.1154832548145, 5825.50483208915, 5828.271466066742, 5846.9183201107935, 5862.472377486047, 5871.266091738533], "unit": "score", "name": "dojo.html", "value": 5647.57372475389}, {"lowerIsBetter": false, "replicates": [494.81245011971265, 542.5930552085936, 579.2643342954448, 632.1308201223318, 632.336047150492, 33795.0, 38368.04079898001, 38964.415533767016, 39009.41485877714, 39130.021749456275, 41706.58293417065, 42024.0, 42284.15431691364, 42351.78824105875, 42455.575444245624, 9381.15569598736, 9589.041095890425, 9604.135627793497, 9604.951975240114, 9643.421394716304, 9361.110694484047, 9567.521623918776, 9589.328746987714, 9667.854982175239, 9682.273829462818, 9508.667196648119, 9666.75833104171, 9691.224702023821, 9698.369605975624, 9724.416535007887, 9478.241740660731, 9656.662016829412, 9666.130048295618, 9666.854997175047, 9690.612375504972, 9532.714018579454, 9652.227821774311, 9660.661876834278, 9665.226781857435, 9667.371620844622, 40149.0, 40569.391459128135, 40598.18803623941, 40622.796886015676, 40690.59309406898, 3267.8202698851555, 3353.3796247694254, 3438.7420943429343, 3456.3605732939236, 3717.931734887604, 28679.28301792451, 28803.711962880312, 28878.0, 28990.565141522893, 29559.113226603236, 2582.780463660591, 2662.1081937550944, 2680.67831860178, 2692.421129457176, 2735.3161709572605, 489252.0, 490895.0, 491011.544942273, 491177.0, 492099.53950230737, 44955.55044449579, 63335.683321584016, 63531.36468635254, 63775.72448551096, 63866.0, 44577.777111114236, 44859.77570112129, 44874.55125448769, 44904.0, 44920.87697807515, 15146.318415671321, 15472.994255373365, 15502.5349239523, 15503.612409689622, 15505.922470387575, 12398.194117382522, 12472.563460278847, 12507.187032842836, 12507.93746031264, 12540.498380064695, 14398.640033999025, 14419.567412977627, 14744.631384215267, 14765.12730953186, 14973.0, 4978.726170060609, 6069.968105422089, 6235.345288744707, 6243.843903902439, 6252.249730032425, 900.2348004196381, 945.2626950978248, 1023.9283250172416, 1066.6106870992187, 1078.0890147825075, 28574.714252857622, 29001.85499072491, 29235.877091245748, 29639.407211856073, 29710.702892970792, 1070.1652710885521, 1075.5643964194514, 1081.0594782539242, 1118.0887576625025, 1175.2772045192146, 14759.0, 14786.260686965608, 15172.468963586221, 15186.924065379824, 15244.618884527976, 474290.0, 480364.0, 481851.18148818065, 482085.0, 484004.0, 58513.829723405295, 59170.704146478995, 59217.0, 59259.0, 59559.404405955385, 1343.3887581150552, 1376.1880490510646, 1453.6365908522869, 1464.6704491489543, 1590.9443169489011, 24073.27780166598, 27738.583921240795, 28479.43041139207, 29688.55467167951, 29867.402651946406, 47255.763721181174, 47411.0, 47776.7611161942, 47836.52163478321, 47842.760786195846, 336887.0, 338958.0, 339094.0, 340180.0, 340237.0, 28093.157205283875, 32077.518837217925, 32992.67007329992, 33087.66912330846, 33102.50346244856, 33740.0, 41025.384619230135, 41394.79302603468, 41408.58591414047, 43113.0, 34732.65267347294, 34923.65076349305, 35324.0, 35400.645993539736, 35683.0, 33767.662323376455, 33782.0, 34350.0, 34458.82770586131, 36375.45436818397, 35675.46486802752, 35818.10454738548, 36004.4599331005, 37398.8130059348, 38551.03622409462, 30820.69179308268, 31417.37165256728, 31424.685753142177, 31436.685633143377, 31485.685143148276, 23395.0, 23978.40053998664, 24048.51902961896, 24135.275941721775, 24185.75814241835], "unit": "score", "name": "ext.html", "value": 18772.224780761317}, {"lowerIsBetter": false, "replicates": [357.3478401916502, 360.5817251987695, 361.9366610843102, 366.7048026338798, 371.1871002504513, 19248.037598120092, 19716.70424943627, 21287.0, 21326.89336553315, 21350.145994160233, 12275.14074014817, 17855.19651615677, 19778.40664780055, 20541.281055163072, 20580.176792928265, 4578.97710511447, 5150.484951504847, 5257.316548848645, 5338.973305133488, 5343.1985202219785, 3909.706771992098, 4103.589641035887, 5267.341582302212, 7048.577085374868, 7637.350825179867, 7180.964095179516, 7588.468807183499, 7595.924040759604, 7612.314891659749, 7614.505057171294, 7354.705811767523, 7392.7042918283205, 7407.370373518257, 7410.888836667455, 7421.962890185541, 4409.933850992237, 4544.113897789933, 6750.122484077087, 6971.6862741176765, 7066.364027237573, 25920.0, 26011.21966340994, 26539.46921061568, 26850.0, 26917.596236056474, 2088.697138914849, 2473.1467643663086, 2680.383511792279, 3093.9845300773577, 3265.510173473974, 12423.93788031063, 14832.25838708071, 15940.0, 16638.417655382123, 16955.406560770436, 1816.5277027972822, 1828.7622609060736, 1919.299455698674, 1934.8161924617139, 2039.7552293724848, 109929.90070099276, 110885.0, 113439.0, 113750.43124784488, 115961.0, 18568.907155464138, 18682.813171868107, 18971.0, 19021.953792541266, 19041.42875713731, 28937.0, 28982.85508572486, 29040.0, 29069.273268168043, 29095.0, 10260.127889129359, 10605.045545900906, 10612.25714200014, 10634.30876992993, 10768.030877221088, 8953.820923581492, 8978.191962723386, 8982.775430614287, 9071.546422678839, 9132.99537050924, 8423.368247381472, 8544.40189186751, 8554.91445085541, 8583.141685831368, 8596.8710469343, 2790.8465034423302, 3336.5819526701057, 3360.7479439042168, 3417.7778444401033, 3484.5121682964404, 382.63267263426866, 435.97602131882417, 768.7386288661882, 872.3631748823394, 962.6042238753695, 11127.054200392895, 11677.76644467123, 11792.41037948099, 11798.941005294919, 12027.21823081497, 398.94081214375876, 411.36444193720774, 444.6154076723611, 450.33800313539047, 452.97735113244204, 6033.426824451758, 6057.515398768088, 6192.040233763774, 6220.34686357935, 6227.626342419469, 245181.0, 245374.0, 245729.0, 446436.0, 517624.0, 117173.0, 118183.40908295404, 120921.0, 123573.38213309056, 123594.38202809109, 456.6301295950291, 465.85325622428826, 468.0428523669105, 471.0437811243182, 472.16662590527744, 10718.73203169927, 10938.289011214245, 11079.279846809932, 11208.719782005515, 11220.66338009861, 47485.69947980028, 48004.75997620129, 48363.516364837305, 48385.75807120942, 48892.75553622209, 71125.64437177988, 72821.0, 73607.89588156075, 73926.0, 73991.63004184945, 7816.570088644951, 7817.0619525657285, 7889.921100788919, 7929.5242285463055, 8223.876641850258, 9867.55595998196, 12272.668193043293, 12619.87380126187, 12801.10392272532, 12867.163634363736, 10086.596536138471, 10588.84116738265, 10886.455677216265, 11099.334039957628, 11150.442477876237, 10305.53625086888, 10360.533775979948, 10468.371897686164, 10506.0, 10577.36535807854, 10463.424511651932, 10574.206934479791, 10966.780664386828, 11168.38573878412, 11196.94401527987, 6313.43179113882, 7914.722984695508, 7965.322947549524, 7977.242161994601, 8036.276735093869, 10702.020126276664, 10813.67558973232, 11005.449727513753, 11123.997680417602, 11189.776204476027], "unit": "score", "name": "jquery.html", "value": 9289.743342274307}, {"lowerIsBetter": false, "replicates": [1354.884834789043, 1611.5326555298964, 1821.5628249220192, 1967.4687834284753, 2001.2295266322471, 8739.038705742363, 8825.338099642537, 8942.821143577125, 8960.103989601044, 8961.238294744939, 7872.0947091084545, 8078.151794061612, 8424.663013479454, 8644.956775216131, 8722.738317850459, 2473.072597775834, 2511.196417146514, 2517.5342561626157, 2519.1560827122844, 2523.3313172009434, 2229.0972156276734, 2479.938001549958, 2563.7051739049966, 2564.7178810330847, 2570.8714564271804, 2225.1321984426086, 2411.8552886826847, 2482.515909397668, 2483.466054798218, 2484.006397441029, 2206.7131272934575, 2303.9424014399606, 2468.2101727447225, 2482.156066937232, 2482.3049546127113, 2076.3459510254374, 2240.932772016842, 2324.418895276181, 2364.2670772060546, 2383.654370116341, 8579.785505362353, 8676.219140277342, 8687.739367818975, 8689.56552172389, 8834.293256539462, 5430.212619170198, 5661.830145095653, 5683.772649094031, 5688.914666280009, 5708.058170401879, 3622.5652921649307, 3711.183539621279, 3747.0, 3776.9433458498142, 3789.4315852622326, 1042.1089968077335, 1056.7410984308895, 1069.8823129455754, 1071.132382769959, 1079.4117206122683, 12010.339431331273, 12215.633530994084, 12221.69445763863, 12225.327606981613, 12247.816282755677, 4930.93984793264, 4933.0, 5034.924476132861, 5046.798128074836, 5060.7722652480725, 10290.176785857113, 10310.381377117397, 10317.587296508205, 10320.741981450374, 10323.793524129625, 4603.516630753789, 5180.637355385163, 5565.2486914266865, 5576.665400076008, 5576.972115139399, 4163.437935878617, 4958.231474121517, 5004.074246264453, 5006.374203224597, 5008.198688209869, 3436.639152888961, 3786.469894214812, 3808.8857334280015, 3839.7504162229366, 3839.9040023999623, 1125.6566747142037, 1138.1691365303375, 1139.7777433400572, 1145.3128123126057, 1189.4647408666135, 1033.178622994721, 1100.9394483303336, 1179.823026546008, 1183.3964678014102, 1228.1280290993316, 8016.398770092266, 8071.515709057476, 8171.591420428955, 8180.83638327242, 8225.753227403187, 1134.8411222428867, 1166.288563975974, 1209.2865209526421, 1211.8606360268507, 1233.3155098920006, 6232.439080482778, 6236.438720515175, 6241.032639940817, 6252.0, 6259.71831267594, 10058.698239052841, 10462.110720588684, 10473.214508911862, 10503.842442363371, 10584.57661693539, 10062.24533160016, 10443.530041148015, 10473.109785668303, 10484.26610137283, 10488.947555262328, 8122.0, 8230.588470576567, 8360.790980225544, 8364.916350836414, 8371.665133394717, 6453.967730161507, 7739.110002349802, 8057.5165490070785, 8136.87794683092, 8142.18578142181, 9434.386764860263, 9459.810803783748, 9497.43015419077, 9497.525123743648, 9521.523923803921, 8336.29141522953, 8745.256653184551, 9797.118259356692, 9956.103950644478, 9970.900290996997, 7451.850962980819, 7526.9623651883585, 7573.2048134945035, 7623.504472209289, 7626.923730762622, 8056.919430805617, 8199.0980992092, 8210.876836847332, 8314.584270786558, 8356.122607126164, 6480.189976252968, 7395.7041718330665, 7397.593132377771, 7494.138174109829, 7554.093508778982, 6028.186194863637, 7256.7822965311125, 7312.670929808278, 7333.413326933939, 7397.075365579302, 7575.204603516771, 7722.3049925506975, 7734.8839767402405, 7737.690492380242, 7738.2261773822165, 6901.827454313682, 7011.1586609607175, 7021.0, 7022.754203602849, 7023.297670232936, 6811.761588344384, 7065.328793764585, 7066.010758493712, 7087.7164913402885, 7092.290770922867], "unit": "score", "name": "mootools.html", "value": 4906.14650895142}, {"lowerIsBetter": false, "replicates": [312.1353849835953, 318.4999550705393, 318.99202519937, 327.08579520240926, 327.508736894658, 6335.524835637329, 6518.804435866919, 6544.312847151046, 6574.145361103062, 6587.967060164705, 6323.557350985433, 6506.284308726036, 6549.312322206171, 6558.147440832697, 6570.014497825328, 4580.656450766189, 4664.463586687523, 4704.6001089907395, 4787.186178349689, 4819.855404337875, 4756.215224487973, 4762.6428017898625, 4790.281457781326, 4793.712377257376, 4795.976020119894, 4718.834840780573, 4738.97630511847, 4745.90508189836, 4751.40607424072, 4782.856514304576, 4531.796069176895, 4569.543045695421, 4713.952860471386, 4716.575508204278, 4729.408823897013, 3602.423612222058, 3762.097096696773, 4020.2763502569524, 4036.616521430459, 4057.411675307064, 4889.584385327252, 6204.81385558434, 6252.6561039142825, 6320.304766475684, 6405.967970160119, 5471.124620060811, 5480.314960629921, 5486.561075113981, 5501.14732216503, 5502.394736579013, 6822.079019332426, 6840.589564626139, 6843.349881761224, 6851.280615535346, 6855.211650660188, 4302.935455968163, 4456.821727130911, 4481.955180448219, 4490.685652004361, 4499.460064792213, 7148.642567871586, 7215.639218039077, 7228.746993855189, 7229.2047874733735, 7241.0, 4535.818567257273, 4541.954580454153, 4549.909001819945, 4562.749048802281, 4565.292379681155, 3726.900564333528, 3855.51806024247, 4632.814687412533, 4641.8375356863025, 4646.97676511622, 5480.698561579072, 5488.423715509894, 5489.615726899158, 5495.53287970527, 5499.945000550023, 6121.357257487989, 6610.041543976096, 6656.83357916056, 6921.965390173118, 6925.099737034153, 1574.4332040465424, 1598.0811033655461, 1609.91145486997, 1613.0805440898575, 1614.9111798851177, 958.9520523973773, 1014.6905193915926, 1020.3928662445833, 1035.4770840725384, 1040.6409788622914, 6161.260648722182, 6284.497240220863, 6443.742250309935, 6481.740730370732, 6498.122753428322, 7129.18014428337, 7155.141383034069, 7223.133224013047, 7223.602701851449, 7261.455390845707, 6433.517486188554, 6448.871022579522, 6457.741690332428, 6470.22357317125, 6474.028895665594, 3764.284785890672, 3801.7148713846573, 3808.5429748430365, 3815.0, 3821.7898015609408, 7214.170370407471, 7539.607176770475, 7562.773116806505, 7568.735094271674, 7579.734709285149, 7444.367228785505, 7446.702131914771, 7456.40348772097, 7477.513961592588, 7484.32641062307, 7538.811529711801, 7547.207543207994, 7551.093868735787, 7552.169261381244, 7561.281678240558, 6977.825554361181, 7213.944025952578, 7216.1340639121545, 7218.205997340184, 7255.274472552703, 7115.0, 7119.786406407816, 7124.893126603209, 7135.714571417086, 7139.964300178466, 7440.479166458296, 7523.623818808928, 7534.54792712439, 7535.660895259617, 7536.8492630148185, 4697.6711630185555, 4756.310335001474, 4762.618990480684, 4768.094062128184, 4772.093302272557, 7172.426205903619, 7176.0, 7177.461690373348, 7190.532615379983, 7209.531380460253, 6651.700673469609, 6923.411510021705, 6934.549254298455, 6947.4789390796905, 6992.685329160098, 6888.724451021903, 6957.234704182435, 6977.406920411619, 6984.546004509691, 7005.404540614105, 6812.863742725217, 6814.0, 6818.18181818185, 6827.146606674166, 6827.863442731018, 6751.265312110282, 6905.75829845953, 6992.860142797013, 7003.089598352181, 7012.403945664676, 6531.738730450728, 6661.1340525733285, 6743.819831529365, 6828.419584335387, 6842.657867106725], "unit": "score", "name": "prototype.html", "value": 5051.992759610615}, {"lowerIsBetter": false, "replicates": [680.7447207297264, 738.4535443771609, 741.9851602967941, 749.8237914090184, 758.3667637522668, 14665.340059697313, 14843.332050057747, 14991.925040374797, 15373.692526149498, 15401.845981540182, 14065.0, 14217.146971181737, 14273.357698903548, 14276.78584821226, 14284.142951422922, 725.891116332549, 738.0331765387333, 901.8917729872425, 920.5627327019679, 922.2022950148107, 895.1630225738922, 916.8670542771295, 919.246218101154, 919.7102912582549, 921.9539023048854, 917.1287277086761, 967.5162418790604, 973.4694591447678, 974.848898420746, 976.653288082731, 760.1903972269542, 947.9336446448751, 969.6121551379434, 970.2092794372599, 970.9805803883953, 723.2911746488418, 724.768074216251, 725.4522835259345, 725.4885305859409, 726.7565365602529, 15093.849061509354, 15142.621434464116, 15170.848291517164, 15171.317290721943, 15201.619959500991, 12203.633890983285, 12263.26420414778, 12395.0, 12597.93701031489, 12680.74638507234, 9376.578053987587, 9844.409335439825, 9946.950265248699, 10239.539220735085, 10433.843492347545, 3530.6116327203986, 3600.531930848973, 3613.512175856278, 3681.7238707097076, 3711.4432835074685, 69534.30465695329, 71983.0, 72259.19352016241, 72391.55216895686, 73020.0, 9408.388454750419, 9412.058794120534, 9443.055694430639, 9512.762180945394, 9577.712668619952, 20681.0, 20688.689669654967, 20693.89653051725, 20726.378208653765, 20729.378118656463, 7343.118825740945, 7437.85124297511, 7531.435142364345, 7588.62056897153, 7763.9611801941755, 3449.2411669432686, 3502.9474557881144, 3964.4053391991433, 4030.7984600769846, 4061.0, 3345.531625572422, 3373.2916087621875, 3388.7119594834717, 3389.1527118220447, 3392.609849867297, 643.1478291264094, 655.3184687924601, 656.8160914943824, 664.0802488553388, 680.8604236131581, 480.38510706295995, 576.7692922830901, 577.1198921644442, 601.0203368509389, 624.6907780648518, 8073.19268073188, 8089.878651820228, 8116.228958248957, 8191.5921840592555, 8219.2050858733, 563.8336690676178, 591.6568390333596, 593.4243783529969, 615.2831950777384, 618.5299172628835, 3661.56061272649, 3701.9444708329397, 3735.5143831301757, 3805.3911374179997, 3808.409696497047, 88374.0, 88630.25523316336, 89030.55484722664, 89219.55390223008, 89717.55141224252, 75030.0, 75923.0, 76189.47621047548, 76225.0, 78483.0, 49414.50585494171, 50601.74699126481, 65553.67223163854, 66587.0, 69342.65328673324, 7549.396048316012, 7569.091708994735, 7633.389328853567, 7752.302292793675, 7949.92050079515, 48853.755731221114, 48990.02019959652, 49583.256251156985, 50322.0, 50360.24459633182, 61471.77056458935, 65889.0, 66287.33712662812, 67396.6630166846, 67480.6625966867, 9813.214942804416, 9858.408495490294, 9923.40459572428, 10042.89957100449, 10169.44068076263, 10694.73263168427, 10791.460426978463, 10852.294600850919, 10882.238243322892, 11839.58561450345, 10181.236407269633, 10194.847077293698, 10216.182705383402, 10238.692839214835, 10608.734781630521, 10269.127124194527, 10499.895001049892, 10505.212109091695, 10609.840852387066, 10625.734356640836, 9805.607775689177, 10072.143867771321, 10105.9494702526, 10146.391216527032, 10381.429021403896, 8549.401541892008, 8702.695405660772, 8804.823903521765, 9004.504752238428, 9090.636374544943, 8694.695685650971, 8726.171013753938, 8765.956170219108, 8941.37410381293, 8951.641934322553], "unit": "score", "name": "yui.html", "value": 6675.398497882015}], "name": "dromaeo_css", "value": 7390.649229998933}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 107.0, 110.0, 110.0, 111.0, 113.0, 117.0, 111.0, 109.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.0}, {"lowerIsBetter": true, "replicates": [157.0, 119.0, 144.0, 194.0, 136.0, 143.0, 140.0, 129.0, 194.0, 150.0], "unit": "score", "name": "audio-beat-detection", "value": 150.6}, {"lowerIsBetter": true, "replicates": [186.0, 184.0, 185.0, 185.0, 188.0, 196.0, 220.0, 182.0, 182.0, 181.0], "unit": "score", "name": "audio-dft", "value": 188.9}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 74.0, 117.0, 57.0, 57.0, 58.0, 61.0, 117.0, 55.0], "unit": "score", "name": "audio-fft", "value": 74.2}, {"lowerIsBetter": true, "replicates": [91.0, 92.0, 130.0, 77.0, 78.0, 82.0, 118.0, 79.0, 80.0, 119.0], "unit": "score", "name": "audio-oscillator", "value": 94.6}, {"lowerIsBetter": true, "replicates": [87.0, 83.0, 86.0, 84.0, 90.0, 84.0, 87.0, 84.0, 86.0, 83.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 85.4}, {"lowerIsBetter": true, "replicates": [92.0, 94.0, 93.0, 94.0, 94.0, 93.0, 93.0, 96.0, 92.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 93.4}, {"lowerIsBetter": true, "replicates": [101.0, 72.0, 133.0, 140.0, 133.0, 83.0, 84.0, 85.0, 83.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 99.8}, {"lowerIsBetter": true, "replicates": [56.0, 54.0, 53.0, 53.0, 53.0, 53.0, 55.0, 66.0, 54.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 55.2}, {"lowerIsBetter": true, "replicates": [63.0, 71.0, 75.0, 72.0, 71.0, 66.0, 64.0, 66.0, 67.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 84.0, 83.0, 83.0, 83.0, 82.0, 84.0, 84.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.5}, {"lowerIsBetter": true, "replicates": [123.0, 126.0, 142.0, 109.0, 134.0, 127.0, 132.0, 140.0, 122.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.4}, {"lowerIsBetter": true, "replicates": [160.0, 174.0, 158.0, 138.0, 140.0, 129.0, 142.0, 122.0, 144.0, 174.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.1}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 69.0, 67.0, 68.0, 66.0, 67.0, 67.0, 67.0, 63.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.4}], "name": "kraken", "value": 1446.6000000000001}]} 05:35:21 INFO - Return code: 0 05:35:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:35:21 ERROR - # TBPL SUCCESS # 05:35:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:35:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:35:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:35:21 INFO - 2016-04-05 05:35:21.357 screenresolution[1678:10130] starting screenresolution argv=screenresolution get 05:35:21 INFO - 2016-04-05 05:35:21.360 screenresolution[1678:10130] Display 0: 1600x1200x32@60 05:35:21 INFO - 2016-04-05 05:35:21.366 screenresolution[1679:10133] starting screenresolution argv=screenresolution list 05:35:21 INFO - Available Modes on Display 0 05:35:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:35:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:35:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:35:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:35:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:35:21 INFO - Intel Iris: 05:35:21 INFO - Chipset Model: Intel Iris 05:35:21 INFO - Type: GPU 05:35:21 INFO - Bus: Built-In 05:35:21 INFO - VRAM (Dynamic, Max): 1536 MB 05:35:21 INFO - Vendor: Intel (0x8086) 05:35:21 INFO - Device ID: 0x0a2e 05:35:21 INFO - Revision ID: 0x0009 05:35:21 INFO - Displays: 05:35:21 INFO - Display: 05:35:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:35:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:35:21 INFO - Display Serial Number: 1600x1200 60 05:35:21 INFO - Main Display: Yes 05:35:21 INFO - Mirror: Off 05:35:21 INFO - Online: Yes 05:35:21 INFO - Rotation: Supported 05:35:21 INFO - Return code: 0 05:35:21 INFO - Running post-action listener: _resource_record_post_action 05:35:21 INFO - Running post-run listener: _resource_record_post_run 05:35:22 INFO - Total resource usage - Wall time: 1206s; CPU: 52.0%; Read bytes: 37488128; Write bytes: 701436928; Read time: 549; Write time: 2051 05:35:22 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 396882432; Write bytes: 391129088; Read time: 30076; Write time: 771 05:35:22 INFO - run-tests - Wall time: 1172s; CPU: 52.0%; Read bytes: 35694080; Write bytes: 297049088; Read time: 530; Write time: 1246 05:35:22 INFO - Running post-run listener: _upload_blobber_files 05:35:22 INFO - Blob upload gear active. 05:35:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:35:22 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:35:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:35:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:35:23 INFO - (blobuploader) - INFO - Open directory for files ... 05:35:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:35:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:35:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:35:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:35:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:35:24 INFO - (blobuploader) - INFO - Done attempting. 05:35:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:35:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:35:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:35:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:35:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:35:25 INFO - (blobuploader) - INFO - Done attempting. 05:35:25 INFO - (blobuploader) - INFO - Iteration through files over. 05:35:25 INFO - Return code: 0 05:35:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:35:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:35:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa726b6dc0982633875f86e0525077ec3bedbd329eb3519a5bf062bc6b997f6bc1d92484b4dcb1ff428c3eab035d439de0a34d2e15b8128fc8fd814b33a3f9d4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0803dcea51339a16296c46f03dee28dc554dbf40af8f23d99dbef7371aedb318d403f97e032aa520ca7adf689d60d87090eac12eaa649e757ff2740c1cf4f629"} 05:35:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:35:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:35:25 INFO - Contents: 05:35:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa726b6dc0982633875f86e0525077ec3bedbd329eb3519a5bf062bc6b997f6bc1d92484b4dcb1ff428c3eab035d439de0a34d2e15b8128fc8fd814b33a3f9d4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0803dcea51339a16296c46f03dee28dc554dbf40af8f23d99dbef7371aedb318d403f97e032aa520ca7adf689d60d87090eac12eaa649e757ff2740c1cf4f629"} 05:35:25 INFO - Running post-run listener: copy_logs_to_upload_dir 05:35:25 INFO - Copying logs to upload dir... 05:35:25 INFO - mkdir: /builds/slave/test/build/upload/logs 05:35:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.532634 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-04-05 05:35:25.356293) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-05 05:35:25.364284) ========= 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.xJyDAr3JbO/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.VItqKtS5rG/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa726b6dc0982633875f86e0525077ec3bedbd329eb3519a5bf062bc6b997f6bc1d92484b4dcb1ff428c3eab035d439de0a34d2e15b8128fc8fd814b33a3f9d4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0803dcea51339a16296c46f03dee28dc554dbf40af8f23d99dbef7371aedb318d403f97e032aa520ca7adf689d60d87090eac12eaa649e757ff2740c1cf4f629"} build_url:https://queue.taskcluster.net/v1/task/GxG6j7tfTmibZPC6Vf9bmw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010615 build_url: 'https://queue.taskcluster.net/v1/task/GxG6j7tfTmibZPC6Vf9bmw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa726b6dc0982633875f86e0525077ec3bedbd329eb3519a5bf062bc6b997f6bc1d92484b4dcb1ff428c3eab035d439de0a34d2e15b8128fc8fd814b33a3f9d4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0803dcea51339a16296c46f03dee28dc554dbf40af8f23d99dbef7371aedb318d403f97e032aa520ca7adf689d60d87090eac12eaa649e757ff2740c1cf4f629"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-05 05:35:25.393111) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 05:35:25.393450) ========= 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.xJyDAr3JbO/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.VItqKtS5rG/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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.005270 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 05:35:25.448802) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-05 05:35:25.449158) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-05 05:35:25.449549) ========= ========= Total master_lag: 4.02 =========