builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0166 starttime: 1456249093.29 results: success (0) buildid: 20160223075310 builduid: 0dca9a6a2fc74004b752fa74d8f20555 revision: 25697d5038158fadb93ec3ed76f3c2e84fd4f60f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-23 09:38:13.287029) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-23 09:38:13.287434) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-23 09:38:13.287716) ========= 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.UQ0v11LWcG/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.9DuLDunDEt/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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.005503 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-23 09:38:13.312896) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-23 09:38:13.316218) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-23 09:38:13.334748) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 09:38:13.335046) ========= 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.UQ0v11LWcG/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.9DuLDunDEt/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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.005207 ========= master_lag: 0.12 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 09:38:13.462805) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-23 09:38:13.463095) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-23 09:38:13.463455) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 09:38:13.463735) ========= 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.UQ0v11LWcG/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.9DuLDunDEt/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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-02-23 09:38:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 154M=0s 2016-02-23 09:38:13 (154 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099278 ========= master_lag: 0.25 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 09:38:13.811463) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 09:38:13.811789) ========= 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.UQ0v11LWcG/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.9DuLDunDEt/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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.019241 ========= master_lag: 0.64 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 09:38:14.473079) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-23 09:38:14.473384) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 25697d5038158fadb93ec3ed76f3c2e84fd4f60f --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 25697d5038158fadb93ec3ed76f3c2e84fd4f60f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UQ0v11LWcG/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.9DuLDunDEt/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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-02-23 09:38:14,552 truncating revision to first 12 chars 2016-02-23 09:38:14,552 Setting DEBUG logging. 2016-02-23 09:38:14,552 attempt 1/10 2016-02-23 09:38:14,552 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/25697d503815?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-23 09:38:15,900 unpacking tar archive at: mozilla-central-25697d503815/testing/mozharness/ program finished with exit code 0 elapsedTime=1.600943 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-23 09:38:16.091936) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-23 09:38:16.092310) ========= echo 25697d5038158fadb93ec3ed76f3c2e84fd4f60f in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'25697d5038158fadb93ec3ed76f3c2e84fd4f60f'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UQ0v11LWcG/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.9DuLDunDEt/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 25697d5038158fadb93ec3ed76f3c2e84fd4f60f program finished with exit code 0 elapsedTime=0.004944 script_repo_revision: '25697d5038158fadb93ec3ed76f3c2e84fd4f60f' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-23 09:38:16.141537) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-23 09:38:16.141822) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-23 09:38:16.154871) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-02-23 09:38:16.155145) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.UQ0v11LWcG/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.9DuLDunDEt/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 09:38:16 INFO - MultiFileLogger online at 20160223 09:38:16 in /builds/slave/test 09:38:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:38:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:38:16 INFO - {'append_to_log': False, 09:38:16 INFO - 'base_work_dir': '/builds/slave/test', 09:38:16 INFO - 'blob_upload_branch': 'Firefox', 09:38:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:38:16 INFO - 'branch': 'Firefox', 09:38:16 INFO - 'buildbot_json_path': 'buildprops.json', 09:38:16 INFO - 'config_files': ('talos/mac_config.py',), 09:38:16 INFO - 'default_actions': ('clobber', 09:38:16 INFO - 'read-buildbot-config', 09:38:16 INFO - 'download-and-extract', 09:38:16 INFO - 'populate-webroot', 09:38:16 INFO - 'create-virtualenv', 09:38:16 INFO - 'install', 09:38:16 INFO - 'run-tests'), 09:38:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:38:16 INFO - 'download_minidump_stackwalk': True, 09:38:16 INFO - 'download_symbols': 'ondemand', 09:38:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:38:16 INFO - 'tooltool.py': '/tools/tooltool.py', 09:38:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:38:16 INFO - '/tools/misc-python/virtualenv.py')}, 09:38:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:38:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:38:16 INFO - 'installer_path': 'installer.exe', 09:38:16 INFO - 'log_level': 'info', 09:38:16 INFO - 'log_name': 'talos', 09:38:16 INFO - 'log_to_console': True, 09:38:16 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:38:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:38:16 INFO - 'opt_config_files': (), 09:38:16 INFO - 'pip_index': False, 09:38:16 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:38:16 INFO - 'cmd': ('bash', 09:38:16 INFO - '-c', 09:38:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:38:16 INFO - 'enabled': True, 09:38:16 INFO - 'halt_on_failure': False, 09:38:16 INFO - 'name': 'check_screen_resolution'},), 09:38:16 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:38:16 INFO - 'cmd': ('bash', 09:38:16 INFO - '-c', 09:38:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:38:16 INFO - 'enabled': True, 09:38:16 INFO - 'halt_on_failure': False, 09:38:16 INFO - 'name': 'check_screen_resolution'},), 09:38:16 INFO - 'run_cmd_checks_enabled': True, 09:38:16 INFO - 'sps_profile': False, 09:38:16 INFO - 'sps_profile_interval': 0, 09:38:16 INFO - 'suite': 'dromaeojs-e10s', 09:38:16 INFO - 'system_bits': '32', 09:38:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:38:16 INFO - 'title': 't-yosemite-r7-0166', 09:38:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:38:16 INFO - 'use_talos_json': True, 09:38:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:38:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:38:16 INFO - 'work_dir': 'build'} 09:38:16 INFO - ##### 09:38:16 INFO - ##### Running clobber step. 09:38:16 INFO - ##### 09:38:16 INFO - Running pre-action listener: _resource_record_pre_action 09:38:16 INFO - Running main action method: clobber 09:38:16 INFO - rmtree: /builds/slave/test/build 09:38:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:38:18 INFO - Running post-action listener: _resource_record_post_action 09:38:18 INFO - ##### 09:38:18 INFO - ##### Running read-buildbot-config step. 09:38:18 INFO - ##### 09:38:18 INFO - Running pre-action listener: _resource_record_pre_action 09:38:18 INFO - Running main action method: read_buildbot_config 09:38:18 INFO - Using buildbot properties: 09:38:18 INFO - { 09:38:18 INFO - "project": "", 09:38:18 INFO - "product": "firefox", 09:38:18 INFO - "script_repo_revision": "production", 09:38:18 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 09:38:18 INFO - "repository": "", 09:38:18 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 09:38:18 INFO - "buildid": "20160223075310", 09:38:18 INFO - "pgo_build": "False", 09:38:18 INFO - "basedir": "/builds/slave/test", 09:38:18 INFO - "buildnumber": 182, 09:38:18 INFO - "slavename": "t-yosemite-r7-0166", 09:38:18 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 09:38:18 INFO - "platform": "yosemite_r7", 09:38:18 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:38:18 INFO - "branch": "mozilla-central", 09:38:18 INFO - "repo_path": "mozilla-central", 09:38:18 INFO - "revision": "25697d5038158fadb93ec3ed76f3c2e84fd4f60f", 09:38:18 INFO - "stage_platform": "macosx64", 09:38:18 INFO - "builduid": "0dca9a6a2fc74004b752fa74d8f20555", 09:38:18 INFO - "slavebuilddir": "test" 09:38:18 INFO - } 09:38:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/TQm41WjRQGKOSgizpUpJKw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 09:38:18 INFO - Running post-action listener: _resource_record_post_action 09:38:18 INFO - ##### 09:38:18 INFO - ##### Running download-and-extract step. 09:38:18 INFO - ##### 09:38:18 INFO - Running pre-action listener: _resource_record_pre_action 09:38:18 INFO - Running main action method: download_and_extract 09:38:18 INFO - mkdir: /builds/slave/test/build/tests 09:38:18 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')]} 09:38:18 INFO - https://queue.taskcluster.net/v1/task/TQm41WjRQGKOSgizpUpJKw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:38:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TQm41WjRQGKOSgizpUpJKw/artifacts/public/build/test_packages.json 09:38:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TQm41WjRQGKOSgizpUpJKw/artifacts/public/build/test_packages.json 09:38:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TQm41WjRQGKOSgizpUpJKw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:38:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TQm41WjRQGKOSgizpUpJKw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:38:20 INFO - Downloaded 1277 bytes. 09:38:20 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:38:20 INFO - Using the following test package requirements: 09:38:20 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 09:38:20 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:38:20 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 09:38:20 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:38:20 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 09:38:20 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:38:20 INFO - u'jsshell-mac.zip'], 09:38:20 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:38:20 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 09:38:20 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 09:38:20 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:38:20 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 09:38:20 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:38:20 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 09:38:20 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:38:20 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 09:38:20 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 09:38:20 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:38:20 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 09:38:20 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:38:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:20 INFO - https://queue.taskcluster.net/v1/task/TQm41WjRQGKOSgizpUpJKw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:38:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TQm41WjRQGKOSgizpUpJKw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 09:38:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TQm41WjRQGKOSgizpUpJKw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 09:38:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TQm41WjRQGKOSgizpUpJKw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 09:38:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TQm41WjRQGKOSgizpUpJKw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:38:21 INFO - Downloaded 17825633 bytes. 09:38:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:38:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:38:24 INFO - Return code: 0 09:38:24 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:38:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:24 INFO - https://queue.taskcluster.net/v1/task/TQm41WjRQGKOSgizpUpJKw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:38:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TQm41WjRQGKOSgizpUpJKw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 09:38:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TQm41WjRQGKOSgizpUpJKw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 09:38:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TQm41WjRQGKOSgizpUpJKw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 09:38:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TQm41WjRQGKOSgizpUpJKw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:38:25 INFO - Downloaded 17825633 bytes. 09:38:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:38:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:38:28 INFO - Return code: 0 09:38:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:28 INFO - https://queue.taskcluster.net/v1/task/TQm41WjRQGKOSgizpUpJKw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:38:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TQm41WjRQGKOSgizpUpJKw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 09:38:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TQm41WjRQGKOSgizpUpJKw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 09:38:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TQm41WjRQGKOSgizpUpJKw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 09:38:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TQm41WjRQGKOSgizpUpJKw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:38:29 INFO - Downloaded 10707015 bytes. 09:38:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:38:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 09:38:30 INFO - Return code: 0 09:38:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:30 INFO - https://queue.taskcluster.net/v1/task/TQm41WjRQGKOSgizpUpJKw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 09:38:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TQm41WjRQGKOSgizpUpJKw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 09:38:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TQm41WjRQGKOSgizpUpJKw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 09:38:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TQm41WjRQGKOSgizpUpJKw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 09:38:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TQm41WjRQGKOSgizpUpJKw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 09:38:32 INFO - Downloaded 111433443 bytes. 09:38:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TQm41WjRQGKOSgizpUpJKw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 09:38:32 INFO - mkdir: /builds/slave/test/properties 09:38:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:38:32 INFO - Writing to file /builds/slave/test/properties/build_url 09:38:32 INFO - Contents: 09:38:32 INFO - build_url:https://queue.taskcluster.net/v1/task/TQm41WjRQGKOSgizpUpJKw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 09:38:33 INFO - Running post-action listener: _resource_record_post_action 09:38:33 INFO - Running post-action listener: set_extra_try_arguments 09:38:33 INFO - ##### 09:38:33 INFO - ##### Running populate-webroot step. 09:38:33 INFO - ##### 09:38:33 INFO - Running pre-action listener: _resource_record_pre_action 09:38:33 INFO - Running main action method: populate_webroot 09:38:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:38:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:38:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:38:33 INFO - '--tppagecycles', 09:38:33 INFO - '7'], 09:38:33 INFO - 'tests': ['tsvgm']}}, 09:38:33 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:38:33 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:38:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:38:33 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:38:33 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:38:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:38:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:38:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:38:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:38:33 INFO - 'talos_options': ['--e10s'], 09:38:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:38:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:38:33 INFO - 'tests': ['damp', 'tps']}, 09:38:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:38:33 INFO - 'talos_options': ['--e10s'], 09:38:33 INFO - 'tests': ['damp', 'tps']}, 09:38:33 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:38:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:38:33 INFO - 'other': {'tests': ['a11yr', 09:38:33 INFO - 'ts_paint', 09:38:33 INFO - 'tpaint', 09:38:33 INFO - 'sessionrestore', 09:38:33 INFO - 'sessionrestore_no_auto_restore']}, 09:38:33 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:38:33 INFO - 'tests': ['a11yr', 09:38:33 INFO - 'ts_paint', 09:38:33 INFO - 'tpaint', 09:38:33 INFO - 'sessionrestore', 09:38:33 INFO - 'sessionrestore_no_auto_restore']}, 09:38:33 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:38:33 INFO - 'tests': ['a11yr', 09:38:33 INFO - 'ts_paint', 09:38:33 INFO - 'tpaint', 09:38:33 INFO - 'sessionrestore', 09:38:33 INFO - 'sessionrestore_no_auto_restore']}, 09:38:33 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:38:33 INFO - 'tests': ['a11yr', 09:38:33 INFO - 'ts_paint', 09:38:33 INFO - 'tpaint', 09:38:33 INFO - 'sessionrestore', 09:38:33 INFO - 'sessionrestore_no_auto_restore']}, 09:38:33 INFO - 'other_l64': {'tests': ['a11yr', 09:38:33 INFO - 'ts_paint', 09:38:33 INFO - 'tpaint', 09:38:33 INFO - 'sessionrestore', 09:38:33 INFO - 'sessionrestore_no_auto_restore']}, 09:38:33 INFO - 'other_nol64': {'tests': ['a11yr', 09:38:33 INFO - 'ts_paint', 09:38:33 INFO - 'tpaint', 09:38:33 INFO - 'sessionrestore', 09:38:33 INFO - 'sessionrestore_no_auto_restore']}, 09:38:33 INFO - 'svgr': {'tests': ['tsvgx', 09:38:33 INFO - 'tsvgr_opacity', 09:38:33 INFO - 'tart', 09:38:33 INFO - 'tscrollx', 09:38:33 INFO - 'cart']}, 09:38:33 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:38:33 INFO - 'tests': ['tsvgx', 09:38:33 INFO - 'tsvgr_opacity', 09:38:33 INFO - 'tart', 09:38:33 INFO - 'tscrollx', 09:38:33 INFO - 'cart']}, 09:38:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:38:33 INFO - 'tests': ['tp5o']}, 09:38:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:38:33 INFO - 'talos_options': ['--e10s'], 09:38:33 INFO - 'tests': ['tp5o']}, 09:38:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:38:33 INFO - 'talos_options': ['--xperf_path', 09:38:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:38:33 INFO - 'tests': ['tp5n']}, 09:38:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:38:33 INFO - 'talos_options': ['--e10s', 09:38:33 INFO - '--xperf_path', 09:38:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:38:33 INFO - 'tests': ['tp5n']}}, 09:38:33 INFO - 'talos.zip': {'path': '', 09:38:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:38:33 INFO - Running post-action listener: _resource_record_post_action 09:38:33 INFO - ##### 09:38:33 INFO - ##### Running create-virtualenv step. 09:38:33 INFO - ##### 09:38:33 INFO - Running pre-action listener: _resource_record_pre_action 09:38:33 INFO - Running main action method: create_virtualenv 09:38:33 INFO - Creating virtualenv /builds/slave/test/build/venv 09:38:33 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 09:38:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:38:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:38:33 INFO - Using real prefix '/tools/python27' 09:38:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:38:34 INFO - Installing distribute.............................................................................................................................................................................................done. 09:38:37 INFO - Installing pip.................done. 09:38:37 INFO - Return code: 0 09:38:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:38:37 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')]} 09:38:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:37 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')]} 09:38:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:37 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 0x102294a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10229b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c7bd63c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102138d30>, '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 0x101f5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10212fb20>, '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.UQ0v11LWcG/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.9DuLDunDEt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 09:38:37 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 09:38:37 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 09:38:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UQ0v11LWcG/Render', 09:38:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:38:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:38:37 INFO - 'HOME': '/Users/cltbld', 09:38:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:38:37 INFO - 'LOGNAME': 'cltbld', 09:38:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:37 INFO - 'MOZ_NO_REMOTE': '1', 09:38:37 INFO - 'NO_EM_RESTART': '1', 09:38:37 INFO - 'PAGER': '/bin/cat', 09:38:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:38:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:37 INFO - 'PWD': '/builds/slave/test', 09:38:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:38:37 INFO - 'SHELL': '/bin/bash', 09:38:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9DuLDunDEt/Listeners', 09:38:37 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 09:38:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:38:37 INFO - 'USER': 'cltbld', 09:38:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:38:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:38:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:37 INFO - 'XPC_FLAGS': '0x0', 09:38:37 INFO - 'XPC_SERVICE_NAME': '0', 09:38:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:38:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:37 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 09:38:37 INFO - Cleaning up... 09:38:37 INFO - Return code: 0 09:38:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:38:37 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')]} 09:38:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:37 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')]} 09:38:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:37 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 0x102294a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10229b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c7bd63c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102138d30>, '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 0x101f5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10212fb20>, '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.UQ0v11LWcG/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.9DuLDunDEt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 09:38:37 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 09:38:37 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 09:38:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UQ0v11LWcG/Render', 09:38:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:38:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:38:37 INFO - 'HOME': '/Users/cltbld', 09:38:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:38:37 INFO - 'LOGNAME': 'cltbld', 09:38:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:37 INFO - 'MOZ_NO_REMOTE': '1', 09:38:37 INFO - 'NO_EM_RESTART': '1', 09:38:37 INFO - 'PAGER': '/bin/cat', 09:38:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:38:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:37 INFO - 'PWD': '/builds/slave/test', 09:38:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:38:37 INFO - 'SHELL': '/bin/bash', 09:38:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9DuLDunDEt/Listeners', 09:38:37 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 09:38:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:38:37 INFO - 'USER': 'cltbld', 09:38:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:38:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:38:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:37 INFO - 'XPC_FLAGS': '0x0', 09:38:37 INFO - 'XPC_SERVICE_NAME': '0', 09:38:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:38:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:37 INFO - Downloading/unpacking psutil>=0.7.1 09:38:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:38:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:38:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:38:40 INFO - Installing collected packages: psutil 09:38:40 INFO - Running setup.py install for psutil 09:38:40 INFO - building 'psutil._psutil_osx' extension 09:38:40 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 09:38:40 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 09:38:40 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 09:38:40 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 09:38:40 INFO - building 'psutil._psutil_posix' extension 09:38:40 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 09:38:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:38:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:38:40 INFO - ^ 09:38:40 INFO - 1 warning generated. 09:38:40 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 09:38:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:38:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:38:41 INFO - Successfully installed psutil 09:38:41 INFO - Cleaning up... 09:38:41 INFO - Return code: 0 09:38:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:38:41 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')]} 09:38:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:41 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')]} 09:38:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:41 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 0x102294a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10229b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c7bd63c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102138d30>, '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 0x101f5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10212fb20>, '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.UQ0v11LWcG/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.9DuLDunDEt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 09:38:41 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 09:38:41 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 09:38:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UQ0v11LWcG/Render', 09:38:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:38:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:38:41 INFO - 'HOME': '/Users/cltbld', 09:38:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:38:41 INFO - 'LOGNAME': 'cltbld', 09:38:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:41 INFO - 'MOZ_NO_REMOTE': '1', 09:38:41 INFO - 'NO_EM_RESTART': '1', 09:38:41 INFO - 'PAGER': '/bin/cat', 09:38:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:38:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:41 INFO - 'PWD': '/builds/slave/test', 09:38:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:38:41 INFO - 'SHELL': '/bin/bash', 09:38:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9DuLDunDEt/Listeners', 09:38:41 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 09:38:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:38:41 INFO - 'USER': 'cltbld', 09:38:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:38:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:38:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:41 INFO - 'XPC_FLAGS': '0x0', 09:38:41 INFO - 'XPC_SERVICE_NAME': '0', 09:38:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:38:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:38:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:38:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:38:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:38:43 INFO - Installing collected packages: mozsystemmonitor 09:38:43 INFO - Running setup.py install for mozsystemmonitor 09:38:44 INFO - Successfully installed mozsystemmonitor 09:38:44 INFO - Cleaning up... 09:38:44 INFO - Return code: 0 09:38:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:38: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')]} 09:38:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38: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')]} 09:38:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38: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', '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 0x102294a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10229b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c7bd63c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102138d30>, '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 0x101f5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10212fb20>, '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.UQ0v11LWcG/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.9DuLDunDEt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 09:38: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:38: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 blobuploader==1.2.4 09:38:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UQ0v11LWcG/Render', 09:38:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:38:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:38:44 INFO - 'HOME': '/Users/cltbld', 09:38:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:38:44 INFO - 'LOGNAME': 'cltbld', 09:38:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:44 INFO - 'MOZ_NO_REMOTE': '1', 09:38:44 INFO - 'NO_EM_RESTART': '1', 09:38:44 INFO - 'PAGER': '/bin/cat', 09:38:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:38:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:44 INFO - 'PWD': '/builds/slave/test', 09:38:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:38:44 INFO - 'SHELL': '/bin/bash', 09:38:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9DuLDunDEt/Listeners', 09:38:44 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 09:38:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:38:44 INFO - 'USER': 'cltbld', 09:38:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:38:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:38:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:44 INFO - 'XPC_FLAGS': '0x0', 09:38:44 INFO - 'XPC_SERVICE_NAME': '0', 09:38:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:38:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:44 INFO - Downloading/unpacking blobuploader==1.2.4 09:38:44 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 09:38:44 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 09:38:44 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 09:38:44 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 09:38:44 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 09:38:44 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 09:38:46 INFO - Downloading blobuploader-1.2.4.tar.gz 09:38:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:38:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:38:46 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 09:38:46 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 09:38:46 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 09:38:46 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 09:38:46 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 09:38:46 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 09:38:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:38:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:38:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:47 INFO - Downloading docopt-0.6.1.tar.gz 09:38:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:38:47 INFO - Installing collected packages: blobuploader, requests, docopt 09:38:47 INFO - Running setup.py install for blobuploader 09:38:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:38:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:38:48 INFO - Running setup.py install for requests 09:38:48 INFO - Running setup.py install for docopt 09:38:48 INFO - Successfully installed blobuploader requests docopt 09:38:48 INFO - Cleaning up... 09:38:48 INFO - Return code: 0 09:38:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:38:48 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')]} 09:38:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:48 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')]} 09:38:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:48 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 0x102294a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10229b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c7bd63c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102138d30>, '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 0x101f5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10212fb20>, '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.UQ0v11LWcG/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.9DuLDunDEt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 09:38:48 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 09:38:48 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 09:38:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UQ0v11LWcG/Render', 09:38:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:38:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:38:48 INFO - 'HOME': '/Users/cltbld', 09:38:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:38:48 INFO - 'LOGNAME': 'cltbld', 09:38:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:48 INFO - 'MOZ_NO_REMOTE': '1', 09:38:48 INFO - 'NO_EM_RESTART': '1', 09:38:48 INFO - 'PAGER': '/bin/cat', 09:38:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:38:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:48 INFO - 'PWD': '/builds/slave/test', 09:38:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:38:48 INFO - 'SHELL': '/bin/bash', 09:38:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9DuLDunDEt/Listeners', 09:38:48 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 09:38:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:38:48 INFO - 'USER': 'cltbld', 09:38:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:38:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:38:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:48 INFO - 'XPC_FLAGS': '0x0', 09:38:48 INFO - 'XPC_SERVICE_NAME': '0', 09:38:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:38:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:38:49 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-ZACjwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:38:49 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-tmee2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:38:49 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-Rdgx8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:38:49 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-jON9xs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:38:49 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-ggEhck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:38:49 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-FhYZGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:38:49 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-2UfUvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:38:49 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-QgtnOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:38:49 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-DO1Ujf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:38:49 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-dsLPE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:38:50 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-A6Ywns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:38:50 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-bzHRFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:38:50 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-qMhQre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:38:50 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-M2Trr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:38:50 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-Y8pLth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:38:50 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-rrayPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:38:50 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-Ycl1A_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:38:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:38:50 INFO - Running setup.py install for manifestparser 09:38:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:38:50 INFO - Running setup.py install for mozcrash 09:38:51 INFO - Running setup.py install for mozdebug 09:38:51 INFO - Running setup.py install for mozdevice 09:38:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:38:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:38:51 INFO - Running setup.py install for mozfile 09:38:51 INFO - Running setup.py install for mozhttpd 09:38:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:38:51 INFO - Running setup.py install for mozinfo 09:38:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:38:51 INFO - Running setup.py install for mozInstall 09:38:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:38:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:38:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:38:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:38:51 INFO - Running setup.py install for mozleak 09:38:52 INFO - Running setup.py install for mozlog 09:38:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:38:52 INFO - Running setup.py install for moznetwork 09:38:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:38:52 INFO - Running setup.py install for mozprocess 09:38:52 INFO - Running setup.py install for mozprofile 09:38:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:38:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:38:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:38:52 INFO - Running setup.py install for mozrunner 09:38:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:38:52 INFO - Running setup.py install for mozscreenshot 09:38:52 INFO - Running setup.py install for moztest 09:38:53 INFO - Running setup.py install for mozversion 09:38:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:38:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:38:53 INFO - Cleaning up... 09:38:53 INFO - Return code: 0 09:38:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:38:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:53 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 0x102294a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10229b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c7bd63c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102138d30>, '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 0x101f5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10212fb20>, '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.UQ0v11LWcG/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.9DuLDunDEt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 09:38:53 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 09:38:53 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 09:38:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UQ0v11LWcG/Render', 09:38:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:38:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:38:53 INFO - 'HOME': '/Users/cltbld', 09:38:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:38:53 INFO - 'LOGNAME': 'cltbld', 09:38:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:53 INFO - 'MOZ_NO_REMOTE': '1', 09:38:53 INFO - 'NO_EM_RESTART': '1', 09:38:53 INFO - 'PAGER': '/bin/cat', 09:38:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:38:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:53 INFO - 'PWD': '/builds/slave/test', 09:38:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:38:53 INFO - 'SHELL': '/bin/bash', 09:38:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9DuLDunDEt/Listeners', 09:38:53 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 09:38:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:38:53 INFO - 'USER': 'cltbld', 09:38:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:38:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:38:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:53 INFO - 'XPC_FLAGS': '0x0', 09:38:53 INFO - 'XPC_SERVICE_NAME': '0', 09:38:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:38:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:38:53 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-CgAgbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:38:53 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)) 09:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:38:53 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-CMEfcI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:38:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 09:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:38:53 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-JwPHmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:38:53 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)) 09:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:38:53 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-GDkraF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:38:53 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)) 09:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:38:53 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-vO3N2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:38:54 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)) 09:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:38:54 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-e5_wES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:38:54 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)) 09:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:38:54 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-6yxF6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:38:54 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)) 09:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:38:54 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-8WFkbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:38:54 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)) 09:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:38:54 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-805JaB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:38:54 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)) 09:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:38:54 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-y7RVSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:38:54 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)) 09:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:38:54 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-ZnXEBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:38:54 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)) 09:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:38:54 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-kpcJyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:38:54 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)) 09:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:38:54 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-9IZf6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:38:54 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)) 09:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:38:54 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-UKhkDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:38:55 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)) 09:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:38:55 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-QWw2K0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:38:55 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)) 09:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:38:55 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-DmbEy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:38:55 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)) 09:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:38:55 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-n6GWrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:38:55 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)) 09:38:55 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:38:55 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:38:55 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)) 09:38:55 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)) 09:38:55 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)) 09:38:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:38: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 09:38: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 09:38: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 09:38: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 09:38: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 09:38: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 09:38:57 INFO - Downloading blessings-1.6.tar.gz 09:38:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:38:58 INFO - Installing collected packages: blessings 09:38:58 INFO - Running setup.py install for blessings 09:38:58 INFO - Successfully installed blessings 09:38:58 INFO - Cleaning up... 09:38:58 INFO - Return code: 0 09:38:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:38:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:38:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:38:58 INFO - Reading from file tmpfile_stdout 09:38:58 INFO - Current package versions: 09:38:58 INFO - blessings == 1.6 09:38:58 INFO - blobuploader == 1.2.4 09:38:58 INFO - docopt == 0.6.1 09:38:58 INFO - manifestparser == 1.1 09:38:58 INFO - mozInstall == 1.12 09:38:58 INFO - mozcrash == 0.16 09:38:58 INFO - mozdebug == 0.1 09:38:58 INFO - mozdevice == 0.48 09:38:58 INFO - mozfile == 1.2 09:38:58 INFO - mozhttpd == 0.7 09:38:58 INFO - mozinfo == 0.9 09:38:58 INFO - mozleak == 0.1 09:38:58 INFO - mozlog == 3.1 09:38:58 INFO - moznetwork == 0.27 09:38:58 INFO - mozprocess == 0.22 09:38:58 INFO - mozprofile == 0.28 09:38:58 INFO - mozrunner == 6.11 09:38:58 INFO - mozscreenshot == 0.1 09:38:58 INFO - mozsystemmonitor == 0.0 09:38:58 INFO - moztest == 0.7 09:38:58 INFO - mozversion == 1.4 09:38:58 INFO - psutil == 3.1.1 09:38:58 INFO - requests == 1.2.3 09:38:58 INFO - wsgiref == 0.1.2 09:38:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:38:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:58 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 0x102294a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10229b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c7bd63c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102138d30>, '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 0x101f5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10212fb20>, '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.UQ0v11LWcG/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.9DuLDunDEt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 09:38:58 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 09:38:58 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 09:38:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UQ0v11LWcG/Render', 09:38:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:38:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:38:58 INFO - 'HOME': '/Users/cltbld', 09:38:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:38:58 INFO - 'LOGNAME': 'cltbld', 09:38:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:58 INFO - 'MOZ_NO_REMOTE': '1', 09:38:58 INFO - 'NO_EM_RESTART': '1', 09:38:58 INFO - 'PAGER': '/bin/cat', 09:38:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:38:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:58 INFO - 'PWD': '/builds/slave/test', 09:38:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:38:58 INFO - 'SHELL': '/bin/bash', 09:38:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9DuLDunDEt/Listeners', 09:38:58 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 09:38:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:38:58 INFO - 'USER': 'cltbld', 09:38:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:38:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:38:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:58 INFO - 'XPC_FLAGS': '0x0', 09:38:58 INFO - 'XPC_SERVICE_NAME': '0', 09:38:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:38:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:58 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)) 09:38:58 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)) 09:38:58 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)) 09:38:58 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)) 09:38:58 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)) 09:38:58 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)) 09:38:58 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)) 09:38:58 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)) 09:38:58 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)) 09:38:58 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)) 09:38:58 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)) 09:38:58 INFO - Cleaning up... 09:38:58 INFO - Return code: 0 09:38:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:38:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:58 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 0x102294a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10229b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c7bd63c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102138d30>, '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 0x101f5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10212fb20>, '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.UQ0v11LWcG/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.9DuLDunDEt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 09:38:58 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 09:38:58 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 09:38:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UQ0v11LWcG/Render', 09:38:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:38:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:38:58 INFO - 'HOME': '/Users/cltbld', 09:38:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:38:58 INFO - 'LOGNAME': 'cltbld', 09:38:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:58 INFO - 'MOZ_NO_REMOTE': '1', 09:38:58 INFO - 'NO_EM_RESTART': '1', 09:38:58 INFO - 'PAGER': '/bin/cat', 09:38:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:38:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:58 INFO - 'PWD': '/builds/slave/test', 09:38:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:38:58 INFO - 'SHELL': '/bin/bash', 09:38:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9DuLDunDEt/Listeners', 09:38:58 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 09:38:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:38:58 INFO - 'USER': 'cltbld', 09:38:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:38:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:38:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:58 INFO - 'XPC_FLAGS': '0x0', 09:38:58 INFO - 'XPC_SERVICE_NAME': '0', 09:38:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:38:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:59 INFO - Downloading/unpacking jsonschema 09:38:59 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 09:38:59 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 09:38:59 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 09:38:59 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 09:38:59 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 09:38:59 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 09:39:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:39:01 INFO - Downloading/unpacking functools32 (from jsonschema) 09:39:01 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 09:39:01 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 09:39:01 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 09:39:01 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 09:39:01 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 09:39:01 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 09:39:01 INFO - Downloading functools32-3.2.3-2.tar.gz 09:39:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:39:01 INFO - warning: no files found matching '*.txt' 09:39:01 INFO - no previously-included directories found matching 'build' 09:39:01 INFO - no previously-included directories found matching 'dist' 09:39:01 INFO - no previously-included directories found matching '.git*' 09:39:01 INFO - Installing collected packages: jsonschema, functools32 09:39:01 INFO - Running setup.py install for functools32 09:39:02 INFO - warning: no files found matching '*.txt' 09:39:02 INFO - no previously-included directories found matching 'build' 09:39:02 INFO - no previously-included directories found matching 'dist' 09:39:02 INFO - no previously-included directories found matching '.git*' 09:39:02 INFO - Successfully installed jsonschema functools32 09:39:02 INFO - Cleaning up... 09:39:02 INFO - Return code: 0 09:39:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:39:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:39:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:39:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:02 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 0x102294a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10229b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c7bd63c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102138d30>, '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 0x101f5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10212fb20>, '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.UQ0v11LWcG/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.9DuLDunDEt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 09:39:02 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 09:39:02 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 09:39:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UQ0v11LWcG/Render', 09:39:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:39:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:39:02 INFO - 'HOME': '/Users/cltbld', 09:39:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:39:02 INFO - 'LOGNAME': 'cltbld', 09:39:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:02 INFO - 'MOZ_NO_REMOTE': '1', 09:39:02 INFO - 'NO_EM_RESTART': '1', 09:39:02 INFO - 'PAGER': '/bin/cat', 09:39:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:39:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:02 INFO - 'PWD': '/builds/slave/test', 09:39:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:39:02 INFO - 'SHELL': '/bin/bash', 09:39:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9DuLDunDEt/Listeners', 09:39:02 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 09:39:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:39:02 INFO - 'USER': 'cltbld', 09:39:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:39:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:39:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:02 INFO - 'XPC_FLAGS': '0x0', 09:39:02 INFO - 'XPC_SERVICE_NAME': '0', 09:39:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:39:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:02 INFO - Downloading/unpacking flake8 09:39:02 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 09:39:02 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 09:39:02 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 09:39:02 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 09:39:02 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 09:39:02 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 09:39:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:39:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:39:04 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 09:39:04 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 09:39:04 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 09:39:04 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 09:39:04 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 09:39:04 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 09:39:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:39:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:39:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:39:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:39:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:39:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:39:05 INFO - no previously-included directories found matching 'docs/_build' 09:39:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:39:06 INFO - Running setup.py install for pep8 09:39:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:39:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:39:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:39:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:39:06 INFO - no previously-included directories found matching 'docs/_build' 09:39:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:39:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:39:06 INFO - Cleaning up... 09:39:06 INFO - Return code: 0 09:39:06 INFO - Running post-action listener: _resource_record_post_action 09:39:06 INFO - Running post-action listener: _start_resource_monitoring 09:39:06 INFO - Starting resource monitoring. 09:39:06 INFO - ##### 09:39:06 INFO - ##### Running install step. 09:39:06 INFO - ##### 09:39:06 INFO - Running pre-action listener: _resource_record_pre_action 09:39:06 INFO - Running main action method: install 09:39:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:39:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:39:06 INFO - Reading from file tmpfile_stdout 09:39:06 INFO - Detecting whether we're running mozinstall >=1.0... 09:39:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:39:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:39:06 INFO - Reading from file tmpfile_stdout 09:39:06 INFO - Output received: 09:39:06 INFO - Usage: mozinstall [options] installer 09:39:06 INFO - Options: 09:39:06 INFO - -h, --help show this help message and exit 09:39:06 INFO - -d DEST, --destination=DEST 09:39:06 INFO - Directory to install application into. [default: 09:39:06 INFO - "/builds/slave/test"] 09:39:06 INFO - --app=APP Application being installed. [default: firefox] 09:39:06 INFO - mkdir: /builds/slave/test/build/application 09:39:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:39:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:39:40 INFO - Reading from file tmpfile_stdout 09:39:40 INFO - Output received: 09:39:40 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:39:40 INFO - Running post-action listener: _resource_record_post_action 09:39:40 INFO - ##### 09:39:40 INFO - ##### Running run-tests step. 09:39:40 INFO - ##### 09:39:40 INFO - Running pre-action listener: _resource_record_pre_action 09:39:40 INFO - Running main action method: run_tests 09:39:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:39:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:39:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:39:40 INFO - 2016-02-23 09:39:40.315 screenresolution[1998:10420] starting screenresolution argv=screenresolution get 09:39:40 INFO - 2016-02-23 09:39:40.318 screenresolution[1998:10420] Display 0: 1600x1200x32@60 09:39:40 INFO - 2016-02-23 09:39:40.323 screenresolution[1999:10422] starting screenresolution argv=screenresolution list 09:39:40 INFO - Available Modes on Display 0 09:39:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:39:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:39:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:39:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:39:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:39:40 INFO - Intel Iris: 09:39:40 INFO - Chipset Model: Intel Iris 09:39:40 INFO - Type: GPU 09:39:40 INFO - Bus: Built-In 09:39:40 INFO - VRAM (Dynamic, Max): 1536 MB 09:39:40 INFO - Vendor: Intel (0x8086) 09:39:40 INFO - Device ID: 0x0a2e 09:39:40 INFO - Revision ID: 0x0009 09:39:40 INFO - Displays: 09:39:40 INFO - Display: 09:39:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:39:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:39:40 INFO - Display Serial Number: 1600x1200 60 09:39:40 INFO - Main Display: Yes 09:39:40 INFO - Mirror: Off 09:39:40 INFO - Online: Yes 09:39:40 INFO - Rotation: Supported 09:39:40 INFO - Return code: 0 09:39:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:39:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:39:40 INFO - Python 2.7.3 09:39:40 INFO - Return code: 0 09:39:40 INFO - grabbing minidump binary from tooltool 09:39:40 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')]} 09:39:40 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 0x102138d30>, '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 0x101f5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10212fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:39:40 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 09:39:40 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 09:39:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:39:40 INFO - Return code: 0 09:39:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:39:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:39:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:39:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:39:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:39:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:39:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:39:41 INFO - Return code: 0 09:39:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TQm41WjRQGKOSgizpUpJKw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0166', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:39:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TQm41WjRQGKOSgizpUpJKw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0166 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:39:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UQ0v11LWcG/Render', 09:39:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:39:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:39:41 INFO - 'HOME': '/Users/cltbld', 09:39:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:39:41 INFO - 'LOGNAME': 'cltbld', 09:39:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:39:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:39:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:41 INFO - 'MOZ_NO_REMOTE': '1', 09:39:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:39:41 INFO - 'NO_EM_RESTART': '1', 09:39:41 INFO - 'PAGER': '/bin/cat', 09:39:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:39:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:41 INFO - 'PWD': '/builds/slave/test', 09:39:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:39:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:39:41 INFO - 'SHELL': '/bin/bash', 09:39:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9DuLDunDEt/Listeners', 09:39:41 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 09:39:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:39:41 INFO - 'USER': 'cltbld', 09:39:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:39:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:39:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:41 INFO - 'XPC_FLAGS': '0x0', 09:39:41 INFO - 'XPC_SERVICE_NAME': '0', 09:39:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:39:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TQm41WjRQGKOSgizpUpJKw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0166', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:39:42 INFO - mozversion application_buildid: 20160223075310 09:39:42 INFO - mozversion application_changeset: 25697d5038158fadb93ec3ed76f3c2e84fd4f60f 09:39:42 INFO - mozversion application_display_name: Nightly 09:39:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:39:42 INFO - mozversion application_name: Firefox 09:39:42 INFO - mozversion application_remotingname: firefox 09:39:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:39:42 INFO - mozversion application_vendor: Mozilla 09:39:42 INFO - mozversion application_version: 47.0a1 09:39:42 INFO - mozversion platform_buildid: 20160223075310 09:39:42 INFO - mozversion platform_changeset: 25697d5038158fadb93ec3ed76f3c2e84fd4f60f 09:39:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:39:42 INFO - mozversion platform_version: 47.0a1 09:39:42 INFO - using testdate: 1456249182 09:39:42 INFO - actual date: 1456249182 09:39:42 INFO - starting webserver on 'localhost:49388' 09:39:42 INFO - SUITE-START | Running 2 tests 09:39:42 INFO - TEST-START | dromaeo_css 09:39:42 INFO - operating with platform_type : mac_ 09:39:42 INFO - Initialising browser for dromaeo_css test... 09:39:42 INFO - TEST-INFO | started process 2017 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/tmpg68ddZ/profile http://localhost:49388/getInfo.html) 09:39:45 INFO - PROCESS | 2017 | __metrics Screen width/height:1600/1200 09:39:45 INFO - PROCESS | 2017 | colorDepth:24 09:39:45 INFO - PROCESS | 2017 | Browser inner width/height: 1024/689 09:39:45 INFO - PROCESS | 2017 | __metrics 09:39:45 ERROR - PROCESS | 2017 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 09:39:46 INFO - TEST-INFO | 2017: exit 0 09:39:46 INFO - Browser initialized. 09:39:46 INFO - Running cycle 1/1 for dromaeo_css test... 09:39:46 INFO - TEST-INFO | started process 2021 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/tmpg68ddZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:39:58 INFO - PROCESS | 2021 | RSS: Main: 255950848 09:39:58 INFO - PROCESS | 2021 | 09:40:47 INFO - PROCESS | 2021 | 1456249247699 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] 09:42:58 INFO - PROCESS | 2021 | Cycle 1(1): loaded http://localhost:49388/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49388/tests/dromaeo/cssquery-ext.html) 09:42:59 INFO - PROCESS | 2021 | RSS: Main: 269238272 09:42:59 INFO - PROCESS | 2021 | 09:46:01 INFO - PROCESS | 2021 | Cycle 1(1): loaded http://localhost:49388/tests/dromaeo/cssquery-ext.html (next: http://localhost:49388/tests/dromaeo/cssquery-jquery.html) 09:46:02 INFO - PROCESS | 2021 | RSS: Main: 280473600 09:46:02 INFO - PROCESS | 2021 | 09:49:03 INFO - PROCESS | 2021 | Cycle 1(1): loaded http://localhost:49388/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49388/tests/dromaeo/cssquery-mootools.html) 09:49:04 INFO - PROCESS | 2021 | RSS: Main: 282243072 09:49:04 INFO - PROCESS | 2021 | 09:52:06 INFO - PROCESS | 2021 | Cycle 1(1): loaded http://localhost:49388/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49388/tests/dromaeo/cssquery-prototype.html) 09:52:06 INFO - PROCESS | 2021 | RSS: Main: 284844032 09:52:06 INFO - PROCESS | 2021 | 09:55:09 INFO - PROCESS | 2021 | Cycle 1(1): loaded http://localhost:49388/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49388/tests/dromaeo/cssquery-yui.html) 09:55:09 INFO - PROCESS | 2021 | RSS: Main: 286707712 09:55:09 INFO - PROCESS | 2021 | 09:58:12 INFO - PROCESS | 2021 | Cycle 1(1): loaded http://localhost:49388/tests/dromaeo/cssquery-yui.html (next: http://localhost:49388/tests/dromaeo/cssquery-dojo.html) 09:58:12 INFO - PROCESS | 2021 | RSS: Main: 288407552 09:58:12 INFO - PROCESS | 2021 | 09:58:12 INFO - PROCESS | 2021 | __start_tp_report 09:58:12 INFO - PROCESS | 2021 | _x_x_mozilla_page_load 09:58:12 INFO - PROCESS | 2021 | _x_x_mozilla_page_load_details 09:58:12 INFO - PROCESS | 2021 | |i|pagename|runs| 09:58:12 INFO - PROCESS | 2021 | |0;dojo.html;3497.370473314803;3527.8765243216476;3551.520544726461;3592.3174596826593;3599.712023038157;5707.942920570793;5746.856328591787;5758.625689330196;5771.076627739562;5771.451712087355;5664.0937450008005;5782.797602083928;5824.708764561766;5869.559783016281;5896.911546326808;5154.5103215194495;5205.817796377128;5214.60890433219;5227.869303267411;5250.6324557281005;5250.921236181442;5251.407783923843;5297.735113244342;5304.257403963448;5305.920411193835;5141.203113517392;5229.320188375486;5241.528262456378;5255.710935898524;5255.973720131413;5156.407013193493;5184.403793563751;5187.922181167285;5212.452692467312;5226.712530810842;5114.181730923035;5152.793888244466;5155.123628983082;5187.688738675692;5193.538433975978;4753.3107699383745;5641.943580564224;5674.319081710221;5674.546036317126;5751.942480575182;6095.298564469898;6180.887440260752;6228.4394404503355;6268.9969604863;6279.6860156992425;6080.452759251644;6164.722587483529;6206.379362063803;6227.532935029845;6273.341299163568;5908.720660033679;5933.199018132497;5947.37552556984;5962.910556341659;5976.8505787355225;6188.1027251048345;6245.219347581552;6286.245650521875;6325;6330.873382532323;6195.4424101831055;6198.81403557894;6199.287081985539;6235;6250.843728906813;6155.96922015396;6259.061140828821;6266.780662676784;6279.874402511924;6286.214223222098;6140.166841500503;6207.6585787782105;6265.561410701207;6266.49868010558;6287.088372186007;6240.500759939194;6244.46922011625;6268.561200715997;6268.905966410507;6283.59156654816;4812.35033270511;4880.097182021266;4916.360873086476;4944.579710724557;4959.851204463872;3619.9276014480088;3933.331333673282;4083.2854250506043;4382.715123516961;4437.201303765289;5854.4730974212525;5862.267216597926;5881.32364778056;5913.29040515141;5946.791862284799;6108.008189064103;6156.230471191101;6187.195664563578;6196.752129914843;6200.968995154995;5831;5875.9118613220835;5885.940530704429;5902.1441890926435;5913;5357.4106848246665;5422.620416570881;5431.266778984866;5469.617126801086;5490.670559766427;6192.566520343533;6372.394622510854;6377.872442551123;6390.712417941204;6403.58376705522;6180.81457556274;6261.405166509175;6276.529260305587;6285.748570057147;6291.496680265659;6253.843653908689;6272.968635156795;6285.214348206474;6372.458341041063;6411.6794160290865;6140.692965351804;6160.784372546939;6175.104609831639;6175.6912154393;6206.10011548332;6197.876042479035;6230.221222347207;6232.844178895564;6239.376062393724;6243.8126856194385;6142.815715528542;6143.631382117087;6149.385061493815;6151.907721384272;6173.166622505904;4730.574248317668;6115.449609535163;6133.325334213144;6211.503079753699;6228.190335256388;5841.094630332305;5941.910871336847;6067.575269731076;6149.508039356751;6200.534959878118;6207.720652570735;6225.782097626561;6237.4698150657705;6255.46828519581;6258.4680302173;6090.725917333642;6128;6133.723982420713;6137.018077107641;6142.723577439116 09:58:12 INFO - PROCESS | 2021 | |1;ext.html;413.5141209079331;436.1821584529008;504.39724529187635;532.4382776171141;601.6450294326347;28234.717652823467;31021.534676979805;37322.81338593306;37699.62300376996;37797;38845.80577097118;39291;39326.21347573054;39341.21317573647;39487.802560987155;9296.302777291714;9487.81024379512;9521.095495927875;9521.143097121258;9528;9479.573419196118;9597.520123993807;9598.184154346889;9603.279754018442;9611.855822162674;9567.712968610953;9577.664781732641;9633.181179599742;9658.855117173212;9662.613495460173;9548.331616786827;9606;9611.951940240324;9634.084761947604;9636.566354513994;9449.480278584675;9453.86553613564;9559.665411710626;9573.617055317849;9588.376755510939;37602.247955040744;37653;37979.62020379789;38179.42730859039;38279.04302392434;3088.644805847334;3163;3181.602299712536;3310.6192787829227;3519.489673997256;28590;28791.56812647791;29091.85454072716;29308.706912931026;29479.557806632918;2811.8031737778365;2861.556458748897;2902.3179552805072;2906.854657267128;3006.6241719785025;504050.99999999633;504169;506994;508983;509444;44487;45661.85845353893;66364;66856.33143668598;66916;37254.25491490155;42989;44384.66845994625;44583;44754.55245447504;15011.699766004836;15035.473758418402;15323.693526129638;15522;15607.531774046796;12381.00951923844;12469.688257793447;12544.310062946626;12598.622041338775;12624.873751262554;14364.922630802732;14446.711065778625;14744.467202877468;14748.63128421798;14790.778138327934;5443.537299329522;5665.895150445706;5790.681512516852;6382.170317858741;6411.455026322815;920.558132096584;980.8479685648736;994.8855881573567;1017.7506510904876;1089.003561740998;23225.419364516023;27115;27541.86229068882;27735;28482.8084872964;1084.6908631040117;1093.8413929980268;1098.7308109513222;1111.9610813621646;1115.6206889657556;14975.925120374546;14987.775183372258;15141.924290378478;15411.383544658313;15417.537473875802;474579;486744;489309;490145;494336;58850.705746470994;59439.919602813694;59597;59960.40039599635;60154;1446.7540518111737;1451.1945870042016;1476.6603681153395;1483.399223314581;1489.0246888288189;29790;30154.643041062765;30226.9420570279;30322.54516182215;30421.391572168875;51802.74098629633;51940.740296298274;52387.47612523826;52547.474525255784;52699;446801;447948;449393;450513;452160.7391963019;34054.48918266178;34411.4838277421;45644.315335270665;47682.52317476781;47727.28409073797;44441;44464.93085835306;44681.32978005268;44694.55305446904;45017.774911125234;36537.63462365342;36953.44569831401;37592.62407375891;37664.246715065;37892.62107378891;35985.640143598226;36542.88989682521;36629.450558241115;36856;36942.26115477621;28728.856355718086;32203.838980804947;36399;36868.63131368652;37756;24112.276631701076;27643.44713105767;29846;33589.66410335866;33682.3263534723;24581.754182457946;25071.623925640764;25285.62071568965;25396.873015634803;25569.9365349061 09:58:12 INFO - PROCESS | 2021 | |2;jquery.html;358.4712548990238;358.64852444604287;360.18777656384856;366.1870647163298;368.79347565363383;13804.516841910536;18823.811761882378;19303.90348048261;19994;20500.179992800287;11737;12148.93925530371;12150.27098374096;19828.801711982876;19987.000649967515;5250.501202385777;5336.546393556552;5423.2136340230645;5429.4526060072885;5444.727763611823;5119.078565858144;5405.945940540583;5407.567394608422;5437.374701909272;5437.592180586452;5372.7045012524295;5420.512153906147;5514.172874068881;5714.971425142869;5767.798127065554;5602.887942241173;5631.690257035862;5689.317281926154;5705.999999999979;5942.910856337158;5559.33288005442;5575.8884822303735;5629.352624448159;5633.15502674598;5661.971690141523;12852.293123878182;13074.215547067111;17063.658726825393;23320.88339558308;23324.53350932989;2393.222202784085;2395.221552995266;2460.5447992121517;2629.382095207625;2803.0609745735205;9544.42733435996;9552.952235238849;9852;10042.447665378475;10130.645427410005;1784.7501349811037;1812.673718730628;1835.07328798957;1851.6111616560538;1898.6392585408728;61241.38758612446;102947.45578816324;106511.46744266307;108409.45795270974;109743.45128274387;10020.899791001997;10081.840588332288;10192.337498062601;11533.21235208544;11538.711532211593;12267.69330766738;13105.410256538478;13535.796963045563;13653.726925461435;13669.359676838843;7459.70161193557;8084.908537347383;8303.792405189919;8394.370422218359;8554.14458554152;7382.22486638906;8762.693305734269;8814.250788682906;8830.337724670675;8871.112888711077;4448.911021779546;4462.910741785211;4548.385967894358;4552.840650577214;4596.770161491912;1885.1893685715;1914.9904250478658;1949.2397964793743;1977.8417726582127;1985.811347921945;862.784303924019;953.7648744875403;985.4432245781111;987.4272921705393;1008.2589296866797;18527.166277517543;20880.895595521924;21638.567228655655;22399.77600223977;23004.309870703906;937.9437233765996;958.4009993753904;972.6984634763246;979.0747743382435;984.5864736810556;9029.961554421194;10396.792064158826;11021.724456888642;11148.55251531367;11602.245854019462;512247;522966;523278;599033;654290;109937;122758.38620806839;124698.37650811688;124961;128100.35949820191;1055.8574592429923;1059.3855563773147;1069.3690722473777;1112.065864673678;1114.7380365614074;18450.169742361893;18613.627727445648;18711.812881871007;18748.968806715762;18832.6233475327;38058.809705951295;50912.490875092255;53293.733531332095;54352.72823635856;55357;71947.64026179835;74044.62977685076;74092.25907740854;75036;75144.24855751373;7925.564093974886;8040.517568945882;8140.75577732669;8168.142345053684;8205.097439281793;10143.289969702346;12845.678858028625;13200.339983001004;13259.270740109387;13461.259630720404;11652.242604230698;11702.648920532398;11808.645740627795;11910.344931028876;11910.583129590423;8179.61756212023;8194.044857691972;11488.368139752394;11973.341466219441;12003;8256.463329883538;8267.462614930011;8547.316214702932;8648.1784230498;8724.56377181151;11781.906002225298;12136.696582585506;12206.694832629255;12268.754624907631;12301.75396492083;12125.029997599995;12152.57465988686;12199;12207.69480762988;12225.08311876595 09:58:12 INFO - PROCESS | 2021 | |3;mootools.html;1564.327339244125;1585.0410501646504;1851.972220416693;1930.8841469511822;1948.8635795494322;7812.101608315045;8401.579921003957;8531.146885311466;8691.56542172892;8725.43284686495;8421.578921053953;8494.023187333443;8555.272801811854;8561.272291855199;8573.356998225143;2034.4201902457803;2411.5176964607062;2426.3206302235403;2435.4398488347692;2455.067074511683;2426.2842461473906;2428.7935525480266;2449.4121410861444;2454.914078007261;2456.7666071723247;2384.8807559622037;2431.465077682907;2431.4772323950347;2451.1493822164243;2474.925752227436;2420.7942324902315;2441.145599040339;2444.7799698027175;2446.902123915041;2453.4725034117573;2474.9752502474926;2492.850428974249;2499.125306142854;2503.0113105323476;2509.2221411362534;8529.402941794076;8687.739367818975;8729.60716767747;8739.694110706158;8739.868901966476;5305.8938821223355;5425.294711687456;5445.564354851603;5472.330939063584;5480.808171713971;3003.2041509000132;3540.9468857966895;3558.839852206631;3612.4039533477207;3633.709303255733;998.4059484606647;1071.132382769959;1075.0754351257913;1092.5520536579963;1100.1748688483638;11522.481488332962;11586.18896677233;11630.360330181837;11692.766144677058;11708.004819590346;3937.153511994935;4632.235681112578;4661.184292748823;4662.254039353687;4689.929651055237;9139.588718507683;9203.539823008823;9217.354785165107;9237.769055773659;9258.259339252978;4729.6452766042685;5257.211418287287;5283.894322113536;5311.150215965427;5366.382865970385;4410;4788.162071637519;4843.515648435199;4897.730624815598;4955.4796746341835;3725.832337544817;3754.4931434256027;3775.7923314217433;3783.886483405502;3805.353089974711;1177.7467844413493;1190.089581470176;1198.0415667465993;1198.9520419183134;1200.9939950300193;1049.4333060147587;1062.654637242899;1062.829947208443;1234.5247079874314;1396.63687441266;8008.439409241297;8062.959685201654;8131.878021829677;8133.268005879381;8162.959185204036;514.9639525233198;518.3313525551996;523.9554637855749;526.4866754914004;527.3197575128041;5990.161377407167;6036.879262414815;6098.817035488943;6112.327643959161;6132.478739307119;8036.6785328587375;8441.746747597583;10078.798424031478;10228.948855255676;10366;9949.353292035994;10096.242781791396;10149;10156.949215253877;10221.43782091992;8052.516848989197;8054.5569993650915;8060.8387832243025;8077.474964127313;8126.674933002732;7776.766696999099;7842.568658723825;7913.089994650459;7967.04395472547;8131.308838748772;9225.953870230605;9250;9464.19554337889;9574.377665451724;9691;9506.667266645634;9659.32384733062;9689.70930872075;9848.753781155528;9984.35101718386;5787.36339002701;6754.18949726036;7166.319199676022;7486.775396738107;7578.052743407075;8005.719799806979;8064.3548516119745;8082.949216602039;8118.715844945398;8123.593820308843;7096.680649370894;7267.745628902963;7274.636268186464;7325;7379.963100184465;7071.858562828817;7081.221065682874;7110.075690160453;7188.640567971685;7230.385417239383;7617.5048621839405;7699.268569486114;7709.2290770922455;7713.344365728976;7719.536827790351;5984.311804142405;6875.724971001104;6887.483438742014;6921.515493915377;6967.756128535477;5873.060310350324;6123.357047509948;6385.201849768779;6984.371406573433;7100.183478899786 09:58:12 INFO - PROCESS | 2021 | |4;prototype.html;260.61429084954267;323.702193981537;328.3400365265815;336.8686212377173;339.9762016658835;6855.931440685604;6868.210155832081;7022.157341119073;7153;7160.964195179024;7013.824654383643;7032.296770322965;7062.435005199584;7076.292370762922;7078.610676412795;5062.797488100471;5068.72122033288;5073.340465739467;5081.060003899272;5085.669431486951;4395.197968832779;5055;5062.443131255559;5077.416097148838;5092.236164575306;4969.726665033421;5001.424836143836;5006.849794506171;5008;5015.3730783652045;4805.3272541844;4972.627052971042;4998.675086119409;5012.047710934929;5012.070352914118;4109;4189.455370801807;4204.07510347723;4215.3887686285625;4242.193983143224;6646.368594983469;6671.132752742113;6686.197656281277;6688.799336019879;6695.230048544431;5745.971270143623;5863.677497737623;5875.6474611523445;5887.499562537189;5892.764289428418;7186.281371862824;7301;7324;7327.267273272683;7365.991126034294;4008.398740188966;4670.206064968964;4671.556202160789;4673.859784206479;4688.953110468886;7798.337141342992;7899.763007109738;7907.130215676271;7918.4061195409995;7919.96040019802;4348.695591308641;4554.476235232924;4753.453352864396;4762.214234651244;4765.642576806753;3766.9452553285123;4756.310335001405;4811.855644330676;4870.025994800983;4873.878153046202;5892.263467066617;5896.3219229788265;5901.616394934315;5909.763609455574;5914.935311643945;7459.738909138154;7477.140128885139;7501.5372002459;7510.737124200627;7539.962300188464;1675.7151284281701;1693.314207745865;1695.5676302542772;1696.211261763286;1697.5077227604104;1004.4073996342194;1035.3529044347283;1056.2025670618634;1075.4783929794044;1092.2900114925362;6825.35159159879;6827.180738311435;6841.657917104125;6920.238773734885;6949.027136200936;7714.5756983366455;7741.690332386754;7744.380449564022;7751.069871615329;7759.922400776033;6858.5199036068;6876.934075218349;6876.965615171892;6893.586384816927;6906.447484201352;3859.208862183246;4065.8780236592947;4078.877633670995;4081.8163182656854;4099.528554216244;7873;7939.2060793920145;7969.481983671043;7977.5612341321785;8009.519428834288;6400.359964003563;7093.219745827955;7404;7903.604819758989;7938.722144724907;5452.890942181213;7323.743668971667;7957.482763620346;7978.920210797934;7980.3615710743;7325.41396688253;7661.042369703787;7678.848172774128;7689.077310722749;7713.42149338813;6073.392660733891;7426.443016773872;7484.288992545699;7492;7532.472726909064;6407.455366293917;7951.681932722858;7962.800929976797;7963.6814527418255;7974.880376794236;3796.46849441084;3965.821538030738;4802.807887684454;4804.95195048045;4826.975865120652;6225.31521532622;6519.445847102859;7590.278923502258;7620.428467865043;7911.406644501801;7561.130469996021;7603.0876294844975;7603.619819009138;7608.087029556267;7621.675389006185;7594.544327340377;7595.202503737028;7612;7621.275978782007;7626.923730762622;6409.359064093554;7025.473089518205;7389.778306650809;7411.184769675224;7442.776716698508;7158.105236845395;7266.273372662691;7548;7564.130125035691;7570.356519695888;5952.916479232234;7249.311315425026;7253;7288.708451662086;7399.519031262951 09:58:12 INFO - PROCESS | 2021 | |5;yui.html;646.7574659502686;683.3030309084737;694.9999999999999;737.4616529933148;737.5058710663855;14504.709905801878;14828.77756833647;14832.406703731838;14876.628084297885;16816.22532282172;15824.604384890383;15905.602359940978;15945.681086378294;15966.600834979132;16002.59993500163;730.631031329178;878.3236907581158;887.2635712358726;896.0949441064539;913.899471058183;868.9131086891292;885.8139790643972;893.3166127912152;896.7489103051156;903.0788595632451;889.3596610440472;912.8128733609594;954.1126752120525;959.7264779537833;959.7936443664611;919.9862002069974;937.6530683647026;947.3984020147187;948.7296120605663;950.6625148072438;684.4832151725465;687.285223367697;695.2074634916199;707.3174386716792;711.1679335177854;15060;15257.38970441181;15297.923510382489;15305.928584999054;15389.846101539066;11047.392393418359;12438.81341779865;12525.686857828536;12768.170068945488;12807.975361971019;9732.41605503672;10069;10241.795164096677;10259.333143345659;10293;3436.0722604896787;3480.269143479872;3510.052285882823;3555.8044307563073;3674.393725035393;80851;82329.58835205846;82654.58672706598;83167.75248371279;84183.57908210481;7932.762017139495;9113.453192808453;9284.396514226553;9572.186364158984;9864.309498335191;17040.914795425942;20259.59480810405;20431.38705838827;20457.2839950601;20459;7383.9261607384315;7395.963020184865;7435.1449583297535;7542.094948606203;7593.6582853771715;3883.572806991229;3950.1164150170534;4006.979965100156;4080.367543030776;4115;3480.5127282180515;3500.177458297298;3505.4391297392294;3513.4202856528896;3522.964770352315;637.8596708724074;648.1541588227315;648.3192647719969;668.6322522612544;669.4242951062083;513.6892180230981;580.7647902599454;625.0655270370825;629.6096420219402;635.920509936258;7805.687772489036;8238.876416853753;8387.370947178986;8450.408471407065;8755.343349248831;606.0575804623764;619.1734035063241;629.5404354821006;632.4339715954195;635.2567496029657;3960.4455376247347;4329.826806927751;4373.934390984138;4428.778561071934;4476.127155204769;67692;71260.64369678119;82050.53848384558;91612;92012.07987920169;67812.66093669599;68954;69206;69371.65314173397;69718.60562788715;51608;62582;63531;66235.34411639652;73163;8844.380893337404;8874.245689116497;8899.510526921082;8996.769526527414;9058.773530661523;47095;48195.277070843265;48388.7580562109;49296.75351623219;50052;59162.5209369752;61127.69436152791;62041.37958620537;62794.05808912961;62972.685136575856;10484;10861.837072444077;10954.616588419367;11145.442727863736;11201.831972520256;11601.651950441501;11855.495251017557;11933.641990740292;12324.876751232372;12485.750284994068;10911.399873007062;11105;11224.382658953837;11278.718032049264;11762.059035277329;10759.246852720235;11326.037286830711;11413.543458261576;11486.253393529394;11854.350630022545;10460;11086.22396432242;11089.22375433712;11320.981111699986;11897.405129743305;7174.354308112295;9544.618215271312;9677.854832177381;9699.88451328078;9944.906060333213;8912.86630700553;9856.31005829585;9872.210223182272;9904.455254961047;9927 09:58:12 INFO - PROCESS | 2021 | __end_tp_report 09:58:12 INFO - PROCESS | 2021 | __start_cc_report 09:58:12 INFO - PROCESS | 2021 | _x_x_mozilla_cycle_collect,344 09:58:12 INFO - PROCESS | 2021 | __end_cc_report 09:58:12 INFO - PROCESS | 2021 | __startTimestamp1456250292603__endTimestamp 09:58:12 INFO - PROCESS | 2021 | 09:58:12 INFO - PROCESS | 2021 | ------- Summary: start ------- 09:58:12 INFO - PROCESS | 2021 | Number of tests: 6 09:58:12 INFO - PROCESS | 2021 | 09:58:12 INFO - PROCESS | 2021 | [#0] dojo.html Cycles:165 Average:5769.78 Median:6108.01 stddev:662.81 (10.9%) stddev-sans-first:640.42 09:58:12 INFO - PROCESS | 2021 | Values: 3497.4 3527.9 3551.5 3592.3 3599.7 5707.9 5746.9 5758.6 5771.1 5771.5 5664.1 5782.8 5824.7 5869.6 5896.9 5154.5 5205.8 5214.6 5227.9 5250.6 5250.9 5251.4 5297.7 5304.3 5305.9 5141.2 5229.3 5241.5 5255.7 5256.0 5156.4 5184.4 5187.9 5212.5 5226.7 5114.2 5152.8 5155.1 5187.7 5193.5 4753.3 5641.9 5674.3 5674.5 5751.9 6095.3 6180.9 6228.4 6269.0 6279.7 6080.5 6164.7 6206.4 6227.5 6273.3 5908.7 5933.2 5947.4 5962.9 5976.9 6188.1 6245.2 6286.2 6325.0 6330.9 6195.4 6198.8 6199.3 6235.0 6250.8 6156.0 6259.1 6266.8 6279.9 6286.2 6140.2 6207.7 6265.6 6266.5 6287.1 6240.5 6244.5 6268.6 6268.9 6283.6 4812.4 4880.1 4916.4 4944.6 4959.9 3619.9 3933.3 4083.3 4382.7 4437.2 5854.5 5862.3 5881.3 5913.3 5946.8 6108.0 6156.2 6187.2 6196.8 6201.0 5831.0 5875.9 5885.9 5902.1 5913.0 5357.4 5422.6 5431.3 5469.6 5490.7 6192.6 6372.4 6377.9 6390.7 6403.6 6180.8 6261.4 6276.5 6285.7 6291.5 6253.8 6273.0 6285.2 6372.5 6411.7 6140.7 6160.8 6175.1 6175.7 6206.1 6197.9 6230.2 6232.8 6239.4 6243.8 6142.8 6143.6 6149.4 6151.9 6173.2 4730.6 6115.4 6133.3 6211.5 6228.2 5841.1 5941.9 6067.6 6149.5 6200.5 6207.7 6225.8 6237.5 6255.5 6258.5 6090.7 6128.0 6133.7 6137.0 6142.7 09:58:12 INFO - PROCESS | 2021 | 09:58:12 INFO - PROCESS | 2021 | [#1] ext.html Cycles:180 Average:61803.53 Median:37844.81 stddev:128082.84 (338.4%) stddev-sans-first:128359.21 09:58:12 INFO - PROCESS | 2021 | Values: 413.5 436.2 504.4 532.4 601.6 28234.7 31021.5 37322.8 37699.6 37797.0 38845.8 39291.0 39326.2 39341.2 39487.8 9296.3 9487.8 9521.1 9521.1 9528.0 9479.6 9597.5 9598.2 9603.3 9611.9 9567.7 9577.7 9633.2 9658.9 9662.6 9548.3 9606.0 9612.0 9634.1 9636.6 9449.5 9453.9 9559.7 9573.6 9588.4 37602.2 37653.0 37979.6 38179.4 38279.0 3088.6 3163.0 3181.6 3310.6 3519.5 28590.0 28791.6 29091.9 29308.7 29479.6 2811.8 2861.6 2902.3 2906.9 3006.6 504051.0 504169.0 506994.0 508983.0 509444.0 44487.0 45661.9 66364.0 66856.3 66916.0 37254.3 42989.0 44384.7 44583.0 44754.6 15011.7 15035.5 15323.7 15522.0 15607.5 12381.0 12469.7 12544.3 12598.6 12624.9 14364.9 14446.7 14744.5 14748.6 14790.8 5443.5 5665.9 5790.7 6382.2 6411.5 920.6 980.8 994.9 1017.8 1089.0 23225.4 27115.0 27541.9 27735.0 28482.8 1084.7 1093.8 1098.7 1112.0 1115.6 14975.9 14987.8 15141.9 15411.4 15417.5 474579.0 486744.0 489309.0 490145.0 494336.0 58850.7 59439.9 59597.0 59960.4 60154.0 1446.8 1451.2 1476.7 1483.4 1489.0 29790.0 30154.6 30226.9 30322.5 30421.4 51802.7 51940.7 52387.5 52547.5 52699.0 446801.0 447948.0 449393.0 450513.0 452160.7 34054.5 34411.5 45644.3 47682.5 47727.3 44441.0 44464.9 44681.3 44694.6 45017.8 36537.6 36953.4 37592.6 37664.2 37892.6 35985.6 36542.9 36629.5 36856.0 36942.3 28728.9 32203.8 36399.0 36868.6 37756.0 24112.3 27643.4 29846.0 33589.7 33682.3 24581.8 25071.6 25285.6 25396.9 25569.9 09:58:12 INFO - PROCESS | 2021 | 09:58:12 INFO - PROCESS | 2021 | [#2] jquery.html Cycles:180 Average:32688.22 Median:2427.88 stddev:94127.17 (3876.9%) stddev-sans-first:94359.92 09:58:12 INFO - PROCESS | 2021 | Values: 358.5 358.6 360.2 366.2 368.8 13804.5 18823.8 19303.9 19994.0 20500.2 11737.0 12148.9 12150.3 19828.8 19987.0 5250.5 5336.5 5423.2 5429.5 5444.7 5119.1 5405.9 5407.6 5437.4 5437.6 5372.7 5420.5 5514.2 5715.0 5767.8 5602.9 5631.7 5689.3 5706.0 5942.9 5559.3 5575.9 5629.4 5633.2 5662.0 12852.3 13074.2 17063.7 23320.9 23324.5 2393.2 2395.2 2460.5 2629.4 2803.1 9544.4 9553.0 9852.0 10042.4 10130.6 1784.8 1812.7 1835.1 1851.6 1898.6 61241.4 102947.5 106511.5 108409.5 109743.5 10020.9 10081.8 10192.3 11533.2 11538.7 12267.7 13105.4 13535.8 13653.7 13669.4 7459.7 8084.9 8303.8 8394.4 8554.1 7382.2 8762.7 8814.3 8830.3 8871.1 4448.9 4462.9 4548.4 4552.8 4596.8 1885.2 1915.0 1949.2 1977.8 1985.8 862.8 953.8 985.4 987.4 1008.3 18527.2 20880.9 21638.6 22399.8 23004.3 937.9 958.4 972.7 979.1 984.6 9030.0 10396.8 11021.7 11148.6 11602.2 512247.0 522966.0 523278.0 599033.0 654290.0 109937.0 122758.4 124698.4 124961.0 128100.4 1055.9 1059.4 1069.4 1112.1 1114.7 18450.2 18613.6 18711.8 18749.0 18832.6 38058.8 50912.5 53293.7 54352.7 55357.0 71947.6 74044.6 74092.3 75036.0 75144.2 7925.6 8040.5 8140.8 8168.1 8205.1 10143.3 12845.7 13200.3 13259.3 13461.3 11652.2 11702.6 11808.6 11910.3 11910.6 8179.6 8194.0 11488.4 11973.3 12003.0 8256.5 8267.5 8547.3 8648.2 8724.6 11781.9 12136.7 12206.7 12268.8 12301.8 12125.0 12152.6 12199.0 12207.7 12225.1 09:58:12 INFO - PROCESS | 2021 | 09:58:12 INFO - PROCESS | 2021 | [#3] mootools.html Cycles:180 Average:5854.61 Median:5634.09 stddev:3082.12 (54.7%) stddev-sans-first:3073.90 09:58:12 INFO - PROCESS | 2021 | Values: 1564.3 1585.0 1852.0 1930.9 1948.9 7812.1 8401.6 8531.1 8691.6 8725.4 8421.6 8494.0 8555.3 8561.3 8573.4 2034.4 2411.5 2426.3 2435.4 2455.1 2426.3 2428.8 2449.4 2454.9 2456.8 2384.9 2431.5 2431.5 2451.1 2474.9 2420.8 2441.1 2444.8 2446.9 2453.5 2475.0 2492.9 2499.1 2503.0 2509.2 8529.4 8687.7 8729.6 8739.7 8739.9 5305.9 5425.3 5445.6 5472.3 5480.8 3003.2 3540.9 3558.8 3612.4 3633.7 998.4 1071.1 1075.1 1092.6 1100.2 11522.5 11586.2 11630.4 11692.8 11708.0 3937.2 4632.2 4661.2 4662.3 4689.9 9139.6 9203.5 9217.4 9237.8 9258.3 4729.6 5257.2 5283.9 5311.2 5366.4 4410.0 4788.2 4843.5 4897.7 4955.5 3725.8 3754.5 3775.8 3783.9 3805.4 1177.7 1190.1 1198.0 1199.0 1201.0 1049.4 1062.7 1062.8 1234.5 1396.6 8008.4 8063.0 8131.9 8133.3 8163.0 515.0 518.3 524.0 526.5 527.3 5990.2 6036.9 6098.8 6112.3 6132.5 8036.7 8441.7 10078.8 10228.9 10366.0 9949.4 10096.2 10149.0 10156.9 10221.4 8052.5 8054.6 8060.8 8077.5 8126.7 7776.8 7842.6 7913.1 7967.0 8131.3 9226.0 9250.0 9464.2 9574.4 9691.0 9506.7 9659.3 9689.7 9848.8 9984.4 5787.4 6754.2 7166.3 7486.8 7578.1 8005.7 8064.4 8082.9 8118.7 8123.6 7096.7 7267.7 7274.6 7325.0 7380.0 7071.9 7081.2 7110.1 7188.6 7230.4 7617.5 7699.3 7709.2 7713.3 7719.5 5984.3 6875.7 6887.5 6921.5 6967.8 5873.1 6123.4 6385.2 6984.4 7100.2 09:58:12 INFO - PROCESS | 2021 | 09:58:12 INFO - PROCESS | 2021 | [#4] prototype.html Cycles:180 Average:5979.36 Median:6848.79 stddev:1964.64 (28.7%) stddev-sans-first:1922.69 09:58:12 INFO - PROCESS | 2021 | Values: 260.6 323.7 328.3 336.9 340.0 6855.9 6868.2 7022.2 7153.0 7161.0 7013.8 7032.3 7062.4 7076.3 7078.6 5062.8 5068.7 5073.3 5081.1 5085.7 4395.2 5055.0 5062.4 5077.4 5092.2 4969.7 5001.4 5006.8 5008.0 5015.4 4805.3 4972.6 4998.7 5012.0 5012.1 4109.0 4189.5 4204.1 4215.4 4242.2 6646.4 6671.1 6686.2 6688.8 6695.2 5746.0 5863.7 5875.6 5887.5 5892.8 7186.3 7301.0 7324.0 7327.3 7366.0 4008.4 4670.2 4671.6 4673.9 4689.0 7798.3 7899.8 7907.1 7918.4 7920.0 4348.7 4554.5 4753.5 4762.2 4765.6 3766.9 4756.3 4811.9 4870.0 4873.9 5892.3 5896.3 5901.6 5909.8 5914.9 7459.7 7477.1 7501.5 7510.7 7540.0 1675.7 1693.3 1695.6 1696.2 1697.5 1004.4 1035.4 1056.2 1075.5 1092.3 6825.4 6827.2 6841.7 6920.2 6949.0 7714.6 7741.7 7744.4 7751.1 7759.9 6858.5 6876.9 6877.0 6893.6 6906.4 3859.2 4065.9 4078.9 4081.8 4099.5 7873.0 7939.2 7969.5 7977.6 8009.5 6400.4 7093.2 7404.0 7903.6 7938.7 5452.9 7323.7 7957.5 7978.9 7980.4 7325.4 7661.0 7678.8 7689.1 7713.4 6073.4 7426.4 7484.3 7492.0 7532.5 6407.5 7951.7 7962.8 7963.7 7974.9 3796.5 3965.8 4802.8 4805.0 4827.0 6225.3 6519.4 7590.3 7620.4 7911.4 7561.1 7603.1 7603.6 7608.1 7621.7 7594.5 7595.2 7612.0 7621.3 7626.9 6409.4 7025.5 7389.8 7411.2 7442.8 7158.1 7266.3 7548.0 7564.1 7570.4 5952.9 7249.3 7253.0 7288.7 7399.5 09:58:12 INFO - PROCESS | 2021 | 09:58:12 INFO - PROCESS | 2021 | [#5] yui.html Cycles:180 Average:17404.56 Median:629.58 stddev:23704.01 (3765.1%) stddev-sans-first:23737.11 09:58:12 INFO - PROCESS | 2021 | Values: 646.8 683.3 695.0 737.5 737.5 14504.7 14828.8 14832.4 14876.6 16816.2 15824.6 15905.6 15945.7 15966.6 16002.6 730.6 878.3 887.3 896.1 913.9 868.9 885.8 893.3 896.7 903.1 889.4 912.8 954.1 959.7 959.8 920.0 937.7 947.4 948.7 950.7 684.5 687.3 695.2 707.3 711.2 15060.0 15257.4 15297.9 15305.9 15389.8 11047.4 12438.8 12525.7 12768.2 12808.0 9732.4 10069.0 10241.8 10259.3 10293.0 3436.1 3480.3 3510.1 3555.8 3674.4 80851.0 82329.6 82654.6 83167.8 84183.6 7932.8 9113.5 9284.4 9572.2 9864.3 17040.9 20259.6 20431.4 20457.3 20459.0 7383.9 7396.0 7435.1 7542.1 7593.7 3883.6 3950.1 4007.0 4080.4 4115.0 3480.5 3500.2 3505.4 3513.4 3523.0 637.9 648.2 648.3 668.6 669.4 513.7 580.8 625.1 629.6 635.9 7805.7 8238.9 8387.4 8450.4 8755.3 606.1 619.2 629.5 632.4 635.3 3960.4 4329.8 4373.9 4428.8 4476.1 67692.0 71260.6 82050.5 91612.0 92012.1 67812.7 68954.0 69206.0 69371.7 69718.6 51608.0 62582.0 63531.0 66235.3 73163.0 8844.4 8874.2 8899.5 8996.8 9058.8 47095.0 48195.3 48388.8 49296.8 50052.0 59162.5 61127.7 62041.4 62794.1 62972.7 10484.0 10861.8 10954.6 11145.4 11201.8 11601.7 11855.5 11933.6 12324.9 12485.8 10911.4 11105.0 11224.4 11278.7 11762.1 10759.2 11326.0 11413.5 11486.3 11854.4 10460.0 11086.2 11089.2 11321.0 11897.4 7174.4 9544.6 9677.9 9699.9 9944.9 8912.9 9856.3 9872.2 9904.5 9927.0 09:58:12 INFO - PROCESS | 2021 | -------- Summary: end -------- 09:58:12 INFO - PROCESS | 2021 | 09:58:13 INFO - TEST-INFO | 2021: exit 0 09:58:13 INFO - TEST-OK | dromaeo_css | took 1110493ms 09:58:13 INFO - TEST-START | kraken 09:58:13 INFO - operating with platform_type : mac_ 09:58:13 INFO - Initialising browser for kraken test... 09:58:13 INFO - TEST-INFO | started process 2027 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/tmpjoZSNP/profile http://localhost:49388/getInfo.html) 09:58:15 INFO - PROCESS | 2027 | __metrics Screen width/height:1600/1200 09:58:15 INFO - PROCESS | 2027 | colorDepth:24 09:58:15 INFO - PROCESS | 2027 | Browser inner width/height: 1024/689 09:58:15 INFO - PROCESS | 2027 | __metrics 09:58:15 ERROR - PROCESS | 2027 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 09:58:16 INFO - TEST-INFO | 2027: exit 0 09:58:16 INFO - Browser initialized. 09:58:16 INFO - Running cycle 1/1 for kraken test... 09:58:16 INFO - TEST-INFO | started process 2030 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/tmpjoZSNP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:58:28 INFO - PROCESS | 2030 | RSS: Main: 255619072 09:58:28 INFO - PROCESS | 2030 | 09:58:31 INFO - PROCESS | 2030 | Cycle 1(1): loaded http://localhost:49388/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49388/tests/kraken/driver.html?testName=audio-beat-detection) 09:58:32 INFO - PROCESS | 2030 | RSS: Main: 268611584 09:58:32 INFO - PROCESS | 2030 | 09:58:34 INFO - PROCESS | 2030 | Cycle 1(1): loaded http://localhost:49388/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49388/tests/kraken/driver.html?testName=audio-dft) 09:58:35 INFO - PROCESS | 2030 | RSS: Main: 277610496 09:58:35 INFO - PROCESS | 2030 | 09:58:39 INFO - PROCESS | 2030 | Cycle 1(1): loaded http://localhost:49388/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49388/tests/kraken/driver.html?testName=audio-fft) 09:58:39 INFO - PROCESS | 2030 | RSS: Main: 280772608 09:58:39 INFO - PROCESS | 2030 | 09:58:41 INFO - PROCESS | 2030 | Cycle 1(1): loaded http://localhost:49388/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49388/tests/kraken/driver.html?testName=audio-oscillator) 09:58:42 INFO - PROCESS | 2030 | RSS: Main: 281395200 09:58:42 INFO - PROCESS | 2030 | 09:58:44 INFO - PROCESS | 2030 | Cycle 1(1): loaded http://localhost:49388/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49388/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:58:44 INFO - PROCESS | 2030 | RSS: Main: 282963968 09:58:44 INFO - PROCESS | 2030 | 09:58:47 INFO - PROCESS | 2030 | Cycle 1(1): loaded http://localhost:49388/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49388/tests/kraken/driver.html?testName=imaging-darkroom) 09:58:48 INFO - PROCESS | 2030 | RSS: Main: 282902528 09:58:48 INFO - PROCESS | 2030 | 09:58:51 INFO - PROCESS | 2030 | Cycle 1(1): loaded http://localhost:49388/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49388/tests/kraken/driver.html?testName=imaging-desaturate) 09:58:51 INFO - PROCESS | 2030 | RSS: Main: 282890240 09:58:51 INFO - PROCESS | 2030 | 09:58:54 INFO - PROCESS | 2030 | Cycle 1(1): loaded http://localhost:49388/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49388/tests/kraken/driver.html?testName=json-parse-financial) 09:58:54 INFO - PROCESS | 2030 | RSS: Main: 283217920 09:58:54 INFO - PROCESS | 2030 | 09:58:56 INFO - PROCESS | 2030 | Cycle 1(1): loaded http://localhost:49388/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49388/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:58:57 INFO - PROCESS | 2030 | RSS: Main: 283709440 09:58:57 INFO - PROCESS | 2030 | 09:58:58 INFO - PROCESS | 2030 | Cycle 1(1): loaded http://localhost:49388/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49388/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:58:59 INFO - PROCESS | 2030 | RSS: Main: 283897856 09:58:59 INFO - PROCESS | 2030 | 09:59:01 INFO - PROCESS | 2030 | Cycle 1(1): loaded http://localhost:49388/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49388/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:59:02 INFO - PROCESS | 2030 | RSS: Main: 283746304 09:59:02 INFO - PROCESS | 2030 | 09:59:04 INFO - PROCESS | 2030 | Cycle 1(1): loaded http://localhost:49388/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49388/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:59:05 INFO - PROCESS | 2030 | RSS: Main: 283717632 09:59:05 INFO - PROCESS | 2030 | 09:59:08 INFO - PROCESS | 2030 | Cycle 1(1): loaded http://localhost:49388/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49388/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:59:08 INFO - PROCESS | 2030 | RSS: Main: 284016640 09:59:08 INFO - PROCESS | 2030 | 09:59:10 INFO - PROCESS | 2030 | Cycle 1(1): loaded http://localhost:49388/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49388/tests/kraken/driver.html?testName=ai-astar) 09:59:10 INFO - PROCESS | 2030 | RSS: Main: 284897280 09:59:10 INFO - PROCESS | 2030 | 09:59:10 INFO - PROCESS | 2030 | __start_tp_report 09:59:10 INFO - PROCESS | 2030 | _x_x_mozilla_page_load 09:59:10 INFO - PROCESS | 2030 | _x_x_mozilla_page_load_details 09:59:10 INFO - PROCESS | 2030 | |i|pagename|runs| 09:59:10 INFO - PROCESS | 2030 | |0;ai-astar;114;108;117;115;117;126;113;115;127;157 09:59:10 INFO - PROCESS | 2030 | |1;audio-beat-detection;159;151;180;188;169;170;137;113;172;112 09:59:10 INFO - PROCESS | 2030 | |2;audio-dft;211;259;264;248;189;194;273;240;250;277 09:59:10 INFO - PROCESS | 2030 | |3;audio-fft;76;70;75;132;56;56;60;58;98;82 09:59:10 INFO - PROCESS | 2030 | |4;audio-oscillator;82;89;121;83;86;81;118;79;83;115 09:59:10 INFO - PROCESS | 2030 | |5;imaging-gaussian-blur;86;92;86;91;86;91;85;92;86;92 09:59:10 INFO - PROCESS | 2030 | |6;imaging-darkroom;95;96;111;93;96;96;95;111;96;95 09:59:10 INFO - PROCESS | 2030 | |7;imaging-desaturate;92;94;92;91;99;90;91;92;95;91 09:59:10 INFO - PROCESS | 2030 | |8;json-parse-financial;58;60;76;87;87;62;57;63;56;57 09:59:10 INFO - PROCESS | 2030 | |9;json-stringify-tinderbox;65;75;70;72;69;68;67;65;66;68 09:59:10 INFO - PROCESS | 2030 | |10;stanford-crypto-aes;89;85;83;86;85;110;103;84;85;86 09:59:10 INFO - PROCESS | 2030 | |11;stanford-crypto-ccm;123;122;130;135;127;128;127;131;145;130 09:59:10 INFO - PROCESS | 2030 | |12;stanford-crypto-pbkdf2;146;142;143;144;141;142;144;147;141;142 09:59:10 INFO - PROCESS | 2030 | |13;stanford-crypto-sha256-iterative;67;70;67;68;70;68;67;68;69;73 09:59:10 INFO - PROCESS | 2030 | __end_tp_report 09:59:10 INFO - PROCESS | 2030 | __start_cc_report 09:59:10 INFO - PROCESS | 2030 | _x_x_mozilla_cycle_collect,889 09:59:10 INFO - PROCESS | 2030 | __end_cc_report 09:59:10 INFO - PROCESS | 2030 | __startTimestamp1456250350548__endTimestamp 09:59:10 INFO - PROCESS | 2030 | 09:59:10 INFO - PROCESS | 2030 | ------- Summary: start ------- 09:59:10 INFO - PROCESS | 2030 | Number of tests: 14 09:59:10 INFO - PROCESS | 2030 | 09:59:10 INFO - PROCESS | 2030 | [#0] ai-astar Cycles:10 Average:120.90 Median:117.00 stddev:13.92 (11.9%) stddev-sans-first:14.53 09:59:10 INFO - PROCESS | 2030 | Values: 114.0 108.0 117.0 115.0 117.0 126.0 113.0 115.0 127.0 157.0 09:59:10 INFO - PROCESS | 2030 | 09:59:10 INFO - PROCESS | 2030 | [#1] audio-beat-detection Cycles:10 Average:155.10 Median:169.50 stddev:26.65 (15.7%) stddev-sans-first:28.23 09:59:10 INFO - PROCESS | 2030 | Values: 159.0 151.0 180.0 188.0 169.0 170.0 137.0 113.0 172.0 112.0 09:59:10 INFO - PROCESS | 2030 | 09:59:10 INFO - PROCESS | 2030 | [#2] audio-dft Cycles:10 Average:240.50 Median:254.50 stddev:31.82 (12.5%) stddev-sans-first:31.91 09:59:10 INFO - PROCESS | 2030 | Values: 211.0 259.0 264.0 248.0 189.0 194.0 273.0 240.0 250.0 277.0 09:59:10 INFO - PROCESS | 2030 | 09:59:10 INFO - PROCESS | 2030 | [#3] audio-fft Cycles:10 Average:76.30 Median:72.50 stddev:23.74 (32.7%) stddev-sans-first:25.18 09:59:10 INFO - PROCESS | 2030 | Values: 76.0 70.0 75.0 132.0 56.0 56.0 60.0 58.0 98.0 82.0 09:59:10 INFO - PROCESS | 2030 | 09:59:10 INFO - PROCESS | 2030 | [#4] audio-oscillator Cycles:10 Average:93.70 Median:82.50 stddev:17.04 (20.7%) stddev-sans-first:17.54 09:59:10 INFO - PROCESS | 2030 | Values: 82.0 89.0 121.0 83.0 86.0 81.0 118.0 79.0 83.0 115.0 09:59:10 INFO - PROCESS | 2030 | 09:59:10 INFO - PROCESS | 2030 | [#5] imaging-gaussian-blur Cycles:10 Average:88.70 Median:91.00 stddev:3.09 (3.4%) stddev-sans-first:3.12 09:59:10 INFO - PROCESS | 2030 | Values: 86.0 92.0 86.0 91.0 86.0 91.0 85.0 92.0 86.0 92.0 09:59:10 INFO - PROCESS | 2030 | 09:59:10 INFO - PROCESS | 2030 | [#6] imaging-darkroom Cycles:10 Average:98.40 Median:95.50 stddev:6.70 (7.0%) stddev-sans-first:7.00 09:59:10 INFO - PROCESS | 2030 | Values: 95.0 96.0 111.0 93.0 96.0 96.0 95.0 111.0 96.0 95.0 09:59:10 INFO - PROCESS | 2030 | 09:59:10 INFO - PROCESS | 2030 | [#7] imaging-desaturate Cycles:10 Average:92.70 Median:92.00 stddev:2.67 (2.9%) stddev-sans-first:2.82 09:59:10 INFO - PROCESS | 2030 | Values: 92.0 94.0 92.0 91.0 99.0 90.0 91.0 92.0 95.0 91.0 09:59:10 INFO - PROCESS | 2030 | 09:59:10 INFO - PROCESS | 2030 | [#8] json-parse-financial Cycles:10 Average:66.30 Median:62.50 stddev:12.33 (19.7%) stddev-sans-first:12.71 09:59:10 INFO - PROCESS | 2030 | Values: 58.0 60.0 76.0 87.0 87.0 62.0 57.0 63.0 56.0 57.0 09:59:10 INFO - PROCESS | 2030 | 09:59:10 INFO - PROCESS | 2030 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:68.50 stddev:3.17 (4.6%) stddev-sans-first:3.10 09:59:10 INFO - PROCESS | 2030 | Values: 65.0 75.0 70.0 72.0 69.0 68.0 67.0 65.0 66.0 68.0 09:59:10 INFO - PROCESS | 2030 | 09:59:10 INFO - PROCESS | 2030 | [#10] stanford-crypto-aes Cycles:10 Average:89.60 Median:85.00 stddev:9.19 (10.8%) stddev-sans-first:9.75 09:59:10 INFO - PROCESS | 2030 | Values: 89.0 85.0 83.0 86.0 85.0 110.0 103.0 84.0 85.0 86.0 09:59:10 INFO - PROCESS | 2030 | 09:59:10 INFO - PROCESS | 2030 | [#11] stanford-crypto-ccm Cycles:10 Average:129.80 Median:130.00 stddev:6.55 (5.0%) stddev-sans-first:6.46 09:59:10 INFO - PROCESS | 2030 | Values: 123.0 122.0 130.0 135.0 127.0 128.0 127.0 131.0 145.0 130.0 09:59:10 INFO - PROCESS | 2030 | 09:59:10 INFO - PROCESS | 2030 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.20 Median:143.50 stddev:2.04 (1.4%) stddev-sans-first:1.90 09:59:10 INFO - PROCESS | 2030 | Values: 146.0 142.0 143.0 144.0 141.0 142.0 144.0 147.0 141.0 142.0 09:59:10 INFO - PROCESS | 2030 | 09:59:10 INFO - PROCESS | 2030 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:68.50 stddev:1.89 (2.8%) stddev-sans-first:1.90 09:59:10 INFO - PROCESS | 2030 | Values: 67.0 70.0 67.0 68.0 70.0 68.0 67.0 68.0 69.0 73.0 09:59:10 INFO - PROCESS | 2030 | -------- Summary: end -------- 09:59:10 INFO - PROCESS | 2030 | 09:59:11 INFO - TEST-INFO | 2030: exit 0 09:59:11 INFO - TEST-OK | kraken | took 58226ms 09:59:11 INFO - SUITE-END | took 1168s 09:59:11 INFO - Completed test suite (00:19:29) 09:59:11 INFO - Working with test: dromaeo_css 09:59:11 INFO - Generating results file: dromaeo_css 09:59:11 INFO - Working with test: kraken 09:59:11 INFO - Generating results file: kraken 09:59:11 INFO - javascript benchmark 09:59:11 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:59:11 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,61]] 09:59:11 INFO - process_Request line: dromaeo_css 7459.87 graph.html#tests=[[72,1,61]] 09:59:11 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:59:11 INFO - process_Request line: kraken 1532.40 graph.html#tests=[[232,1,61]] 09:59:11 INFO - RETURN: dromaeo_css: 7459.87 09:59:11 INFO - RETURN: kraken: 1532.40 09:59:11 INFO - javascript benchmark 09:59:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3497.370473314803, 3527.8765243216476, 3551.520544726461, 3592.3174596826593, 3599.712023038157, 5707.942920570793, 5746.856328591787, 5758.625689330196, 5771.076627739562, 5771.451712087355, 5664.0937450008005, 5782.797602083928, 5824.708764561766, 5869.559783016281, 5896.911546326808, 5154.5103215194495, 5205.817796377128, 5214.60890433219, 5227.869303267411, 5250.6324557281005, 5250.921236181442, 5251.407783923843, 5297.735113244342, 5304.257403963448, 5305.920411193835, 5141.203113517392, 5229.320188375486, 5241.528262456378, 5255.710935898524, 5255.973720131413, 5156.407013193493, 5184.403793563751, 5187.922181167285, 5212.452692467312, 5226.712530810842, 5114.181730923035, 5152.793888244466, 5155.123628983082, 5187.688738675692, 5193.538433975978, 4753.3107699383745, 5641.943580564224, 5674.319081710221, 5674.546036317126, 5751.942480575182, 6095.298564469898, 6180.887440260752, 6228.4394404503355, 6268.9969604863, 6279.6860156992425, 6080.452759251644, 6164.722587483529, 6206.379362063803, 6227.532935029845, 6273.341299163568, 5908.720660033679, 5933.199018132497, 5947.37552556984, 5962.910556341659, 5976.8505787355225, 6188.1027251048345, 6245.219347581552, 6286.245650521875, 6325.0, 6330.873382532323, 6195.4424101831055, 6198.81403557894, 6199.287081985539, 6235.0, 6250.843728906813, 6155.96922015396, 6259.061140828821, 6266.780662676784, 6279.874402511924, 6286.214223222098, 6140.166841500503, 6207.6585787782105, 6265.561410701207, 6266.49868010558, 6287.088372186007, 6240.500759939194, 6244.46922011625, 6268.561200715997, 6268.905966410507, 6283.59156654816, 4812.35033270511, 4880.097182021266, 4916.360873086476, 4944.579710724557, 4959.851204463872, 3619.9276014480088, 3933.331333673282, 4083.2854250506043, 4382.715123516961, 4437.201303765289, 5854.4730974212525, 5862.267216597926, 5881.32364778056, 5913.29040515141, 5946.791862284799, 6108.008189064103, 6156.230471191101, 6187.195664563578, 6196.752129914843, 6200.968995154995, 5831.0, 5875.9118613220835, 5885.940530704429, 5902.1441890926435, 5913.0, 5357.4106848246665, 5422.620416570881, 5431.266778984866, 5469.617126801086, 5490.670559766427, 6192.566520343533, 6372.394622510854, 6377.872442551123, 6390.712417941204, 6403.58376705522, 6180.81457556274, 6261.405166509175, 6276.529260305587, 6285.748570057147, 6291.496680265659, 6253.843653908689, 6272.968635156795, 6285.214348206474, 6372.458341041063, 6411.6794160290865, 6140.692965351804, 6160.784372546939, 6175.104609831639, 6175.6912154393, 6206.10011548332, 6197.876042479035, 6230.221222347207, 6232.844178895564, 6239.376062393724, 6243.8126856194385, 6142.815715528542, 6143.631382117087, 6149.385061493815, 6151.907721384272, 6173.166622505904, 4730.574248317668, 6115.449609535163, 6133.325334213144, 6211.503079753699, 6228.190335256388, 5841.094630332305, 5941.910871336847, 6067.575269731076, 6149.508039356751, 6200.534959878118, 6207.720652570735, 6225.782097626561, 6237.4698150657705, 6255.46828519581, 6258.4680302173, 6090.725917333642, 6128.0, 6133.723982420713, 6137.018077107641, 6142.723577439116], "unit": "score", "name": "dojo.html", "value": 5727.191940483611}, {"lowerIsBetter": false, "replicates": [413.5141209079331, 436.1821584529008, 504.39724529187635, 532.4382776171141, 601.6450294326347, 28234.717652823467, 31021.534676979805, 37322.81338593306, 37699.62300376996, 37797.0, 38845.80577097118, 39291.0, 39326.21347573054, 39341.21317573647, 39487.802560987155, 9296.302777291714, 9487.81024379512, 9521.095495927875, 9521.143097121258, 9528.0, 9479.573419196118, 9597.520123993807, 9598.184154346889, 9603.279754018442, 9611.855822162674, 9567.712968610953, 9577.664781732641, 9633.181179599742, 9658.855117173212, 9662.613495460173, 9548.331616786827, 9606.0, 9611.951940240324, 9634.084761947604, 9636.566354513994, 9449.480278584675, 9453.86553613564, 9559.665411710626, 9573.617055317849, 9588.376755510939, 37602.247955040744, 37653.0, 37979.62020379789, 38179.42730859039, 38279.04302392434, 3088.644805847334, 3163.0, 3181.602299712536, 3310.6192787829227, 3519.489673997256, 28590.0, 28791.56812647791, 29091.85454072716, 29308.706912931026, 29479.557806632918, 2811.8031737778365, 2861.556458748897, 2902.3179552805072, 2906.854657267128, 3006.6241719785025, 504050.99999999633, 504169.0, 506994.0, 508983.0, 509444.0, 44487.0, 45661.85845353893, 66364.0, 66856.33143668598, 66916.0, 37254.25491490155, 42989.0, 44384.66845994625, 44583.0, 44754.55245447504, 15011.699766004836, 15035.473758418402, 15323.693526129638, 15522.0, 15607.531774046796, 12381.00951923844, 12469.688257793447, 12544.310062946626, 12598.622041338775, 12624.873751262554, 14364.922630802732, 14446.711065778625, 14744.467202877468, 14748.63128421798, 14790.778138327934, 5443.537299329522, 5665.895150445706, 5790.681512516852, 6382.170317858741, 6411.455026322815, 920.558132096584, 980.8479685648736, 994.8855881573567, 1017.7506510904876, 1089.003561740998, 23225.419364516023, 27115.0, 27541.86229068882, 27735.0, 28482.8084872964, 1084.6908631040117, 1093.8413929980268, 1098.7308109513222, 1111.9610813621646, 1115.6206889657556, 14975.925120374546, 14987.775183372258, 15141.924290378478, 15411.383544658313, 15417.537473875802, 474579.0, 486744.0, 489309.0, 490145.0, 494336.0, 58850.705746470994, 59439.919602813694, 59597.0, 59960.40039599635, 60154.0, 1446.7540518111737, 1451.1945870042016, 1476.6603681153395, 1483.399223314581, 1489.0246888288189, 29790.0, 30154.643041062765, 30226.9420570279, 30322.54516182215, 30421.391572168875, 51802.74098629633, 51940.740296298274, 52387.47612523826, 52547.474525255784, 52699.0, 446801.0, 447948.0, 449393.0, 450513.0, 452160.7391963019, 34054.48918266178, 34411.4838277421, 45644.315335270665, 47682.52317476781, 47727.28409073797, 44441.0, 44464.93085835306, 44681.32978005268, 44694.55305446904, 45017.774911125234, 36537.63462365342, 36953.44569831401, 37592.62407375891, 37664.246715065, 37892.62107378891, 35985.640143598226, 36542.88989682521, 36629.450558241115, 36856.0, 36942.26115477621, 28728.856355718086, 32203.838980804947, 36399.0, 36868.63131368652, 37756.0, 24112.276631701076, 27643.44713105767, 29846.0, 33589.66410335866, 33682.3263534723, 24581.754182457946, 25071.623925640764, 25285.62071568965, 25396.873015634803, 25569.9365349061], "unit": "score", "name": "ext.html", "value": 18983.0036824344}, {"lowerIsBetter": false, "replicates": [358.4712548990238, 358.64852444604287, 360.18777656384856, 366.1870647163298, 368.79347565363383, 13804.516841910536, 18823.811761882378, 19303.90348048261, 19994.0, 20500.179992800287, 11737.0, 12148.93925530371, 12150.27098374096, 19828.801711982876, 19987.000649967515, 5250.501202385777, 5336.546393556552, 5423.2136340230645, 5429.4526060072885, 5444.727763611823, 5119.078565858144, 5405.945940540583, 5407.567394608422, 5437.374701909272, 5437.592180586452, 5372.7045012524295, 5420.512153906147, 5514.172874068881, 5714.971425142869, 5767.798127065554, 5602.887942241173, 5631.690257035862, 5689.317281926154, 5705.999999999979, 5942.910856337158, 5559.33288005442, 5575.8884822303735, 5629.352624448159, 5633.15502674598, 5661.971690141523, 12852.293123878182, 13074.215547067111, 17063.658726825393, 23320.88339558308, 23324.53350932989, 2393.222202784085, 2395.221552995266, 2460.5447992121517, 2629.382095207625, 2803.0609745735205, 9544.42733435996, 9552.952235238849, 9852.0, 10042.447665378475, 10130.645427410005, 1784.7501349811037, 1812.673718730628, 1835.07328798957, 1851.6111616560538, 1898.6392585408728, 61241.38758612446, 102947.45578816324, 106511.46744266307, 108409.45795270974, 109743.45128274387, 10020.899791001997, 10081.840588332288, 10192.337498062601, 11533.21235208544, 11538.711532211593, 12267.69330766738, 13105.410256538478, 13535.796963045563, 13653.726925461435, 13669.359676838843, 7459.70161193557, 8084.908537347383, 8303.792405189919, 8394.370422218359, 8554.14458554152, 7382.22486638906, 8762.693305734269, 8814.250788682906, 8830.337724670675, 8871.112888711077, 4448.911021779546, 4462.910741785211, 4548.385967894358, 4552.840650577214, 4596.770161491912, 1885.1893685715, 1914.9904250478658, 1949.2397964793743, 1977.8417726582127, 1985.811347921945, 862.784303924019, 953.7648744875403, 985.4432245781111, 987.4272921705393, 1008.2589296866797, 18527.166277517543, 20880.895595521924, 21638.567228655655, 22399.77600223977, 23004.309870703906, 937.9437233765996, 958.4009993753904, 972.6984634763246, 979.0747743382435, 984.5864736810556, 9029.961554421194, 10396.792064158826, 11021.724456888642, 11148.55251531367, 11602.245854019462, 512247.0, 522966.0, 523278.0, 599033.0, 654290.0, 109937.0, 122758.38620806839, 124698.37650811688, 124961.0, 128100.35949820191, 1055.8574592429923, 1059.3855563773147, 1069.3690722473777, 1112.065864673678, 1114.7380365614074, 18450.169742361893, 18613.627727445648, 18711.812881871007, 18748.968806715762, 18832.6233475327, 38058.809705951295, 50912.490875092255, 53293.733531332095, 54352.72823635856, 55357.0, 71947.64026179835, 74044.62977685076, 74092.25907740854, 75036.0, 75144.24855751373, 7925.564093974886, 8040.517568945882, 8140.75577732669, 8168.142345053684, 8205.097439281793, 10143.289969702346, 12845.678858028625, 13200.339983001004, 13259.270740109387, 13461.259630720404, 11652.242604230698, 11702.648920532398, 11808.645740627795, 11910.344931028876, 11910.583129590423, 8179.61756212023, 8194.044857691972, 11488.368139752394, 11973.341466219441, 12003.0, 8256.463329883538, 8267.462614930011, 8547.316214702932, 8648.1784230498, 8724.56377181151, 11781.906002225298, 12136.696582585506, 12206.694832629255, 12268.754624907631, 12301.75396492083, 12125.029997599995, 12152.57465988686, 12199.0, 12207.69480762988, 12225.08311876595], "unit": "score", "name": "jquery.html", "value": 9256.664290377037}, {"lowerIsBetter": false, "replicates": [1564.327339244125, 1585.0410501646504, 1851.972220416693, 1930.8841469511822, 1948.8635795494322, 7812.101608315045, 8401.579921003957, 8531.146885311466, 8691.56542172892, 8725.43284686495, 8421.578921053953, 8494.023187333443, 8555.272801811854, 8561.272291855199, 8573.356998225143, 2034.4201902457803, 2411.5176964607062, 2426.3206302235403, 2435.4398488347692, 2455.067074511683, 2426.2842461473906, 2428.7935525480266, 2449.4121410861444, 2454.914078007261, 2456.7666071723247, 2384.8807559622037, 2431.465077682907, 2431.4772323950347, 2451.1493822164243, 2474.925752227436, 2420.7942324902315, 2441.145599040339, 2444.7799698027175, 2446.902123915041, 2453.4725034117573, 2474.9752502474926, 2492.850428974249, 2499.125306142854, 2503.0113105323476, 2509.2221411362534, 8529.402941794076, 8687.739367818975, 8729.60716767747, 8739.694110706158, 8739.868901966476, 5305.8938821223355, 5425.294711687456, 5445.564354851603, 5472.330939063584, 5480.808171713971, 3003.2041509000132, 3540.9468857966895, 3558.839852206631, 3612.4039533477207, 3633.709303255733, 998.4059484606647, 1071.132382769959, 1075.0754351257913, 1092.5520536579963, 1100.1748688483638, 11522.481488332962, 11586.18896677233, 11630.360330181837, 11692.766144677058, 11708.004819590346, 3937.153511994935, 4632.235681112578, 4661.184292748823, 4662.254039353687, 4689.929651055237, 9139.588718507683, 9203.539823008823, 9217.354785165107, 9237.769055773659, 9258.259339252978, 4729.6452766042685, 5257.211418287287, 5283.894322113536, 5311.150215965427, 5366.382865970385, 4410.0, 4788.162071637519, 4843.515648435199, 4897.730624815598, 4955.4796746341835, 3725.832337544817, 3754.4931434256027, 3775.7923314217433, 3783.886483405502, 3805.353089974711, 1177.7467844413493, 1190.089581470176, 1198.0415667465993, 1198.9520419183134, 1200.9939950300193, 1049.4333060147587, 1062.654637242899, 1062.829947208443, 1234.5247079874314, 1396.63687441266, 8008.439409241297, 8062.959685201654, 8131.878021829677, 8133.268005879381, 8162.959185204036, 514.9639525233198, 518.3313525551996, 523.9554637855749, 526.4866754914004, 527.3197575128041, 5990.161377407167, 6036.879262414815, 6098.817035488943, 6112.327643959161, 6132.478739307119, 8036.6785328587375, 8441.746747597583, 10078.798424031478, 10228.948855255676, 10366.0, 9949.353292035994, 10096.242781791396, 10149.0, 10156.949215253877, 10221.43782091992, 8052.516848989197, 8054.5569993650915, 8060.8387832243025, 8077.474964127313, 8126.674933002732, 7776.766696999099, 7842.568658723825, 7913.089994650459, 7967.04395472547, 8131.308838748772, 9225.953870230605, 9250.0, 9464.19554337889, 9574.377665451724, 9691.0, 9506.667266645634, 9659.32384733062, 9689.70930872075, 9848.753781155528, 9984.35101718386, 5787.36339002701, 6754.18949726036, 7166.319199676022, 7486.775396738107, 7578.052743407075, 8005.719799806979, 8064.3548516119745, 8082.949216602039, 8118.715844945398, 8123.593820308843, 7096.680649370894, 7267.745628902963, 7274.636268186464, 7325.0, 7379.963100184465, 7071.858562828817, 7081.221065682874, 7110.075690160453, 7188.640567971685, 7230.385417239383, 7617.5048621839405, 7699.268569486114, 7709.2290770922455, 7713.344365728976, 7719.536827790351, 5984.311804142405, 6875.724971001104, 6887.483438742014, 6921.515493915377, 6967.756128535477, 5873.060310350324, 6123.357047509948, 6385.201849768779, 6984.371406573433, 7100.183478899786], "unit": "score", "name": "mootools.html", "value": 4709.457260707959}, {"lowerIsBetter": false, "replicates": [260.61429084954267, 323.702193981537, 328.3400365265815, 336.8686212377173, 339.9762016658835, 6855.931440685604, 6868.210155832081, 7022.157341119073, 7153.0, 7160.964195179024, 7013.824654383643, 7032.296770322965, 7062.435005199584, 7076.292370762922, 7078.610676412795, 5062.797488100471, 5068.72122033288, 5073.340465739467, 5081.060003899272, 5085.669431486951, 4395.197968832779, 5055.0, 5062.443131255559, 5077.416097148838, 5092.236164575306, 4969.726665033421, 5001.424836143836, 5006.849794506171, 5008.0, 5015.3730783652045, 4805.3272541844, 4972.627052971042, 4998.675086119409, 5012.047710934929, 5012.070352914118, 4109.0, 4189.455370801807, 4204.07510347723, 4215.3887686285625, 4242.193983143224, 6646.368594983469, 6671.132752742113, 6686.197656281277, 6688.799336019879, 6695.230048544431, 5745.971270143623, 5863.677497737623, 5875.6474611523445, 5887.499562537189, 5892.764289428418, 7186.281371862824, 7301.0, 7324.0, 7327.267273272683, 7365.991126034294, 4008.398740188966, 4670.206064968964, 4671.556202160789, 4673.859784206479, 4688.953110468886, 7798.337141342992, 7899.763007109738, 7907.130215676271, 7918.4061195409995, 7919.96040019802, 4348.695591308641, 4554.476235232924, 4753.453352864396, 4762.214234651244, 4765.642576806753, 3766.9452553285123, 4756.310335001405, 4811.855644330676, 4870.025994800983, 4873.878153046202, 5892.263467066617, 5896.3219229788265, 5901.616394934315, 5909.763609455574, 5914.935311643945, 7459.738909138154, 7477.140128885139, 7501.5372002459, 7510.737124200627, 7539.962300188464, 1675.7151284281701, 1693.314207745865, 1695.5676302542772, 1696.211261763286, 1697.5077227604104, 1004.4073996342194, 1035.3529044347283, 1056.2025670618634, 1075.4783929794044, 1092.2900114925362, 6825.35159159879, 6827.180738311435, 6841.657917104125, 6920.238773734885, 6949.027136200936, 7714.5756983366455, 7741.690332386754, 7744.380449564022, 7751.069871615329, 7759.922400776033, 6858.5199036068, 6876.934075218349, 6876.965615171892, 6893.586384816927, 6906.447484201352, 3859.208862183246, 4065.8780236592947, 4078.877633670995, 4081.8163182656854, 4099.528554216244, 7873.0, 7939.2060793920145, 7969.481983671043, 7977.5612341321785, 8009.519428834288, 6400.359964003563, 7093.219745827955, 7404.0, 7903.604819758989, 7938.722144724907, 5452.890942181213, 7323.743668971667, 7957.482763620346, 7978.920210797934, 7980.3615710743, 7325.41396688253, 7661.042369703787, 7678.848172774128, 7689.077310722749, 7713.42149338813, 6073.392660733891, 7426.443016773872, 7484.288992545699, 7492.0, 7532.472726909064, 6407.455366293917, 7951.681932722858, 7962.800929976797, 7963.6814527418255, 7974.880376794236, 3796.46849441084, 3965.821538030738, 4802.807887684454, 4804.95195048045, 4826.975865120652, 6225.31521532622, 6519.445847102859, 7590.278923502258, 7620.428467865043, 7911.406644501801, 7561.130469996021, 7603.0876294844975, 7603.619819009138, 7608.087029556267, 7621.675389006185, 7594.544327340377, 7595.202503737028, 7612.0, 7621.275978782007, 7626.923730762622, 6409.359064093554, 7025.473089518205, 7389.778306650809, 7411.184769675224, 7442.776716698508, 7158.105236845395, 7266.273372662691, 7548.0, 7564.130125035691, 7570.356519695888, 5952.916479232234, 7249.311315425026, 7253.0, 7288.708451662086, 7399.519031262951], "unit": "score", "name": "prototype.html", "value": 5312.722852027585}, {"lowerIsBetter": false, "replicates": [646.7574659502686, 683.3030309084737, 694.9999999999999, 737.4616529933148, 737.5058710663855, 14504.709905801878, 14828.77756833647, 14832.406703731838, 14876.628084297885, 16816.22532282172, 15824.604384890383, 15905.602359940978, 15945.681086378294, 15966.600834979132, 16002.59993500163, 730.631031329178, 878.3236907581158, 887.2635712358726, 896.0949441064539, 913.899471058183, 868.9131086891292, 885.8139790643972, 893.3166127912152, 896.7489103051156, 903.0788595632451, 889.3596610440472, 912.8128733609594, 954.1126752120525, 959.7264779537833, 959.7936443664611, 919.9862002069974, 937.6530683647026, 947.3984020147187, 948.7296120605663, 950.6625148072438, 684.4832151725465, 687.285223367697, 695.2074634916199, 707.3174386716792, 711.1679335177854, 15060.0, 15257.38970441181, 15297.923510382489, 15305.928584999054, 15389.846101539066, 11047.392393418359, 12438.81341779865, 12525.686857828536, 12768.170068945488, 12807.975361971019, 9732.41605503672, 10069.0, 10241.795164096677, 10259.333143345659, 10293.0, 3436.0722604896787, 3480.269143479872, 3510.052285882823, 3555.8044307563073, 3674.393725035393, 80851.0, 82329.58835205846, 82654.58672706598, 83167.75248371279, 84183.57908210481, 7932.762017139495, 9113.453192808453, 9284.396514226553, 9572.186364158984, 9864.309498335191, 17040.914795425942, 20259.59480810405, 20431.38705838827, 20457.2839950601, 20459.0, 7383.9261607384315, 7395.963020184865, 7435.1449583297535, 7542.094948606203, 7593.6582853771715, 3883.572806991229, 3950.1164150170534, 4006.979965100156, 4080.367543030776, 4115.0, 3480.5127282180515, 3500.177458297298, 3505.4391297392294, 3513.4202856528896, 3522.964770352315, 637.8596708724074, 648.1541588227315, 648.3192647719969, 668.6322522612544, 669.4242951062083, 513.6892180230981, 580.7647902599454, 625.0655270370825, 629.6096420219402, 635.920509936258, 7805.687772489036, 8238.876416853753, 8387.370947178986, 8450.408471407065, 8755.343349248831, 606.0575804623764, 619.1734035063241, 629.5404354821006, 632.4339715954195, 635.2567496029657, 3960.4455376247347, 4329.826806927751, 4373.934390984138, 4428.778561071934, 4476.127155204769, 67692.0, 71260.64369678119, 82050.53848384558, 91612.0, 92012.07987920169, 67812.66093669599, 68954.0, 69206.0, 69371.65314173397, 69718.60562788715, 51608.0, 62582.0, 63531.0, 66235.34411639652, 73163.0, 8844.380893337404, 8874.245689116497, 8899.510526921082, 8996.769526527414, 9058.773530661523, 47095.0, 48195.277070843265, 48388.7580562109, 49296.75351623219, 50052.0, 59162.5209369752, 61127.69436152791, 62041.37958620537, 62794.05808912961, 62972.685136575856, 10484.0, 10861.837072444077, 10954.616588419367, 11145.442727863736, 11201.831972520256, 11601.651950441501, 11855.495251017557, 11933.641990740292, 12324.876751232372, 12485.750284994068, 10911.399873007062, 11105.0, 11224.382658953837, 11278.718032049264, 11762.059035277329, 10759.246852720235, 11326.037286830711, 11413.543458261576, 11486.253393529394, 11854.350630022545, 10460.0, 11086.22396432242, 11089.22375433712, 11320.981111699986, 11897.405129743305, 7174.354308112295, 9544.618215271312, 9677.854832177381, 9699.88451328078, 9944.906060333213, 8912.86630700553, 9856.31005829585, 9872.210223182272, 9904.455254961047, 9927.0], "unit": "score", "name": "yui.html", "value": 6843.938772597622}], "name": "dromaeo_css", "value": 7459.8742864669575}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 108.0, 117.0, 115.0, 117.0, 126.0, 113.0, 115.0, 127.0, 157.0], "unit": "score", "name": "ai-astar", "value": 120.9}, {"lowerIsBetter": true, "replicates": [159.0, 151.0, 180.0, 188.0, 169.0, 170.0, 137.0, 113.0, 172.0, 112.0], "unit": "score", "name": "audio-beat-detection", "value": 155.1}, {"lowerIsBetter": true, "replicates": [211.0, 259.0, 264.0, 248.0, 189.0, 194.0, 273.0, 240.0, 250.0, 277.0], "unit": "score", "name": "audio-dft", "value": 240.5}, {"lowerIsBetter": true, "replicates": [76.0, 70.0, 75.0, 132.0, 56.0, 56.0, 60.0, 58.0, 98.0, 82.0], "unit": "score", "name": "audio-fft", "value": 76.3}, {"lowerIsBetter": true, "replicates": [82.0, 89.0, 121.0, 83.0, 86.0, 81.0, 118.0, 79.0, 83.0, 115.0], "unit": "score", "name": "audio-oscillator", "value": 93.7}, {"lowerIsBetter": true, "replicates": [86.0, 92.0, 86.0, 91.0, 86.0, 91.0, 85.0, 92.0, 86.0, 92.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 88.7}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 111.0, 93.0, 96.0, 96.0, 95.0, 111.0, 96.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 98.4}, {"lowerIsBetter": true, "replicates": [92.0, 94.0, 92.0, 91.0, 99.0, 90.0, 91.0, 92.0, 95.0, 91.0], "unit": "score", "name": "imaging-desaturate", "value": 92.7}, {"lowerIsBetter": true, "replicates": [58.0, 60.0, 76.0, 87.0, 87.0, 62.0, 57.0, 63.0, 56.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 66.3}, {"lowerIsBetter": true, "replicates": [65.0, 75.0, 70.0, 72.0, 69.0, 68.0, 67.0, 65.0, 66.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [89.0, 85.0, 83.0, 86.0, 85.0, 110.0, 103.0, 84.0, 85.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 89.6}, {"lowerIsBetter": true, "replicates": [123.0, 122.0, 130.0, 135.0, 127.0, 128.0, 127.0, 131.0, 145.0, 130.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 129.8}, {"lowerIsBetter": true, "replicates": [146.0, 142.0, 143.0, 144.0, 141.0, 142.0, 144.0, 147.0, 141.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.2}, {"lowerIsBetter": true, "replicates": [67.0, 70.0, 67.0, 68.0, 70.0, 68.0, 67.0, 68.0, 69.0, 73.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken", "value": 1532.4}]} 09:59:11 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,61]]", "result": "1532.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,61]]", "result": "7459.87"}}} 09:59:11 INFO - Return code: 0 09:59:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:59:11 ERROR - # TBPL SUCCESS # 09:59:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:59:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:59:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:59:11 INFO - 2016-02-23 09:59:11.927 screenresolution[2035:12934] starting screenresolution argv=screenresolution get 09:59:11 INFO - 2016-02-23 09:59:11.929 screenresolution[2035:12934] Display 0: 1600x1200x32@60 09:59:11 INFO - 2016-02-23 09:59:11.935 screenresolution[2036:12936] starting screenresolution argv=screenresolution list 09:59:11 INFO - Available Modes on Display 0 09:59:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:59:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:59:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:59:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:59:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:59:12 INFO - Intel Iris: 09:59:12 INFO - Chipset Model: Intel Iris 09:59:12 INFO - Type: GPU 09:59:12 INFO - Bus: Built-In 09:59:12 INFO - VRAM (Dynamic, Max): 1536 MB 09:59:12 INFO - Vendor: Intel (0x8086) 09:59:12 INFO - Device ID: 0x0a2e 09:59:12 INFO - Revision ID: 0x0009 09:59:12 INFO - Displays: 09:59:12 INFO - Display: 09:59:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:59:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:59:12 INFO - Display Serial Number: 1600x1200 60 09:59:12 INFO - Main Display: Yes 09:59:12 INFO - Mirror: Off 09:59:12 INFO - Online: Yes 09:59:12 INFO - Rotation: Supported 09:59:12 INFO - Return code: 0 09:59:12 INFO - Running post-action listener: _resource_record_post_action 09:59:12 INFO - Running post-run listener: _resource_record_post_run 09:59:13 INFO - Total resource usage - Wall time: 1205s; CPU: 54.0%; Read bytes: 2428928; Write bytes: 709990912; Read time: 43; Write time: 2328 09:59:13 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 384571904; Write bytes: 379435008; Read time: 28474; Write time: 729 09:59:13 INFO - run-tests - Wall time: 1172s; CPU: 54.0%; Read bytes: 2428928; Write bytes: 303055360; Read time: 43; Write time: 1543 09:59:13 INFO - Running post-run listener: _upload_blobber_files 09:59:13 INFO - Blob upload gear active. 09:59:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:59:13 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 09:59:13 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'] 09:59:13 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 09:59:13 INFO - (blobuploader) - INFO - Open directory for files ... 09:59:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:59:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:59:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:59:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:59:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:59:14 INFO - (blobuploader) - INFO - Done attempting. 09:59:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:59:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:59:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:59:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:59:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:59:15 INFO - (blobuploader) - INFO - Done attempting. 09:59:15 INFO - (blobuploader) - INFO - Iteration through files over. 09:59:15 INFO - Return code: 0 09:59:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:59:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:59:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef89394c3d7f7d6a56ec818787f4637c1c6709ad0ac60a844ca88f4d5608f54cd01840416caeceb74f52bab3d3a5e9a3bf231ec904b79b1b025c5bd5306693fc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dce138f4941dde0f5997ed6cecf453695726da40aea14f18f5102ad0142d4d58f2361930ad57c82890919cc6a49c3cc7fcbc98d08b71bd7a59fb53c45c969194"} 09:59:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:59:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:59:15 INFO - Contents: 09:59:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef89394c3d7f7d6a56ec818787f4637c1c6709ad0ac60a844ca88f4d5608f54cd01840416caeceb74f52bab3d3a5e9a3bf231ec904b79b1b025c5bd5306693fc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dce138f4941dde0f5997ed6cecf453695726da40aea14f18f5102ad0142d4d58f2361930ad57c82890919cc6a49c3cc7fcbc98d08b71bd7a59fb53c45c969194"} 09:59:15 INFO - Running post-run listener: copy_logs_to_upload_dir 09:59:15 INFO - Copying logs to upload dir... 09:59:15 INFO - mkdir: /builds/slave/test/build/upload/logs 09:59:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.650735 ========= master_lag: 1.16 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-02-23 09:59:16.965851) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 10 secs) (at 2016-02-23 09:59:16.969414) ========= 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.UQ0v11LWcG/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.9DuLDunDEt/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef89394c3d7f7d6a56ec818787f4637c1c6709ad0ac60a844ca88f4d5608f54cd01840416caeceb74f52bab3d3a5e9a3bf231ec904b79b1b025c5bd5306693fc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dce138f4941dde0f5997ed6cecf453695726da40aea14f18f5102ad0142d4d58f2361930ad57c82890919cc6a49c3cc7fcbc98d08b71bd7a59fb53c45c969194"} build_url:https://queue.taskcluster.net/v1/task/TQm41WjRQGKOSgizpUpJKw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011174 build_url: 'https://queue.taskcluster.net/v1/task/TQm41WjRQGKOSgizpUpJKw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef89394c3d7f7d6a56ec818787f4637c1c6709ad0ac60a844ca88f4d5608f54cd01840416caeceb74f52bab3d3a5e9a3bf231ec904b79b1b025c5bd5306693fc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dce138f4941dde0f5997ed6cecf453695726da40aea14f18f5102ad0142d4d58f2361930ad57c82890919cc6a49c3cc7fcbc98d08b71bd7a59fb53c45c969194"}' ========= master_lag: 10.37 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 10 secs) (at 2016-02-23 09:59:27.350907) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 6 secs) (at 2016-02-23 09:59:27.351293) ========= 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.UQ0v11LWcG/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.9DuLDunDEt/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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.004064 ========= master_lag: 6.92 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 6 secs) (at 2016-02-23 09:59:34.272260) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-23 09:59:34.272604) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-23 09:59:34.586680) ========= ========= Total master_lag: 19.54 =========