builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0112 starttime: 1456492502.39 results: success (0) buildid: 20160226030256 builduid: c48eb906f79442d68dbbeac865f22f0c revision: 918df3a0bc1c4d07299e4f66274a7da923534577 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-26 05:15:02.393464) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-26 05:15:02.393966) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-26 05:15:02.394292) ========= 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.h3TF1Svj5T/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.qQrrZ6b05L/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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.005830 basedir: '/builds/slave/test' ========= master_lag: 0.13 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-26 05:15:02.526037) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-26 05:15:02.526385) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-26 05:15:02.859089) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 05:15:02.859376) ========= 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.h3TF1Svj5T/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.qQrrZ6b05L/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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.005233 ========= master_lag: 0.14 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 05:15:03.002929) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-26 05:15:03.003232) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-26 05:15:03.003827) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 05:15:03.004187) ========= 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.h3TF1Svj5T/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.qQrrZ6b05L/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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-26 05:15:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.43M=0.001s 2016-02-26 05:15:03 (8.43 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.631460 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 05:15:03.663491) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 05:15:03.663893) ========= 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.h3TF1Svj5T/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.qQrrZ6b05L/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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.019990 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 05:15:03.714018) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-26 05:15:03.714386) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 918df3a0bc1c4d07299e4f66274a7da923534577 --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 918df3a0bc1c4d07299e4f66274a7da923534577 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.h3TF1Svj5T/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.qQrrZ6b05L/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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-26 05:15:03,791 truncating revision to first 12 chars 2016-02-26 05:15:03,791 Setting DEBUG logging. 2016-02-26 05:15:03,791 attempt 1/10 2016-02-26 05:15:03,792 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/918df3a0bc1c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-26 05:15:05,008 unpacking tar archive at: mozilla-central-918df3a0bc1c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.471447 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-26 05:15:05.202971) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-26 05:15:05.203415) ========= echo 918df3a0bc1c4d07299e4f66274a7da923534577 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'918df3a0bc1c4d07299e4f66274a7da923534577'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.h3TF1Svj5T/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.qQrrZ6b05L/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 918df3a0bc1c4d07299e4f66274a7da923534577 program finished with exit code 0 elapsedTime=0.005327 script_repo_revision: '918df3a0bc1c4d07299e4f66274a7da923534577' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-26 05:15:05.258964) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-26 05:15:05.259294) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-26 05:15:05.290085) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-02-26 05:15:05.290432) ========= /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.h3TF1Svj5T/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.qQrrZ6b05L/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:15:05 INFO - MultiFileLogger online at 20160226 05:15:05 in /builds/slave/test 05:15:05 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 05:15:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:15:05 INFO - {'append_to_log': False, 05:15:05 INFO - 'base_work_dir': '/builds/slave/test', 05:15:05 INFO - 'blob_upload_branch': 'Firefox', 05:15:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:15:05 INFO - 'branch': 'Firefox', 05:15:05 INFO - 'buildbot_json_path': 'buildprops.json', 05:15:05 INFO - 'config_files': ('talos/mac_config.py',), 05:15:05 INFO - 'default_actions': ('clobber', 05:15:05 INFO - 'read-buildbot-config', 05:15:05 INFO - 'download-and-extract', 05:15:05 INFO - 'populate-webroot', 05:15:05 INFO - 'create-virtualenv', 05:15:05 INFO - 'install', 05:15:05 INFO - 'run-tests'), 05:15:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:15:05 INFO - 'download_minidump_stackwalk': True, 05:15:05 INFO - 'download_symbols': 'ondemand', 05:15:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:15:05 INFO - 'tooltool.py': '/tools/tooltool.py', 05:15:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:15:05 INFO - '/tools/misc-python/virtualenv.py')}, 05:15:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:15:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:15:05 INFO - 'installer_path': 'installer.exe', 05:15:05 INFO - 'log_level': 'info', 05:15:05 INFO - 'log_name': 'talos', 05:15:05 INFO - 'log_to_console': True, 05:15:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:15:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:15:05 INFO - 'opt_config_files': (), 05:15:05 INFO - 'pip_index': False, 05:15:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:15:05 INFO - 'cmd': ('bash', 05:15:05 INFO - '-c', 05:15:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:15:05 INFO - 'enabled': True, 05:15:05 INFO - 'halt_on_failure': False, 05:15:05 INFO - 'name': 'check_screen_resolution'},), 05:15:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:15:05 INFO - 'cmd': ('bash', 05:15:05 INFO - '-c', 05:15:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:15:05 INFO - 'enabled': True, 05:15:05 INFO - 'halt_on_failure': False, 05:15:05 INFO - 'name': 'check_screen_resolution'},), 05:15:05 INFO - 'run_cmd_checks_enabled': True, 05:15:05 INFO - 'sps_profile': False, 05:15:05 INFO - 'sps_profile_interval': 0, 05:15:05 INFO - 'suite': 'dromaeojs-e10s', 05:15:05 INFO - 'system_bits': '32', 05:15:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:15:05 INFO - 'title': 't-yosemite-r7-0112', 05:15:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:15:05 INFO - 'use_talos_json': True, 05:15:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:15:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:15:05 INFO - 'work_dir': 'build'} 05:15:05 INFO - ##### 05:15:05 INFO - ##### Running clobber step. 05:15:05 INFO - ##### 05:15:05 INFO - Running pre-action listener: _resource_record_pre_action 05:15:05 INFO - Running main action method: clobber 05:15:05 INFO - rmtree: /builds/slave/test/build 05:15:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:15:07 INFO - Running post-action listener: _resource_record_post_action 05:15:07 INFO - ##### 05:15:07 INFO - ##### Running read-buildbot-config step. 05:15:07 INFO - ##### 05:15:07 INFO - Running pre-action listener: _resource_record_pre_action 05:15:07 INFO - Running main action method: read_buildbot_config 05:15:07 INFO - Using buildbot properties: 05:15:07 INFO - { 05:15:07 INFO - "project": "", 05:15:07 INFO - "product": "firefox", 05:15:07 INFO - "script_repo_revision": "production", 05:15:07 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:15:07 INFO - "repository": "", 05:15:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:15:07 INFO - "buildid": "20160226030256", 05:15:07 INFO - "stage_platform": "macosx64", 05:15:07 INFO - "basedir": "/builds/slave/test", 05:15:07 INFO - "nightly_build": "True", 05:15:07 INFO - "buildnumber": 124, 05:15:07 INFO - "slavename": "t-yosemite-r7-0112", 05:15:07 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:15:07 INFO - "platform": "yosemite_r7", 05:15:07 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:15:07 INFO - "branch": "mozilla-central", 05:15:07 INFO - "repo_path": "mozilla-central", 05:15:07 INFO - "revision": "918df3a0bc1c4d07299e4f66274a7da923534577", 05:15:07 INFO - "pgo_build": "False", 05:15:07 INFO - "builduid": "c48eb906f79442d68dbbeac865f22f0c", 05:15:07 INFO - "slavebuilddir": "test" 05:15:07 INFO - } 05:15:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/ahvy7-_gSIeAa1Ym5ohl7w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 05:15:07 INFO - Running post-action listener: _resource_record_post_action 05:15:07 INFO - ##### 05:15:07 INFO - ##### Running download-and-extract step. 05:15:07 INFO - ##### 05:15:07 INFO - Running pre-action listener: _resource_record_pre_action 05:15:07 INFO - Running main action method: download_and_extract 05:15:07 INFO - mkdir: /builds/slave/test/build/tests 05:15:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:07 INFO - https://queue.taskcluster.net/v1/task/ahvy7-_gSIeAa1Ym5ohl7w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:15:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ahvy7-_gSIeAa1Ym5ohl7w/artifacts/public/build/test_packages.json 05:15:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ahvy7-_gSIeAa1Ym5ohl7w/artifacts/public/build/test_packages.json 05:15:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ahvy7-_gSIeAa1Ym5ohl7w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:15:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ahvy7-_gSIeAa1Ym5ohl7w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:15:10 INFO - Downloaded 1277 bytes. 05:15:10 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:15:10 INFO - Using the following test package requirements: 05:15:10 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 05:15:10 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:15:10 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 05:15:10 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:15:10 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 05:15:10 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:15:10 INFO - u'jsshell-mac.zip'], 05:15:10 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:15:10 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 05:15:10 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 05:15:10 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:15:10 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 05:15:10 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:15:10 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 05:15:10 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:15:10 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 05:15:10 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 05:15:10 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:15:10 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 05:15:10 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:15:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:10 INFO - https://queue.taskcluster.net/v1/task/ahvy7-_gSIeAa1Ym5ohl7w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:15:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ahvy7-_gSIeAa1Ym5ohl7w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:15:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ahvy7-_gSIeAa1Ym5ohl7w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:15:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ahvy7-_gSIeAa1Ym5ohl7w/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 05:15:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ahvy7-_gSIeAa1Ym5ohl7w/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 05:15:11 INFO - Downloaded 17830361 bytes. 05:15:11 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'] 05:15:11 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 05:15:14 INFO - Return code: 0 05:15:14 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 05:15:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:14 INFO - https://queue.taskcluster.net/v1/task/ahvy7-_gSIeAa1Ym5ohl7w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:15:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ahvy7-_gSIeAa1Ym5ohl7w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:15:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ahvy7-_gSIeAa1Ym5ohl7w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:15:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ahvy7-_gSIeAa1Ym5ohl7w/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 05:15:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ahvy7-_gSIeAa1Ym5ohl7w/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 05:15:19 INFO - Downloaded 17830361 bytes. 05:15:19 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'] 05:15:19 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 05:15:23 INFO - Return code: 0 05:15:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:23 INFO - https://queue.taskcluster.net/v1/task/ahvy7-_gSIeAa1Ym5ohl7w/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:15:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ahvy7-_gSIeAa1Ym5ohl7w/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 05:15:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ahvy7-_gSIeAa1Ym5ohl7w/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 05:15:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ahvy7-_gSIeAa1Ym5ohl7w/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 05:15:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ahvy7-_gSIeAa1Ym5ohl7w/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 05:15:25 INFO - Downloaded 10707015 bytes. 05:15:25 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'] 05:15:25 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 05:15:25 INFO - Return code: 0 05:15:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:25 INFO - https://queue.taskcluster.net/v1/task/ahvy7-_gSIeAa1Ym5ohl7w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:15:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ahvy7-_gSIeAa1Ym5ohl7w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:15:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ahvy7-_gSIeAa1Ym5ohl7w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:15:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ahvy7-_gSIeAa1Ym5ohl7w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 05:15:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ahvy7-_gSIeAa1Ym5ohl7w/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 05:15:33 INFO - Downloaded 111592524 bytes. 05:15:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ahvy7-_gSIeAa1Ym5ohl7w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:15:33 INFO - mkdir: /builds/slave/test/properties 05:15:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:15:33 INFO - Writing to file /builds/slave/test/properties/build_url 05:15:33 INFO - Contents: 05:15:33 INFO - build_url:https://queue.taskcluster.net/v1/task/ahvy7-_gSIeAa1Ym5ohl7w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:15:34 INFO - Running post-action listener: _resource_record_post_action 05:15:34 INFO - Running post-action listener: set_extra_try_arguments 05:15:34 INFO - ##### 05:15:34 INFO - ##### Running populate-webroot step. 05:15:34 INFO - ##### 05:15:34 INFO - Running pre-action listener: _resource_record_pre_action 05:15:34 INFO - Running main action method: populate_webroot 05:15:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:15:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:15:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:15:34 INFO - '--tppagecycles', 05:15:34 INFO - '7'], 05:15:34 INFO - 'tests': ['tsvgm']}}, 05:15:34 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:15:34 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:15:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:15:34 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:15:34 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:15:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:15:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:15:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:34 INFO - 'talos_options': ['--e10s'], 05:15:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:15:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:34 INFO - 'tests': ['damp', 'tps']}, 05:15:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:34 INFO - 'talos_options': ['--e10s'], 05:15:34 INFO - 'tests': ['damp', 'tps']}, 05:15:34 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:15:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:15:34 INFO - 'other': {'tests': ['a11yr', 05:15:34 INFO - 'ts_paint', 05:15:34 INFO - 'tpaint', 05:15:34 INFO - 'sessionrestore', 05:15:34 INFO - 'sessionrestore_no_auto_restore']}, 05:15:34 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:15:34 INFO - 'tests': ['a11yr', 05:15:34 INFO - 'ts_paint', 05:15:34 INFO - 'tpaint', 05:15:34 INFO - 'sessionrestore', 05:15:34 INFO - 'sessionrestore_no_auto_restore']}, 05:15:34 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:15:34 INFO - 'tests': ['a11yr', 05:15:34 INFO - 'ts_paint', 05:15:34 INFO - 'tpaint', 05:15:34 INFO - 'sessionrestore', 05:15:34 INFO - 'sessionrestore_no_auto_restore']}, 05:15:34 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:15:34 INFO - 'tests': ['a11yr', 05:15:34 INFO - 'ts_paint', 05:15:34 INFO - 'tpaint', 05:15:34 INFO - 'sessionrestore', 05:15:34 INFO - 'sessionrestore_no_auto_restore']}, 05:15:34 INFO - 'other_l64': {'tests': ['a11yr', 05:15:34 INFO - 'ts_paint', 05:15:34 INFO - 'tpaint', 05:15:34 INFO - 'sessionrestore', 05:15:34 INFO - 'sessionrestore_no_auto_restore']}, 05:15:34 INFO - 'other_nol64': {'tests': ['a11yr', 05:15:34 INFO - 'ts_paint', 05:15:34 INFO - 'tpaint', 05:15:34 INFO - 'sessionrestore', 05:15:34 INFO - 'sessionrestore_no_auto_restore']}, 05:15:34 INFO - 'svgr': {'tests': ['tsvgx', 05:15:34 INFO - 'tsvgr_opacity', 05:15:34 INFO - 'tart', 05:15:34 INFO - 'tscrollx', 05:15:34 INFO - 'cart']}, 05:15:34 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:15:34 INFO - 'tests': ['tsvgx', 05:15:34 INFO - 'tsvgr_opacity', 05:15:34 INFO - 'tart', 05:15:34 INFO - 'tscrollx', 05:15:34 INFO - 'cart']}, 05:15:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:34 INFO - 'tests': ['tp5o']}, 05:15:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:34 INFO - 'talos_options': ['--e10s'], 05:15:34 INFO - 'tests': ['tp5o']}, 05:15:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:34 INFO - 'talos_options': ['--xperf_path', 05:15:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:15:34 INFO - 'tests': ['tp5n']}, 05:15:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:34 INFO - 'talos_options': ['--e10s', 05:15:34 INFO - '--xperf_path', 05:15:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:15:34 INFO - 'tests': ['tp5n']}}, 05:15:34 INFO - 'talos.zip': {'path': '', 05:15:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:15:34 INFO - Running post-action listener: _resource_record_post_action 05:15:34 INFO - ##### 05:15:34 INFO - ##### Running create-virtualenv step. 05:15:34 INFO - ##### 05:15:34 INFO - Running pre-action listener: _resource_record_pre_action 05:15:34 INFO - Running main action method: create_virtualenv 05:15:34 INFO - Creating virtualenv /builds/slave/test/build/venv 05:15:34 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:15:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:15:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:15:35 INFO - Using real prefix '/tools/python27' 05:15:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:15:35 INFO - Installing distribute.............................................................................................................................................................................................done. 05:15:38 INFO - Installing pip.................done. 05:15:38 INFO - Return code: 0 05:15:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:15:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102a55a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a5c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb78b4a5cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028f9d30>, '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 0x10271ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1028f0b20>, '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.h3TF1Svj5T/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.qQrrZ6b05L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:15:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:15:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:15:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h3TF1Svj5T/Render', 05:15:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:38 INFO - 'HOME': '/Users/cltbld', 05:15:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:38 INFO - 'LOGNAME': 'cltbld', 05:15:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:38 INFO - 'MOZ_NO_REMOTE': '1', 05:15:38 INFO - 'NO_EM_RESTART': '1', 05:15:38 INFO - 'PAGER': '/bin/cat', 05:15:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:38 INFO - 'PWD': '/builds/slave/test', 05:15:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:38 INFO - 'SHELL': '/bin/bash', 05:15:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qQrrZ6b05L/Listeners', 05:15:38 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 05:15:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:38 INFO - 'USER': 'cltbld', 05:15:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:38 INFO - 'XPC_FLAGS': '0x0', 05:15:38 INFO - 'XPC_SERVICE_NAME': '0', 05:15:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:38 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:15:38 INFO - Cleaning up... 05:15:38 INFO - Return code: 0 05:15:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:15:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102a55a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a5c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb78b4a5cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028f9d30>, '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 0x10271ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1028f0b20>, '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.h3TF1Svj5T/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.qQrrZ6b05L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:15:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:15:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:15:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h3TF1Svj5T/Render', 05:15:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:38 INFO - 'HOME': '/Users/cltbld', 05:15:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:38 INFO - 'LOGNAME': 'cltbld', 05:15:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:38 INFO - 'MOZ_NO_REMOTE': '1', 05:15:38 INFO - 'NO_EM_RESTART': '1', 05:15:38 INFO - 'PAGER': '/bin/cat', 05:15:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:38 INFO - 'PWD': '/builds/slave/test', 05:15:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:38 INFO - 'SHELL': '/bin/bash', 05:15:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qQrrZ6b05L/Listeners', 05:15:38 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 05:15:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:38 INFO - 'USER': 'cltbld', 05:15:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:38 INFO - 'XPC_FLAGS': '0x0', 05:15:38 INFO - 'XPC_SERVICE_NAME': '0', 05:15:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:39 INFO - Downloading/unpacking psutil>=0.7.1 05:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:15:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:15:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:15:42 INFO - Installing collected packages: psutil 05:15:42 INFO - Running setup.py install for psutil 05:15:42 INFO - building 'psutil._psutil_osx' extension 05:15:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:15:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:15:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:15:42 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:15:42 INFO - building 'psutil._psutil_posix' extension 05:15:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:15:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:15:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:15:42 INFO - ^ 05:15:42 INFO - 1 warning generated. 05:15:42 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:15:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:15:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:15:42 INFO - Successfully installed psutil 05:15:42 INFO - Cleaning up... 05:15:42 INFO - Return code: 0 05:15:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:15:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:43 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 0x102a55a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a5c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb78b4a5cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028f9d30>, '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 0x10271ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1028f0b20>, '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.h3TF1Svj5T/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.qQrrZ6b05L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:15:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:15:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:15:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h3TF1Svj5T/Render', 05:15:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:43 INFO - 'HOME': '/Users/cltbld', 05:15:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:43 INFO - 'LOGNAME': 'cltbld', 05:15:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:43 INFO - 'MOZ_NO_REMOTE': '1', 05:15:43 INFO - 'NO_EM_RESTART': '1', 05:15:43 INFO - 'PAGER': '/bin/cat', 05:15:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:43 INFO - 'PWD': '/builds/slave/test', 05:15:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:43 INFO - 'SHELL': '/bin/bash', 05:15:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qQrrZ6b05L/Listeners', 05:15:43 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 05:15:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:43 INFO - 'USER': 'cltbld', 05:15:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:43 INFO - 'XPC_FLAGS': '0x0', 05:15:43 INFO - 'XPC_SERVICE_NAME': '0', 05:15:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:15:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:15:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:15:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:15:45 INFO - Installing collected packages: mozsystemmonitor 05:15:45 INFO - Running setup.py install for mozsystemmonitor 05:15:45 INFO - Successfully installed mozsystemmonitor 05:15:45 INFO - Cleaning up... 05:15:45 INFO - Return code: 0 05:15:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:15:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:45 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 0x102a55a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a5c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb78b4a5cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028f9d30>, '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 0x10271ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1028f0b20>, '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.h3TF1Svj5T/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.qQrrZ6b05L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:15:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:15:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:15:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h3TF1Svj5T/Render', 05:15:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:45 INFO - 'HOME': '/Users/cltbld', 05:15:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:45 INFO - 'LOGNAME': 'cltbld', 05:15:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:45 INFO - 'MOZ_NO_REMOTE': '1', 05:15:45 INFO - 'NO_EM_RESTART': '1', 05:15:45 INFO - 'PAGER': '/bin/cat', 05:15:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:45 INFO - 'PWD': '/builds/slave/test', 05:15:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:45 INFO - 'SHELL': '/bin/bash', 05:15:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qQrrZ6b05L/Listeners', 05:15:45 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 05:15:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:45 INFO - 'USER': 'cltbld', 05:15:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:45 INFO - 'XPC_FLAGS': '0x0', 05:15:45 INFO - 'XPC_SERVICE_NAME': '0', 05:15:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:46 INFO - Downloading/unpacking blobuploader==1.2.4 05:15: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 05:15: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 05:15: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 05:15: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 05:15: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 05:15: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 05:15:48 INFO - Downloading blobuploader-1.2.4.tar.gz 05:15:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:15:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:15:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:49 INFO - Downloading docopt-0.6.1.tar.gz 05:15:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:15:49 INFO - Installing collected packages: blobuploader, requests, docopt 05:15:49 INFO - Running setup.py install for blobuploader 05:15:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:15:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:15:49 INFO - Running setup.py install for requests 05:15:50 INFO - Running setup.py install for docopt 05:15:50 INFO - Successfully installed blobuploader requests docopt 05:15:50 INFO - Cleaning up... 05:15:50 INFO - Return code: 0 05:15:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:50 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 0x102a55a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a5c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb78b4a5cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028f9d30>, '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 0x10271ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1028f0b20>, '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.h3TF1Svj5T/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.qQrrZ6b05L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:15:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:15:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:15:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h3TF1Svj5T/Render', 05:15:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:50 INFO - 'HOME': '/Users/cltbld', 05:15:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:50 INFO - 'LOGNAME': 'cltbld', 05:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:50 INFO - 'MOZ_NO_REMOTE': '1', 05:15:50 INFO - 'NO_EM_RESTART': '1', 05:15:50 INFO - 'PAGER': '/bin/cat', 05:15:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:50 INFO - 'PWD': '/builds/slave/test', 05:15:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:50 INFO - 'SHELL': '/bin/bash', 05:15:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qQrrZ6b05L/Listeners', 05:15:50 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 05:15:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:50 INFO - 'USER': 'cltbld', 05:15:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:50 INFO - 'XPC_FLAGS': '0x0', 05:15:50 INFO - 'XPC_SERVICE_NAME': '0', 05:15:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:15:50 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-NsjVsV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:15:50 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-2vfClF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:15:51 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-Xq_e4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:15:51 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-L7vXT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:15:51 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-wYwl2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:15:51 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-0yfBcO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:15:51 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-lp76Gl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:15:51 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-PAEgRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:15:51 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-3SHs1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:15:51 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-YeC4dm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:15:51 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-2wbQBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:15:51 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-26PeO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:15:52 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-34CAqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:15:52 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-1XH_AO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:15:52 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-s6IIE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:15:52 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-HCOYg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:15:52 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-YQPepQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:15:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:15:52 INFO - Running setup.py install for manifestparser 05:15:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:15:52 INFO - Running setup.py install for mozcrash 05:15:52 INFO - Running setup.py install for mozdebug 05:15:53 INFO - Running setup.py install for mozdevice 05:15:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:15:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:15:53 INFO - Running setup.py install for mozfile 05:15:53 INFO - Running setup.py install for mozhttpd 05:15:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:15:53 INFO - Running setup.py install for mozinfo 05:15:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:15:53 INFO - Running setup.py install for mozInstall 05:15:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:15:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:15:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:15:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:15:53 INFO - Running setup.py install for mozleak 05:15:53 INFO - Running setup.py install for mozlog 05:15:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:15:54 INFO - Running setup.py install for moznetwork 05:15:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:15:54 INFO - Running setup.py install for mozprocess 05:15:54 INFO - Running setup.py install for mozprofile 05:15:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:15:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:15:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:15:54 INFO - Running setup.py install for mozrunner 05:15:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:15:54 INFO - Running setup.py install for mozscreenshot 05:15:54 INFO - Running setup.py install for moztest 05:15:54 INFO - Running setup.py install for mozversion 05:15:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:15:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:15:55 INFO - Cleaning up... 05:15:55 INFO - Return code: 0 05:15:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:15:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:55 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 0x102a55a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a5c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb78b4a5cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028f9d30>, '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 0x10271ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1028f0b20>, '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.h3TF1Svj5T/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.qQrrZ6b05L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:15:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:15:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:15:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h3TF1Svj5T/Render', 05:15:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:55 INFO - 'HOME': '/Users/cltbld', 05:15:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:55 INFO - 'LOGNAME': 'cltbld', 05:15:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:55 INFO - 'MOZ_NO_REMOTE': '1', 05:15:55 INFO - 'NO_EM_RESTART': '1', 05:15:55 INFO - 'PAGER': '/bin/cat', 05:15:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:55 INFO - 'PWD': '/builds/slave/test', 05:15:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:55 INFO - 'SHELL': '/bin/bash', 05:15:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qQrrZ6b05L/Listeners', 05:15:55 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 05:15:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:55 INFO - 'USER': 'cltbld', 05:15:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:55 INFO - 'XPC_FLAGS': '0x0', 05:15:55 INFO - 'XPC_SERVICE_NAME': '0', 05:15:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:15:55 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-DhCVNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:15:55 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:15:55 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-uuJhjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:15:55 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)) 05:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:15:55 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-GMabio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:15:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:15:55 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-0UZcD2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:15:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:15:55 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-D2u_bh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:15:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:15:55 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-O4JKaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:15:56 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-Huenjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:15:56 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-dfNbLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:15:56 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-S5KvUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:15:56 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-yy8clP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:15:56 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-Gyry64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:15:56 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-LMMSmY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:15:56 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-NYardC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:15:56 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-z1sjYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:15:56 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-S5b8N_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:15:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:15:57 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-zhzI0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:15:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:15:57 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-cMw18c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:15:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:15:57 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)) 05:15:57 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)) 05:15:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:15:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:15:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:15:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:59 INFO - Downloading blessings-1.6.tar.gz 05:15:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:15:59 INFO - Installing collected packages: blessings 05:15:59 INFO - Running setup.py install for blessings 05:15:59 INFO - Successfully installed blessings 05:15:59 INFO - Cleaning up... 05:15:59 INFO - Return code: 0 05:15:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:15:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:15:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:16:00 INFO - Reading from file tmpfile_stdout 05:16:00 INFO - Current package versions: 05:16:00 INFO - blessings == 1.6 05:16:00 INFO - blobuploader == 1.2.4 05:16:00 INFO - docopt == 0.6.1 05:16:00 INFO - manifestparser == 1.1 05:16:00 INFO - mozInstall == 1.12 05:16:00 INFO - mozcrash == 0.16 05:16:00 INFO - mozdebug == 0.1 05:16:00 INFO - mozdevice == 0.48 05:16:00 INFO - mozfile == 1.2 05:16:00 INFO - mozhttpd == 0.7 05:16:00 INFO - mozinfo == 0.9 05:16:00 INFO - mozleak == 0.1 05:16:00 INFO - mozlog == 3.1 05:16:00 INFO - moznetwork == 0.27 05:16:00 INFO - mozprocess == 0.22 05:16:00 INFO - mozprofile == 0.28 05:16:00 INFO - mozrunner == 6.11 05:16:00 INFO - mozscreenshot == 0.1 05:16:00 INFO - mozsystemmonitor == 0.0 05:16:00 INFO - moztest == 0.7 05:16:00 INFO - mozversion == 1.4 05:16:00 INFO - psutil == 3.1.1 05:16:00 INFO - requests == 1.2.3 05:16:00 INFO - wsgiref == 0.1.2 05:16:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:16:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:00 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 0x102a55a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a5c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb78b4a5cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028f9d30>, '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 0x10271ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1028f0b20>, '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.h3TF1Svj5T/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.qQrrZ6b05L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:16:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:16:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:16:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h3TF1Svj5T/Render', 05:16:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:00 INFO - 'HOME': '/Users/cltbld', 05:16:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:00 INFO - 'LOGNAME': 'cltbld', 05:16:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:00 INFO - 'MOZ_NO_REMOTE': '1', 05:16:00 INFO - 'NO_EM_RESTART': '1', 05:16:00 INFO - 'PAGER': '/bin/cat', 05:16:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:00 INFO - 'PWD': '/builds/slave/test', 05:16:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:00 INFO - 'SHELL': '/bin/bash', 05:16:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qQrrZ6b05L/Listeners', 05:16:00 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 05:16:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:00 INFO - 'USER': 'cltbld', 05:16:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:00 INFO - 'XPC_FLAGS': '0x0', 05:16:00 INFO - 'XPC_SERVICE_NAME': '0', 05:16:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:16:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:16:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:16:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:16:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:16:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:16:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:16:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:16:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:16:00 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:16:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:16:00 INFO - Cleaning up... 05:16:00 INFO - Return code: 0 05:16:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:16:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:00 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 0x102a55a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a5c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb78b4a5cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028f9d30>, '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 0x10271ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1028f0b20>, '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.h3TF1Svj5T/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.qQrrZ6b05L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:16:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:16:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:16:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h3TF1Svj5T/Render', 05:16:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:00 INFO - 'HOME': '/Users/cltbld', 05:16:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:00 INFO - 'LOGNAME': 'cltbld', 05:16:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:00 INFO - 'MOZ_NO_REMOTE': '1', 05:16:00 INFO - 'NO_EM_RESTART': '1', 05:16:00 INFO - 'PAGER': '/bin/cat', 05:16:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:00 INFO - 'PWD': '/builds/slave/test', 05:16:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:00 INFO - 'SHELL': '/bin/bash', 05:16:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qQrrZ6b05L/Listeners', 05:16:00 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 05:16:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:00 INFO - 'USER': 'cltbld', 05:16:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:00 INFO - 'XPC_FLAGS': '0x0', 05:16:00 INFO - 'XPC_SERVICE_NAME': '0', 05:16:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:00 INFO - Downloading/unpacking jsonschema 05:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:16:03 INFO - Downloading/unpacking functools32 (from jsonschema) 05:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:03 INFO - Downloading functools32-3.2.3-2.tar.gz 05:16:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:16:03 INFO - warning: no files found matching '*.txt' 05:16:03 INFO - no previously-included directories found matching 'build' 05:16:03 INFO - no previously-included directories found matching 'dist' 05:16:03 INFO - no previously-included directories found matching '.git*' 05:16:03 INFO - Installing collected packages: jsonschema, functools32 05:16:03 INFO - Running setup.py install for functools32 05:16:03 INFO - warning: no files found matching '*.txt' 05:16:03 INFO - no previously-included directories found matching 'build' 05:16:03 INFO - no previously-included directories found matching 'dist' 05:16:03 INFO - no previously-included directories found matching '.git*' 05:16:03 INFO - Successfully installed jsonschema functools32 05:16:03 INFO - Cleaning up... 05:16:03 INFO - Return code: 0 05:16:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:03 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 0x102a55a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a5c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb78b4a5cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028f9d30>, '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 0x10271ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1028f0b20>, '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.h3TF1Svj5T/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.qQrrZ6b05L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:16:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:16:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:16:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h3TF1Svj5T/Render', 05:16:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:03 INFO - 'HOME': '/Users/cltbld', 05:16:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:03 INFO - 'LOGNAME': 'cltbld', 05:16:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:03 INFO - 'MOZ_NO_REMOTE': '1', 05:16:03 INFO - 'NO_EM_RESTART': '1', 05:16:03 INFO - 'PAGER': '/bin/cat', 05:16:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:03 INFO - 'PWD': '/builds/slave/test', 05:16:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:03 INFO - 'SHELL': '/bin/bash', 05:16:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qQrrZ6b05L/Listeners', 05:16:03 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 05:16:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:03 INFO - 'USER': 'cltbld', 05:16:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:03 INFO - 'XPC_FLAGS': '0x0', 05:16:03 INFO - 'XPC_SERVICE_NAME': '0', 05:16:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:04 INFO - Downloading/unpacking flake8 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:16:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:16:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:16:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:16:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:16:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:16:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:16:07 INFO - no previously-included directories found matching 'docs/_build' 05:16:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:16:07 INFO - Running setup.py install for pep8 05:16:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:16:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:16:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:16:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:16:07 INFO - no previously-included directories found matching 'docs/_build' 05:16:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:16:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:16:07 INFO - Cleaning up... 05:16:08 INFO - Return code: 0 05:16:08 INFO - Running post-action listener: _resource_record_post_action 05:16:08 INFO - Running post-action listener: _start_resource_monitoring 05:16:08 INFO - Starting resource monitoring. 05:16:08 INFO - ##### 05:16:08 INFO - ##### Running install step. 05:16:08 INFO - ##### 05:16:08 INFO - Running pre-action listener: _resource_record_pre_action 05:16:08 INFO - Running main action method: install 05:16:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:16:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:16:08 INFO - Reading from file tmpfile_stdout 05:16:08 INFO - Detecting whether we're running mozinstall >=1.0... 05:16:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:16:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:16:08 INFO - Reading from file tmpfile_stdout 05:16:08 INFO - Output received: 05:16:08 INFO - Usage: mozinstall [options] installer 05:16:08 INFO - Options: 05:16:08 INFO - -h, --help show this help message and exit 05:16:08 INFO - -d DEST, --destination=DEST 05:16:08 INFO - Directory to install application into. [default: 05:16:08 INFO - "/builds/slave/test"] 05:16:08 INFO - --app=APP Application being installed. [default: firefox] 05:16:08 INFO - mkdir: /builds/slave/test/build/application 05:16:08 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'] 05:16:08 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 05:16:42 INFO - Reading from file tmpfile_stdout 05:16:42 INFO - Output received: 05:16:42 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:16:42 INFO - Running post-action listener: _resource_record_post_action 05:16:42 INFO - ##### 05:16:42 INFO - ##### Running run-tests step. 05:16:42 INFO - ##### 05:16:42 INFO - Running pre-action listener: _resource_record_pre_action 05:16:42 INFO - Running main action method: run_tests 05:16:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:16:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:16:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:16:42 INFO - 2016-02-26 05:16:42.167 screenresolution[1974:62662] starting screenresolution argv=screenresolution get 05:16:42 INFO - 2016-02-26 05:16:42.170 screenresolution[1974:62662] Display 0: 1600x1200x32@60 05:16:42 INFO - 2016-02-26 05:16:42.175 screenresolution[1975:62665] starting screenresolution argv=screenresolution list 05:16:42 INFO - Available Modes on Display 0 05:16:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:16:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:16:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:16:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:16:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:16:42 INFO - Intel Iris: 05:16:42 INFO - Chipset Model: Intel Iris 05:16:42 INFO - Type: GPU 05:16:42 INFO - Bus: Built-In 05:16:42 INFO - VRAM (Dynamic, Max): 1536 MB 05:16:42 INFO - Vendor: Intel (0x8086) 05:16:42 INFO - Device ID: 0x0a2e 05:16:42 INFO - Revision ID: 0x0009 05:16:42 INFO - Displays: 05:16:42 INFO - Display: 05:16:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:16:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:16:42 INFO - Display Serial Number: 1600x1200 60 05:16:42 INFO - Main Display: Yes 05:16:42 INFO - Mirror: Off 05:16:42 INFO - Online: Yes 05:16:42 INFO - Rotation: Supported 05:16:42 INFO - Return code: 0 05:16:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:16:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:16:42 INFO - Python 2.7.3 05:16:42 INFO - Return code: 0 05:16:42 INFO - grabbing minidump binary from tooltool 05:16:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:42 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 0x1028f9d30>, '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 0x10271ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1028f0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:16:42 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:16:42 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:16:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:16:42 INFO - Return code: 0 05:16:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:16:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:16:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:16:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:16:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:16:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:16:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:16:43 INFO - Return code: 0 05:16:43 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ahvy7-_gSIeAa1Ym5ohl7w/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0112', '--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 05:16:43 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/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ahvy7-_gSIeAa1Ym5ohl7w/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0112 --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 05:16:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h3TF1Svj5T/Render', 05:16:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:43 INFO - 'HOME': '/Users/cltbld', 05:16:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:43 INFO - 'LOGNAME': 'cltbld', 05:16:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:16:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:16:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:43 INFO - 'MOZ_NO_REMOTE': '1', 05:16:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:16:43 INFO - 'NO_EM_RESTART': '1', 05:16:43 INFO - 'PAGER': '/bin/cat', 05:16:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:43 INFO - 'PWD': '/builds/slave/test', 05:16:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:16:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:43 INFO - 'SHELL': '/bin/bash', 05:16:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qQrrZ6b05L/Listeners', 05:16:43 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 05:16:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:43 INFO - 'USER': 'cltbld', 05:16:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:43 INFO - 'XPC_FLAGS': '0x0', 05:16:43 INFO - 'XPC_SERVICE_NAME': '0', 05:16:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:43 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ahvy7-_gSIeAa1Ym5ohl7w/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0112', '--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 05:16:43 INFO - mozversion application_buildid: 20160226030256 05:16:43 INFO - mozversion application_changeset: 918df3a0bc1c4d07299e4f66274a7da923534577 05:16:43 INFO - mozversion application_display_name: Nightly 05:16:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:16:43 INFO - mozversion application_name: Firefox 05:16:43 INFO - mozversion application_remotingname: firefox 05:16:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:16:43 INFO - mozversion application_vendor: Mozilla 05:16:43 INFO - mozversion application_version: 47.0a1 05:16:43 INFO - mozversion platform_buildid: 20160226030256 05:16:43 INFO - mozversion platform_changeset: 918df3a0bc1c4d07299e4f66274a7da923534577 05:16:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:16:43 INFO - mozversion platform_version: 47.0a1 05:16:43 INFO - using testdate: 1456492603 05:16:43 INFO - actual date: 1456492603 05:16:44 INFO - starting webserver on 'localhost:50544' 05:16:44 INFO - SUITE-START | Running 2 tests 05:16:44 INFO - TEST-START | dromaeo_css 05:16:44 INFO - operating with platform_type : mac_ 05:16:44 INFO - Initialising browser for dromaeo_css test... 05:16:44 INFO - TEST-INFO | started process 1993 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmpING04j/profile http://localhost:50544/getInfo.html) 05:16:47 INFO - PROCESS | 1993 | __metrics Screen width/height:1600/1200 05:16:47 INFO - PROCESS | 1993 | colorDepth:24 05:16:47 INFO - PROCESS | 1993 | Browser inner width/height: 1024/689 05:16:47 INFO - PROCESS | 1993 | __metrics 05:16:47 ERROR - PROCESS | 1993 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 05:16:48 INFO - TEST-INFO | 1993: exit 0 05:16:48 INFO - Browser initialized. 05:16:48 INFO - Running cycle 1/1 for dromaeo_css test... 05:16:48 INFO - TEST-INFO | started process 1998 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmpING04j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:17:00 INFO - PROCESS | 1998 | RSS: Main: 255479808 05:17:00 INFO - PROCESS | 1998 | 05:17:50 INFO - PROCESS | 1998 | 1456492670113 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:20:00 INFO - PROCESS | 1998 | Cycle 1(1): loaded http://localhost:50544/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50544/tests/dromaeo/cssquery-ext.html) 05:20:01 INFO - PROCESS | 1998 | RSS: Main: 274579456 05:20:01 INFO - PROCESS | 1998 | 05:23:03 INFO - PROCESS | 1998 | Cycle 1(1): loaded http://localhost:50544/tests/dromaeo/cssquery-ext.html (next: http://localhost:50544/tests/dromaeo/cssquery-jquery.html) 05:23:04 INFO - PROCESS | 1998 | RSS: Main: 285671424 05:23:04 INFO - PROCESS | 1998 | 05:26:05 INFO - PROCESS | 1998 | Cycle 1(1): loaded http://localhost:50544/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50544/tests/dromaeo/cssquery-mootools.html) 05:26:06 INFO - PROCESS | 1998 | RSS: Main: 286121984 05:26:06 INFO - PROCESS | 1998 | 05:29:08 INFO - PROCESS | 1998 | Cycle 1(1): loaded http://localhost:50544/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50544/tests/dromaeo/cssquery-prototype.html) 05:29:08 INFO - PROCESS | 1998 | RSS: Main: 288481280 05:29:08 INFO - PROCESS | 1998 | 05:32:11 INFO - PROCESS | 1998 | Cycle 1(1): loaded http://localhost:50544/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50544/tests/dromaeo/cssquery-yui.html) 05:32:12 INFO - PROCESS | 1998 | RSS: Main: 290422784 05:32:12 INFO - PROCESS | 1998 | 05:35:14 INFO - PROCESS | 1998 | Cycle 1(1): loaded http://localhost:50544/tests/dromaeo/cssquery-yui.html (next: http://localhost:50544/tests/dromaeo/cssquery-dojo.html) 05:35:14 INFO - PROCESS | 1998 | RSS: Main: 293072896 05:35:14 INFO - PROCESS | 1998 | 05:35:14 INFO - PROCESS | 1998 | __start_tp_report 05:35:14 INFO - PROCESS | 1998 | _x_x_mozilla_page_load 05:35:14 INFO - PROCESS | 1998 | _x_x_mozilla_page_load_details 05:35:14 INFO - PROCESS | 1998 | |i|pagename|runs| 05:35:14 INFO - PROCESS | 1998 | |0;dojo.html;3453.1539772755677;3466.532018177547;3499.8250087495617;3520.366334059869;3533.2756784859107;4334.7182433141825;5303.469653034699;5655.0386434306165;5661.207430959664;5666.546676265899;5553.805616803413;5635.971820140893;5681.886362272752;5692.430756924306;5798.217240672508;4183.2051910137125;5141.254518094874;5145.845624631248;5173.793048278083;5293.708846013467;5170;5183.144781111112;5191.480851914797;5229.686218826863;5234.6335756497065;5102.438731739506;5132.3071385363055;5166.535011848914;5203.349581302337;5209.374875015023;5151.948480515184;5161.483851614846;5173.430922598511;5177.611679124081;5215.0873597120735;4977.303177555145;5127.282180494733;5151.922721159186;5156.252343410185;5179.430262671103;5456.699881506515;5518.061929471959;5582.609217354787;5602.38373778884;5633.80281690143;6100.206973093514;6132.570720049598;6160.5687601867885;6178.845528861814;6210.472109870621;6108.433136212286;6178.10417489466;6221.284552276501;6251.499880009588;6268.310485846553;5682.659040457585;5752.395998420147;5766.971165144148;5772;5784.2769653793275;6256.092866534327;6257.342978987232;6259.18630578031;6267.40459656341;6274.717637706314;5841.357450680422;5921.67430791302;5957.49361304294;6011.278646562353;6113.969430152821;6111.956402836248;6136.662483563447;6170.784022559279;6175.3515880832765;6201.0388389799655;6147.139400483936;6170.413810688067;6192.071189321638;6194.194754681953;6240.375962403723;6028.547858910511;6216.720247588869;6218.751249949952;6219.937800621936;6221.782237621662;3786.2048969716116;4475.328700694922;4816.831410900601;4893.510648935149;4926.9014619707405;3885.3977633466857;4024.577419370924;4346.521882592912;4361.869143925687;4387.561243875651;4790.880227994328;5668.829935101953;5676.602637815313;5712.885742285131;5768.826935191951;5619.353774315924;6087.117367981707;6157.983932651152;6231.345708700612;6275.6862156891975;4785.282207668877;5803;5812.854678632983;5820.243368362086;5829.8251052468495;4647.34937108805;5325.307709997753;5374.328208973879;5381.1121165007335;5390.757415916293;5581.330240371181;6049.969750151221;6259.655718935503;6272.090546870678;6299.779507717391;6225.190725205694;6233.906491402723;6263.906041409291;6264.780732674334;6282.685865706788;6171.783987560414;6203.565750397609;6218.347073557392;6252.718627661857;6298;6062.545309101747;6094.714482069224;6137.039921714347;6159.19930409044;6177.073438984188;6213;6218.906716399167;6272.717727702173;6280.403361680633;6316.431521163117;5646.774129034957;5943.959807033665;6031.668258245839;6127.448529632355;6170.228721409824;6081.847953801013;6094.939050609437;6111.694415279129;6112.908306375497;6136.662483563447;5719.771209151588;5908.261467316585;5914.7338369774325;5926.851828704317;5940.376260492586;5942.078977758454;5982.7307771149535;6021.819345419644;6052.576319657582;6067.393260673897;5841.649501029782;5924.844655292177;5925.466707996301;5936.554758393051;5937.168796368425 05:35:14 INFO - PROCESS | 1998 | |1;ext.html;411.32337305133075;458.7752001519257;503.96686792076247;556.5575367582771;591.449951545063;35000.649993500054;35478.75824346145;35527.11182220446;35575;35591.93224203275;36717.63282367175;36763;37279.440808387895;37349.439758403576;37390.626093739054;9256.352055356128;9415.81168376632;9452.621895124186;9471.194948429391;9479.763005924839;9339.3462457628;9464;9544.856827147598;9615.66345177919;9632.277579181555;8893.644254229856;9032.870891138607;9542.713718588453;9585.52072396381;9596.616135354612;9498.810023799555;9510.714678559654;9525.666601668978;9610.423374597547;9618.422894626345;9345.01877302887;9416.62333506659;9471.715848524555;9489.857652135224;9502.619895204183;36252.912412627666;36354;36604.450933236025;36687;36822;3039.4377040247405;3107.036818586223;3270.656581058978;3270.8528116234825;3321.70104690579;27104;27343;27495.725042749516;27659.861700691366;27716.72283277182;2450.301664025762;2757.8621068946472;2760.5721113227482;2771.057840334276;2793.022442145233;444929.99999999674;465889.9999999966;466127;467521;470269;42966.14067718628;58057.129143062884;58253.70873145607;58290.708546457;58338.7083064582;34972.825135874155;42597.36103958443;42621.78689106535;42913.14173716571;42964.14071718548;14841.480548180762;14989.475368362055;15228.543143705707;15237.923810381099;15265.465708700141;9465.810683786285;11284.040856527286;11426.542938282542;11478.024367928652;11503.19477636574;13870.306484675726;14051.367688454044;14086.718265634834;14115.941304402211;14237.85762142386;5129.281900533928;5246.527812496817;6248.094026366151;6267.091271765568;6287.49700023997;935.3779736475168;976;981.2983716642635;983.7048885334514;998.7253505286104;28585.428291434055;28613.99851005205;29110.12669619915;29157.56263656047;29422.264443389085;997.2321312589265;1046.6127532812757;1097.7859317433183;1157.8494795676509;1230.3048777440717;12425.875741242471;13875.889928805671;14526.636834079021;14703.294945617514;14840.777388339184;518482;524500;528923;529985;530825;53974.46025539773;54402.72798636061;54554.63613409697;55094.173587396224;55110.44889551053;1392.1716578635696;1409.9647508812361;1425.6435891027243;1430.8354539228121;1435.067206315903;28235.858820705766;28240.85879570589;28510;28843.5673464894;29249.561256581594;46642;46758.298625521325;46831.76584117058;46928;47272.7636361816;491517;494284;496937;497908;498597.5070124626;31653;31815.045548633578;31874.52188217225;32068.358632826745;32374.190645233117;41832;42272.36591451192;42415.93960151021;43134;43299;30742;30766.230844229074;35712.28575428425;35754.88818785769;35910;32381.838090809397;35527.11182220362;35627;35870.8206458966;36049.459258111674;30108;31162;31605.36789264248;33198.83804066846;35774.926752197476;25270.873645631655;28274.151775446768;29355.266118347212;30116.647933058575;30358.392832143676;23282;23640.29079127629;23708.52582948297;23967;24140.39649008789 05:35:14 INFO - PROCESS | 1998 | |2;jquery.html;293.5816461542302;350.3378614418749;354.9105822505274;356.88758041217017;366.83492428407226;15519.84480155198;19353.032348382578;19481.318153864617;19497.415077547677;20321.49196270094;19732.309369172082;19957.60084798303;20473.590528189427;20695;20786.272480463187;5547.805826796063;5679.650913157672;5736.971315143439;5803.390643982384;5863.5016023638045;5703.914441283384;5747.626404283729;7025.789226323193;7289.635518224094;7344.081989751281;7161;7292.380147687453;7347.88978165328;7746.690132394726;7772.650230739602;6536.477081833442;7552.5846078465665;7604.5437273763755;7648.502847314934;7660;6670.132882725263;6910.101686780737;6972.58164510126;6972.895406568906;6986.16166060076;21784.455388615253;26260.73739262602;26514.072007479837;26957.730422695717;27399;2188.420068681785;2216.213244298267;2351.271105957159;2639.6436481075;2687.5699888017825;14758.11451312914;15303.846961530353;15591.37634494619;15935.760963585555;16249.781266405067;1762.3567397899803;1828.1590468384559;1829.805228725651;1836.036081057442;1853.5644123630937;94281.52859235728;97461.51269243608;98088;98540;115622;17468.82531174672;18673.90663046676;19406.514837128903;19715.40853774389;19729.506762331057;12902.161359511601;13150.736985260433;28286.575701364083;28291.43417131687;28470.288242793682;8342.708005219789;8511.489310641382;8579.82840343202;8647.178518040777;8658.523781192094;8853.822923541493;8898.199162075314;8947.910520894839;9013.77465563353;9039.367244292836;4474.418325617649;4487.506374298824;4528.864134075983;4544.818207271672;4564.680472366969;1856.6565185440736;1914.5022294203607;1930.4980705016517;1934.7484826972684;1936.244864502845;770.4799260499141;902.9051949545335;970.4763521271536;1045.2160879340495;1049.3074570783247;18530.722039169425;19755.802441975684;20517.487062823548;20596.691049634268;20760.169593216404;918.3433844801;919.544825311475;941.4445477168366;1004.322082594246;1033.9172866170688;9071.727848164566;10761.78476430467;10981.12151027916;11024.944875275572;11062.612808551663;485041;513119;523582;642374;657020;86099.5695021521;114230;123194;127690.36154819353;128361;983.8376667849725;1018.1447584029303;1044.3890324160452;1083.1713738989679;1092.0990183098975;18484;18822.52943676419;18917;18949.43151705451;18967;40052.799736001136;48942.51057489379;50758.746206268734;52937.47062529325;53672;54475.0933717318;66365;67682.66158669176;69628.60742785217;70033.64983175052;6476.870462590816;7729.613519323899;8067.919320806717;8112.22933821286;8118;5661.688607126647;9665.951670241886;10858.945705271422;11033.007029367396;11862.762744745229;10903.781924361627;11467.369294688871;11572.6528204154;11694.766104678029;11847.76304473923;9427.3400861939;11106.777864442503;11231.989120979151;11482.655520334403;11551.249168804;9235.630574776933;9832.065953734384;11663.533458661559;11787.528498860293;12100.273983561014;7003.159620845531;7765.961170194113;8036.276735093869;8087.63605637736;8091.150429205084;10782.353058816496;11305.491252893475;11413.486393112496;11656;11718.23831450953 05:35:14 INFO - PROCESS | 1998 | |3;mootools.html;1524.725549401108;1534.6010037390279;1763.5062182588872;1880.3418803418806;1895.914683839227;7812.570308633023;8336.541490218036;8494;8711.390202685807;8734.737957861267;8427.83144337113;8475.957620211906;8507.234348908598;8550.444221125623;8569.01456332522;2372.5729368713623;2394.1979436888664;2396.4847557775074;2405.482821193443;2417.6857008588945;2399.9880000599974;2405.9759402406016;2442.804575633954;2452.8896199670967;2456.1403508771964;2399.328188107324;2442.7068751749816;2464.3223113643803;2464.4208610976407;2466.642336861154;2421.3583400398907;2431.817613678981;2453.9386515337083;2456.8403053801535;2464.4578192797558;2430.21018169094;2445.3397582652583;2446.8654224017673;2447.877606119687;2448.4490989527394;8643.611037503264;8676.566171691453;8676.8698469523;8711.651533938635;8722.476651400937;5290.259363689087;5384.219288203189;5431.891362172774;5442.836714898559;5479.506844384025;3530.6292839251764;3620.945685814715;3632.2735452909524;3674.026383008505;3678.668919797231;1051.4059556350637;1076.7523469602036;1077.380506208933;1080.222239987208;1083.8211695070304;9712.61149554017;11597.188196826226;11691.181617286793;11691.94154029233;11727.589534366256;4819.445763737145;4822.132016237111;4901.142300097468;4910;4917.6311776616185;10019.348742331726;10034.24743144267;10049.799004020026;10057.64798232073;10082.747931301776;5368.731563421891;5393.83818485446;5447.1829225616475;5453.836384908459;5460.863478412992;4376.343548467692;4785.994941062416;4902.779374928065;4905.852824415273;4912.557869791736;3912.882613521599;3924.274009308287;3952.604739526082;3988.082740969593;4009.3785463253244;1100.6918062942389;1278.8465384153776;1289.7033682253134;1297.6245180109115;1301.1672529581076;1041.6354276003337;1044.519521020324;1054.6045233037612;1210.431097384228;1380.2477649680948;8043.477173983672;8048.5170889746805;8067.475614085066;8077.232662897015;8130.471519351223;517.317141373391;520.573130033369;526.3263023330144;526.3762441506826;526.531387065512;6170.5372097092895;6187.319394866561;6237.438630523275;6246.437820596168;6248.718807653667;10254.436006019741;10578.10086142671;10606.310589811637;10637.308574942605;10648.414337211529;8675.652973880975;10206.795864082676;10476.738081548023;10480.842787358195;10538.578456861793;8208.794780130545;8244.876326855101;8276.462029968034;8284.171582841787;8352.540610266373;6530.346965303432;7833.804154896173;7838.451308408356;7862.253085956825;7965.163657815846;9212.815743685223;9298.72103836886;9398.765030874283;9478.57346419399;9590.904090959;9466.432014079177;9645.37305075168;9735.150321439187;9823.508824558601;9850;6784.728610855708;7168.247334029852;7376.889346659697;7417.147028091623;7530;8124.025116985999;8130.552819594979;8147.9185208147155;8183.427160098736;8197.344212463107;7185.101862267216;7273.309035641606;7323.560586364835;7385.335319821242;7486.101667799899;7096.716131354688;7112.50212485121;7128.643567821485;7241.131064272321;7315.414766818535;6639.236487803964;7703.576303303372;7716.729914453192;7720.498167619086;7796.571188584682;6865.0732151160955;6894.896576551256;6968.651567421507;6976.093107895941;6976.895346569907;6952.026716259828;6971.58170509771;7023.157221133497;7038.190608080136;7075.964620176866 05:35:14 INFO - PROCESS | 1998 | |4;prototype.html;320.9053329267866;325.4093819717215;327.1363600095748;330.4349562248556;332.55769826131245;6883.105196324477;7015.473839462035;7035.718571257156;7040.507164498475;7080.681369338379;6845.486588505857;6870.519063665545;6897.275786042468;6898.896516552243;6906.896396554056;4799.832005879794;4888.340074090006;4989.426215985171;4992.725400103011;5051.873703157414;4997.925446029103;5018.623603229754;5023.799048038074;5030.496950304959;5035;4923.236898280772;4943.777530011158;4963.900721985558;4969.751512424365;4981.850544483653;4514.796834142471;4863.686804562783;4984.825531106412;5011.699298042111;5036.043151801146;4290.892727681801;4293.098449325646;4297.935530967038;4301.72038817479;4306.0526684129445;6357.268914074848;6609.206895172562;6620;6633.535652504326;6648.634325112117;5829.621074630178;5848.561357898175;5899.233099697055;5899.675517846516;5916.911246331309;7422.369098626623;7423.220561841037;7425.774747166711;7441.627918604102;7452.205422966387;4671.85984420468;4680.712803978899;4685.500639795267;4686.015936653307;4702.200625893572;7212.003872216869;7777.688892444296;7863.37093032556;7867.9606601966625;7873.370130389612;4546.272596384562;4616.330632058332;4725.858224253209;4733.881652958704;4735.715857048519;4802.615790736732;4815.95184048155;4819.734914579732;4821.132196204647;4827;4917.532834380728;5306.495882891119;5778.7688492460675;5786.363500014995;5807.01280782268;7331.156916954512;7340.192578816326;7363.410927125817;7363.77908662741;7396.630168491554;1586.5874872533225;1627.8372162783864;1638.6394993101499;1661.8338166183528;1676.0195285757725;1050.6847945616285;1066.818640831045;1078.0836289154313;1078.9892101079047;1079.185215162563;6217.253929528486;6501.284858665543;6952.261934516371;6961.060256865258;6994.8950765738555;7642.5032372895585;7662.463627546018;7666.923330766621;7671.654775535114;7688.346490548366;6921.377076063179;6940.757073502403;6940.930590694028;6949.617771022541;6954.374106330454;3333.9166520837175;3726.2174943262216;4026.879193624196;4039.4546736190828;4075.3683179107284;7969.800754981055;8006.319462845607;8135.918640813635;8154.592270386457;8174.38692098095;7184.634919365304;7371.631418429057;8038.196180381915;8038.276555110068;8109.432339736162;6520.445762110274;8090.676372945251;8115.959420202979;8119.959400203079;8142.145074767182;7493.478065309296;7768.300852923038;7796.883046754417;7834.960825195838;7851.764447066369;7605.429592780453;7648.34989025939;7649.235076492307;7663.693452261847;7665.19515450892;8092.393070519617;8102.189781021851;8113.8377232456205;8134.918650813416;8135.349172066339;4126.979365103155;4788.688735232199;4795.304680821192;4813.374261346003;4825.831095911626;5680.460356266148;5725.969325521446;5916.437938395846;6321.988481842883;7678.69285228607;6140.447359737466;7353.448491363062;7388.1503627083575;7462.44031697614;7467.813304667427;6152.569320147547;7265.9273407267365;7448.031755871702;7455.739049133254;7474.5888976106835;6743.460523158037;7017.947307903855;7203.531770435115;7225.385842203262;7262.201157872735;7141.178764441948;7412.518186317872;7448.404127669882;7480.812979675552;7519.1728909818785;7231.385332246818;7268.418526517971;7273.890891636735;7275.381592564691;7280.089988751406 05:35:14 INFO - PROCESS | 1998 | |5;yui.html;669.5380187670507;677.766465033639;720.2149656874006;738.8005238585582;742.1391186223981;14690.26548672566;14735.705285894275;14874.181919994397;14911.95616306859;15136.01615894966;13627.386767595457;13804.309784510784;13807.171569705824;13844.169349839016;13846.169229846191;846.128487657712;858.9398742088056;862.3360012790148;865.3077537969599;866.9046404895456;701.169114599199;802.6789284286274;854.6325080215505;882.8322618702458;884.0408157149501;905.3933864310894;914.8947870994821;917.1241464401514;919.6827094652334;920.5213289089669;899.1727610598265;908.27791905435;908.6592527802075;908.8136931928939;911.3757076402685;577.7082573300498;665.7503436211421;666.094112007674;674.5547938360708;678.3047376439189;14398.856011439857;14472.98689091764;14504.202268875208;14522.983391162623;14538.927305363406;11368.431578421047;12573.622791316184;12618.81071783924;12729.872701272961;13028.804567931395;9329.953350233272;9477.668281610111;10142.340747851365;10189.796204075878;10204.540795664212;3101.875924962999;3532.7703699259464;3617.3850445424077;3635.4546817977252;3636.7636103653176;68297.60958366434;71615.28384716138;71960.6401967992;74747.62626186889;77196;9433.433993960385;9494.667686630935;9668.661596844217;9755.512224388753;10388.013138751807;21515.56968860614;21827.23604673829;21851.78148218529;21865.12539498402;21871.562568748537;7315.195328513859;7542.811429714301;7560.168381478033;7701.653425595861;7794.454388192772;4097.713160078825;4106.67146628269;4131.772752498581;4134.896627584274;4149.813258403379;3637.94543081854;3673.045008297862;3673.81630918453;3675.7978311192605;3682;656.9047488114197;663.9269680335159;667.6227931218846;670.128832517725;677.0555075669512;568.6247076929207;590.8906852232351;592.2508027345411;598.8113744170572;616.4328817487922;8052.315553178046;8244.505329680238;8314.127016663284;8384.161583841567;8499.532525711145;523.2047288122109;577.4485366475006;577.6678409914316;619.7056398210904;622.2129006806393;3865.6520913117956;3873.24471728016;3889.572147063821;3929.5284565851707;3945.2504024235304;64033.679831600544;83393.16606833975;83468;83810;83967;75178.62410687911;78971.42057158824;79094;79604;80223.99440014047;68180;68792.31207687959;69816.30183698199;70439;71054;7788.688452462065;7797.688092476465;7856.7250146244605;7889.092754333095;7937.126916039116;37168;40754;50334;50524.24213636725;51703.48296517137;62171.37828621656;62803.37196627975;66985.66507167433;68056.6597167011;69098;10138.797224055625;10153.187744980236;10220.948895255477;10495.52770125331;10622.415767132881;10841.512131953923;10892.564297428331;10957.56169753201;11021.173411993972;11856.438709038082;10436;10749.462526873782;10800.945995269973;11085.390303533382;11089.22375433712;10213.74465638365;10620.52207650642;10641.201909856636;10642.8403573948;10738.624148154777;10058.29591928558;10258.28192026551;10302.948485257526;10486;10604.257701960789;8822.735317940473;8852.867206991772;8908.55457227149;9028.503432311287;9072.95463522678;7252.057232559733;8902.287816974756;8947.239484643878;8993.910060899307;9125 05:35:14 INFO - PROCESS | 1998 | __end_tp_report 05:35:14 INFO - PROCESS | 1998 | __start_cc_report 05:35:14 INFO - PROCESS | 1998 | _x_x_mozilla_cycle_collect,341 05:35:14 INFO - PROCESS | 1998 | __end_cc_report 05:35:14 INFO - PROCESS | 1998 | __startTimestamp1456493714711__endTimestamp 05:35:14 INFO - PROCESS | 1998 | 05:35:14 INFO - PROCESS | 1998 | ------- Summary: start ------- 05:35:14 INFO - PROCESS | 1998 | Number of tests: 6 05:35:14 INFO - PROCESS | 1998 | 05:35:14 INFO - PROCESS | 1998 | [#0] dojo.html Cycles:165 Average:5655.95 Median:5914.73 stddev:675.99 (11.4%) stddev-sans-first:655.60 05:35:14 INFO - PROCESS | 1998 | Values: 3453.2 3466.5 3499.8 3520.4 3533.3 4334.7 5303.5 5655.0 5661.2 5666.5 5553.8 5636.0 5681.9 5692.4 5798.2 4183.2 5141.3 5145.8 5173.8 5293.7 5170.0 5183.1 5191.5 5229.7 5234.6 5102.4 5132.3 5166.5 5203.3 5209.4 5151.9 5161.5 5173.4 5177.6 5215.1 4977.3 5127.3 5151.9 5156.3 5179.4 5456.7 5518.1 5582.6 5602.4 5633.8 6100.2 6132.6 6160.6 6178.8 6210.5 6108.4 6178.1 6221.3 6251.5 6268.3 5682.7 5752.4 5767.0 5772.0 5784.3 6256.1 6257.3 6259.2 6267.4 6274.7 5841.4 5921.7 5957.5 6011.3 6114.0 6112.0 6136.7 6170.8 6175.4 6201.0 6147.1 6170.4 6192.1 6194.2 6240.4 6028.5 6216.7 6218.8 6219.9 6221.8 3786.2 4475.3 4816.8 4893.5 4926.9 3885.4 4024.6 4346.5 4361.9 4387.6 4790.9 5668.8 5676.6 5712.9 5768.8 5619.4 6087.1 6158.0 6231.3 6275.7 4785.3 5803.0 5812.9 5820.2 5829.8 4647.3 5325.3 5374.3 5381.1 5390.8 5581.3 6050.0 6259.7 6272.1 6299.8 6225.2 6233.9 6263.9 6264.8 6282.7 6171.8 6203.6 6218.3 6252.7 6298.0 6062.5 6094.7 6137.0 6159.2 6177.1 6213.0 6218.9 6272.7 6280.4 6316.4 5646.8 5944.0 6031.7 6127.4 6170.2 6081.8 6094.9 6111.7 6112.9 6136.7 5719.8 5908.3 5914.7 5926.9 5940.4 5942.1 5982.7 6021.8 6052.6 6067.4 5841.6 5924.8 5925.5 5936.6 5937.2 05:35:14 INFO - PROCESS | 1998 | 05:35:14 INFO - PROCESS | 1998 | [#1] ext.html Cycles:180 Average:61747.09 Median:36479.23 stddev:132187.26 (362.4%) stddev-sans-first:132477.86 05:35:14 INFO - PROCESS | 1998 | Values: 411.3 458.8 504.0 556.6 591.4 35000.6 35478.8 35527.1 35575.0 35591.9 36717.6 36763.0 37279.4 37349.4 37390.6 9256.4 9415.8 9452.6 9471.2 9479.8 9339.3 9464.0 9544.9 9615.7 9632.3 8893.6 9032.9 9542.7 9585.5 9596.6 9498.8 9510.7 9525.7 9610.4 9618.4 9345.0 9416.6 9471.7 9489.9 9502.6 36252.9 36354.0 36604.5 36687.0 36822.0 3039.4 3107.0 3270.7 3270.9 3321.7 27104.0 27343.0 27495.7 27659.9 27716.7 2450.3 2757.9 2760.6 2771.1 2793.0 444930.0 465890.0 466127.0 467521.0 470269.0 42966.1 58057.1 58253.7 58290.7 58338.7 34972.8 42597.4 42621.8 42913.1 42964.1 14841.5 14989.5 15228.5 15237.9 15265.5 9465.8 11284.0 11426.5 11478.0 11503.2 13870.3 14051.4 14086.7 14115.9 14237.9 5129.3 5246.5 6248.1 6267.1 6287.5 935.4 976.0 981.3 983.7 998.7 28585.4 28614.0 29110.1 29157.6 29422.3 997.2 1046.6 1097.8 1157.8 1230.3 12425.9 13875.9 14526.6 14703.3 14840.8 518482.0 524500.0 528923.0 529985.0 530825.0 53974.5 54402.7 54554.6 55094.2 55110.4 1392.2 1410.0 1425.6 1430.8 1435.1 28235.9 28240.9 28510.0 28843.6 29249.6 46642.0 46758.3 46831.8 46928.0 47272.8 491517.0 494284.0 496937.0 497908.0 498597.5 31653.0 31815.0 31874.5 32068.4 32374.2 41832.0 42272.4 42415.9 43134.0 43299.0 30742.0 30766.2 35712.3 35754.9 35910.0 32381.8 35527.1 35627.0 35870.8 36049.5 30108.0 31162.0 31605.4 33198.8 35774.9 25270.9 28274.2 29355.3 30116.6 30358.4 23282.0 23640.3 23708.5 23967.0 24140.4 05:35:14 INFO - PROCESS | 1998 | 05:35:14 INFO - PROCESS | 1998 | [#2] jquery.html Cycles:180 Average:33407.84 Median:28380.86 stddev:94326.74 (332.4%) stddev-sans-first:94558.58 05:35:14 INFO - PROCESS | 1998 | Values: 293.6 350.3 354.9 356.9 366.8 15519.8 19353.0 19481.3 19497.4 20321.5 19732.3 19957.6 20473.6 20695.0 20786.3 5547.8 5679.7 5737.0 5803.4 5863.5 5703.9 5747.6 7025.8 7289.6 7344.1 7161.0 7292.4 7347.9 7746.7 7772.7 6536.5 7552.6 7604.5 7648.5 7660.0 6670.1 6910.1 6972.6 6972.9 6986.2 21784.5 26260.7 26514.1 26957.7 27399.0 2188.4 2216.2 2351.3 2639.6 2687.6 14758.1 15303.8 15591.4 15935.8 16249.8 1762.4 1828.2 1829.8 1836.0 1853.6 94281.5 97461.5 98088.0 98540.0 115622.0 17468.8 18673.9 19406.5 19715.4 19729.5 12902.2 13150.7 28286.6 28291.4 28470.3 8342.7 8511.5 8579.8 8647.2 8658.5 8853.8 8898.2 8947.9 9013.8 9039.4 4474.4 4487.5 4528.9 4544.8 4564.7 1856.7 1914.5 1930.5 1934.7 1936.2 770.5 902.9 970.5 1045.2 1049.3 18530.7 19755.8 20517.5 20596.7 20760.2 918.3 919.5 941.4 1004.3 1033.9 9071.7 10761.8 10981.1 11024.9 11062.6 485041.0 513119.0 523582.0 642374.0 657020.0 86099.6 114230.0 123194.0 127690.4 128361.0 983.8 1018.1 1044.4 1083.2 1092.1 18484.0 18822.5 18917.0 18949.4 18967.0 40052.8 48942.5 50758.7 52937.5 53672.0 54475.1 66365.0 67682.7 69628.6 70033.6 6476.9 7729.6 8067.9 8112.2 8118.0 5661.7 9666.0 10858.9 11033.0 11862.8 10903.8 11467.4 11572.7 11694.8 11847.8 9427.3 11106.8 11232.0 11482.7 11551.2 9235.6 9832.1 11663.5 11787.5 12100.3 7003.2 7766.0 8036.3 8087.6 8091.2 10782.4 11305.5 11413.5 11656.0 11718.2 05:35:14 INFO - PROCESS | 1998 | 05:35:14 INFO - PROCESS | 1998 | [#3] mootools.html Cycles:180 Average:5949.14 Median:5389.03 stddev:3123.51 (58.0%) stddev-sans-first:3114.57 05:35:14 INFO - PROCESS | 1998 | Values: 1524.7 1534.6 1763.5 1880.3 1895.9 7812.6 8336.5 8494.0 8711.4 8734.7 8427.8 8476.0 8507.2 8550.4 8569.0 2372.6 2394.2 2396.5 2405.5 2417.7 2400.0 2406.0 2442.8 2452.9 2456.1 2399.3 2442.7 2464.3 2464.4 2466.6 2421.4 2431.8 2453.9 2456.8 2464.5 2430.2 2445.3 2446.9 2447.9 2448.4 8643.6 8676.6 8676.9 8711.7 8722.5 5290.3 5384.2 5431.9 5442.8 5479.5 3530.6 3620.9 3632.3 3674.0 3678.7 1051.4 1076.8 1077.4 1080.2 1083.8 9712.6 11597.2 11691.2 11691.9 11727.6 4819.4 4822.1 4901.1 4910.0 4917.6 10019.3 10034.2 10049.8 10057.6 10082.7 5368.7 5393.8 5447.2 5453.8 5460.9 4376.3 4786.0 4902.8 4905.9 4912.6 3912.9 3924.3 3952.6 3988.1 4009.4 1100.7 1278.8 1289.7 1297.6 1301.2 1041.6 1044.5 1054.6 1210.4 1380.2 8043.5 8048.5 8067.5 8077.2 8130.5 517.3 520.6 526.3 526.4 526.5 6170.5 6187.3 6237.4 6246.4 6248.7 10254.4 10578.1 10606.3 10637.3 10648.4 8675.7 10206.8 10476.7 10480.8 10538.6 8208.8 8244.9 8276.5 8284.2 8352.5 6530.3 7833.8 7838.5 7862.3 7965.2 9212.8 9298.7 9398.8 9478.6 9590.9 9466.4 9645.4 9735.2 9823.5 9850.0 6784.7 7168.2 7376.9 7417.1 7530.0 8124.0 8130.6 8147.9 8183.4 8197.3 7185.1 7273.3 7323.6 7385.3 7486.1 7096.7 7112.5 7128.6 7241.1 7315.4 6639.2 7703.6 7716.7 7720.5 7796.6 6865.1 6894.9 6968.7 6976.1 6976.9 6952.0 6971.6 7023.2 7038.2 7076.0 05:35:14 INFO - PROCESS | 1998 | 05:35:14 INFO - PROCESS | 1998 | [#4] prototype.html Cycles:180 Average:5972.86 Median:6858.00 stddev:1964.59 (28.6%) stddev-sans-first:1923.75 05:35:14 INFO - PROCESS | 1998 | Values: 320.9 325.4 327.1 330.4 332.6 6883.1 7015.5 7035.7 7040.5 7080.7 6845.5 6870.5 6897.3 6898.9 6906.9 4799.8 4888.3 4989.4 4992.7 5051.9 4997.9 5018.6 5023.8 5030.5 5035.0 4923.2 4943.8 4963.9 4969.8 4981.9 4514.8 4863.7 4984.8 5011.7 5036.0 4290.9 4293.1 4297.9 4301.7 4306.1 6357.3 6609.2 6620.0 6633.5 6648.6 5829.6 5848.6 5899.2 5899.7 5916.9 7422.4 7423.2 7425.8 7441.6 7452.2 4671.9 4680.7 4685.5 4686.0 4702.2 7212.0 7777.7 7863.4 7868.0 7873.4 4546.3 4616.3 4725.9 4733.9 4735.7 4802.6 4816.0 4819.7 4821.1 4827.0 4917.5 5306.5 5778.8 5786.4 5807.0 7331.2 7340.2 7363.4 7363.8 7396.6 1586.6 1627.8 1638.6 1661.8 1676.0 1050.7 1066.8 1078.1 1079.0 1079.2 6217.3 6501.3 6952.3 6961.1 6994.9 7642.5 7662.5 7666.9 7671.7 7688.3 6921.4 6940.8 6940.9 6949.6 6954.4 3333.9 3726.2 4026.9 4039.5 4075.4 7969.8 8006.3 8135.9 8154.6 8174.4 7184.6 7371.6 8038.2 8038.3 8109.4 6520.4 8090.7 8116.0 8120.0 8142.1 7493.5 7768.3 7796.9 7835.0 7851.8 7605.4 7648.3 7649.2 7663.7 7665.2 8092.4 8102.2 8113.8 8134.9 8135.3 4127.0 4788.7 4795.3 4813.4 4825.8 5680.5 5726.0 5916.4 6322.0 7678.7 6140.4 7353.4 7388.2 7462.4 7467.8 6152.6 7265.9 7448.0 7455.7 7474.6 6743.5 7017.9 7203.5 7225.4 7262.2 7141.2 7412.5 7448.4 7480.8 7519.2 7231.4 7268.4 7273.9 7275.4 7280.1 05:35:14 INFO - PROCESS | 1998 | 05:35:14 INFO - PROCESS | 1998 | [#5] yui.html Cycles:180 Average:17392.04 Median:31712.79 stddev:24097.01 (76.0%) stddev-sans-first:24131.89 05:35:14 INFO - PROCESS | 1998 | Values: 669.5 677.8 720.2 738.8 742.1 14690.3 14735.7 14874.2 14912.0 15136.0 13627.4 13804.3 13807.2 13844.2 13846.2 846.1 858.9 862.3 865.3 866.9 701.2 802.7 854.6 882.8 884.0 905.4 914.9 917.1 919.7 920.5 899.2 908.3 908.7 908.8 911.4 577.7 665.8 666.1 674.6 678.3 14398.9 14473.0 14504.2 14523.0 14538.9 11368.4 12573.6 12618.8 12729.9 13028.8 9330.0 9477.7 10142.3 10189.8 10204.5 3101.9 3532.8 3617.4 3635.5 3636.8 68297.6 71615.3 71960.6 74747.6 77196.0 9433.4 9494.7 9668.7 9755.5 10388.0 21515.6 21827.2 21851.8 21865.1 21871.6 7315.2 7542.8 7560.2 7701.7 7794.5 4097.7 4106.7 4131.8 4134.9 4149.8 3637.9 3673.0 3673.8 3675.8 3682.0 656.9 663.9 667.6 670.1 677.1 568.6 590.9 592.3 598.8 616.4 8052.3 8244.5 8314.1 8384.2 8499.5 523.2 577.4 577.7 619.7 622.2 3865.7 3873.2 3889.6 3929.5 3945.3 64033.7 83393.2 83468.0 83810.0 83967.0 75178.6 78971.4 79094.0 79604.0 80224.0 68180.0 68792.3 69816.3 70439.0 71054.0 7788.7 7797.7 7856.7 7889.1 7937.1 37168.0 40754.0 50334.0 50524.2 51703.5 62171.4 62803.4 66985.7 68056.7 69098.0 10138.8 10153.2 10220.9 10495.5 10622.4 10841.5 10892.6 10957.6 11021.2 11856.4 10436.0 10749.5 10800.9 11085.4 11089.2 10213.7 10620.5 10641.2 10642.8 10738.6 10058.3 10258.3 10302.9 10486.0 10604.3 8822.7 8852.9 8908.6 9028.5 9073.0 7252.1 8902.3 8947.2 8993.9 9125.0 05:35:14 INFO - PROCESS | 1998 | -------- Summary: end -------- 05:35:14 INFO - PROCESS | 1998 | 05:35:15 INFO - TEST-INFO | 1998: exit 0 05:35:15 INFO - TEST-OK | dromaeo_css | took 1110831ms 05:35:15 INFO - TEST-START | kraken 05:35:15 INFO - operating with platform_type : mac_ 05:35:15 INFO - Initialising browser for kraken test... 05:35:15 INFO - TEST-INFO | started process 2004 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmpNMeeHn/profile http://localhost:50544/getInfo.html) 05:35:18 INFO - PROCESS | 2004 | __metrics Screen width/height:1600/1200 05:35:18 INFO - PROCESS | 2004 | colorDepth:24 05:35:18 INFO - PROCESS | 2004 | Browser inner width/height: 1024/689 05:35:18 INFO - PROCESS | 2004 | __metrics 05:35:18 ERROR - PROCESS | 2004 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 05:35:18 INFO - TEST-INFO | 2004: exit 0 05:35:18 INFO - Browser initialized. 05:35:18 INFO - Running cycle 1/1 for kraken test... 05:35:18 INFO - TEST-INFO | started process 2008 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmpNMeeHn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:35:30 INFO - PROCESS | 2008 | RSS: Main: 256135168 05:35:30 INFO - PROCESS | 2008 | 05:35:33 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:50544/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50544/tests/kraken/driver.html?testName=audio-beat-detection) 05:35:34 INFO - PROCESS | 2008 | RSS: Main: 269459456 05:35:34 INFO - PROCESS | 2008 | 05:35:37 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:50544/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50544/tests/kraken/driver.html?testName=audio-dft) 05:35:37 INFO - PROCESS | 2008 | RSS: Main: 276836352 05:35:37 INFO - PROCESS | 2008 | 05:35:41 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:50544/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50544/tests/kraken/driver.html?testName=audio-fft) 05:35:41 INFO - PROCESS | 2008 | RSS: Main: 281133056 05:35:41 INFO - PROCESS | 2008 | 05:35:43 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:50544/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50544/tests/kraken/driver.html?testName=audio-oscillator) 05:35:44 INFO - PROCESS | 2008 | RSS: Main: 282193920 05:35:44 INFO - PROCESS | 2008 | 05:35:46 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:50544/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50544/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:35:46 INFO - PROCESS | 2008 | RSS: Main: 282763264 05:35:46 INFO - PROCESS | 2008 | 05:35:49 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:50544/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50544/tests/kraken/driver.html?testName=imaging-darkroom) 05:35:50 INFO - PROCESS | 2008 | RSS: Main: 282206208 05:35:50 INFO - PROCESS | 2008 | 05:35:53 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:50544/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50544/tests/kraken/driver.html?testName=imaging-desaturate) 05:35:53 INFO - PROCESS | 2008 | RSS: Main: 283209728 05:35:53 INFO - PROCESS | 2008 | 05:35:56 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:50544/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50544/tests/kraken/driver.html?testName=json-parse-financial) 05:35:57 INFO - PROCESS | 2008 | RSS: Main: 283516928 05:35:57 INFO - PROCESS | 2008 | 05:35:58 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:50544/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50544/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:35:59 INFO - PROCESS | 2008 | RSS: Main: 284151808 05:35:59 INFO - PROCESS | 2008 | 05:36:01 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:50544/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50544/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:36:01 INFO - PROCESS | 2008 | RSS: Main: 282759168 05:36:01 INFO - PROCESS | 2008 | 05:36:04 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:50544/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50544/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:36:04 INFO - PROCESS | 2008 | RSS: Main: 285020160 05:36:04 INFO - PROCESS | 2008 | 05:36:07 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:50544/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50544/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:36:07 INFO - PROCESS | 2008 | RSS: Main: 284577792 05:36:07 INFO - PROCESS | 2008 | 05:36:10 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:50544/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50544/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:36:11 INFO - PROCESS | 2008 | RSS: Main: 283254784 05:36:11 INFO - PROCESS | 2008 | 05:36:12 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:50544/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50544/tests/kraken/driver.html?testName=ai-astar) 05:36:13 INFO - PROCESS | 2008 | RSS: Main: 284733440 05:36:13 INFO - PROCESS | 2008 | 05:36:13 INFO - PROCESS | 2008 | __start_tp_report 05:36:13 INFO - PROCESS | 2008 | _x_x_mozilla_page_load 05:36:13 INFO - PROCESS | 2008 | _x_x_mozilla_page_load_details 05:36:13 INFO - PROCESS | 2008 | |i|pagename|runs| 05:36:13 INFO - PROCESS | 2008 | |0;ai-astar;168;96;169;170;169;161;110;151;166;113 05:36:13 INFO - PROCESS | 2008 | |1;audio-beat-detection;155;124;144;154;123;164;171;155;163;122 05:36:13 INFO - PROCESS | 2008 | |2;audio-dft;192;196;199;219;286;281;196;194;198;194 05:36:13 INFO - PROCESS | 2008 | |3;audio-fft;71;82;72;125;57;61;58;60;89;56 05:36:13 INFO - PROCESS | 2008 | |4;audio-oscillator;83;82;127;79;83;81;121;79;82;120 05:36:13 INFO - PROCESS | 2008 | |5;imaging-gaussian-blur;87;92;111;93;86;91;85;93;86;92 05:36:13 INFO - PROCESS | 2008 | |6;imaging-darkroom;95;95;95;94;95;96;95;95;122;152 05:36:13 INFO - PROCESS | 2008 | |7;imaging-desaturate;142;150;92;130;113;151;149;106;94;93 05:36:13 INFO - PROCESS | 2008 | |8;json-parse-financial;58;56;57;57;55;59;57;64;57;55 05:36:13 INFO - PROCESS | 2008 | |9;json-stringify-tinderbox;71;66;77;82;71;71;67;69;69;69 05:36:13 INFO - PROCESS | 2008 | |10;stanford-crypto-aes;87;84;90;86;84;83;87;77;100;100 05:36:13 INFO - PROCESS | 2008 | |11;stanford-crypto-ccm;126;136;134;118;131;129;131;135;123;129 05:36:13 INFO - PROCESS | 2008 | |12;stanford-crypto-pbkdf2;129;139;132;142;135;173;141;139;142;143 05:36:13 INFO - PROCESS | 2008 | |13;stanford-crypto-sha256-iterative;69;67;69;65;70;77;94;95;95;99 05:36:13 INFO - PROCESS | 2008 | __end_tp_report 05:36:13 INFO - PROCESS | 2008 | __start_cc_report 05:36:13 INFO - PROCESS | 2008 | _x_x_mozilla_cycle_collect,891 05:36:13 INFO - PROCESS | 2008 | __end_cc_report 05:36:13 INFO - PROCESS | 2008 | __startTimestamp1456493773081__endTimestamp 05:36:13 INFO - PROCESS | 2008 | 05:36:13 INFO - PROCESS | 2008 | ------- Summary: start ------- 05:36:13 INFO - PROCESS | 2008 | Number of tests: 14 05:36:13 INFO - PROCESS | 2008 | 05:36:13 INFO - PROCESS | 2008 | [#0] ai-astar Cycles:10 Average:147.30 Median:168.50 stddev:29.13 (17.3%) stddev-sans-first:29.92 05:36:13 INFO - PROCESS | 2008 | Values: 168.0 96.0 169.0 170.0 169.0 161.0 110.0 151.0 166.0 113.0 05:36:13 INFO - PROCESS | 2008 | 05:36:13 INFO - PROCESS | 2008 | [#1] audio-beat-detection Cycles:10 Average:147.50 Median:155.00 stddev:18.36 (11.8%) stddev-sans-first:19.27 05:36:13 INFO - PROCESS | 2008 | Values: 155.0 124.0 144.0 154.0 123.0 164.0 171.0 155.0 163.0 122.0 05:36:13 INFO - PROCESS | 2008 | 05:36:13 INFO - PROCESS | 2008 | [#2] audio-dft Cycles:10 Average:215.50 Median:198.50 stddev:36.65 (18.5%) stddev-sans-first:37.87 05:36:13 INFO - PROCESS | 2008 | Values: 192.0 196.0 199.0 219.0 286.0 281.0 196.0 194.0 198.0 194.0 05:36:13 INFO - PROCESS | 2008 | 05:36:13 INFO - PROCESS | 2008 | [#3] audio-fft Cycles:10 Average:73.10 Median:66.00 stddev:21.42 (32.5%) stddev-sans-first:22.70 05:36:13 INFO - PROCESS | 2008 | Values: 71.0 82.0 72.0 125.0 57.0 61.0 58.0 60.0 89.0 56.0 05:36:13 INFO - PROCESS | 2008 | 05:36:13 INFO - PROCESS | 2008 | [#4] audio-oscillator Cycles:10 Average:93.70 Median:81.50 stddev:20.12 (24.7%) stddev-sans-first:20.96 05:36:13 INFO - PROCESS | 2008 | Values: 83.0 82.0 127.0 79.0 83.0 81.0 121.0 79.0 82.0 120.0 05:36:13 INFO - PROCESS | 2008 | 05:36:13 INFO - PROCESS | 2008 | [#5] imaging-gaussian-blur Cycles:10 Average:91.60 Median:91.50 stddev:7.52 (8.2%) stddev-sans-first:7.79 05:36:13 INFO - PROCESS | 2008 | Values: 87.0 92.0 111.0 93.0 86.0 91.0 85.0 93.0 86.0 92.0 05:36:13 INFO - PROCESS | 2008 | 05:36:13 INFO - PROCESS | 2008 | [#6] imaging-darkroom Cycles:10 Average:103.40 Median:95.00 stddev:19.07 (20.1%) stddev-sans-first:19.99 05:36:13 INFO - PROCESS | 2008 | Values: 95.0 95.0 95.0 94.0 95.0 96.0 95.0 95.0 122.0 152.0 05:36:13 INFO - PROCESS | 2008 | 05:36:13 INFO - PROCESS | 2008 | [#7] imaging-desaturate Cycles:10 Average:122.00 Median:150.50 stddev:25.12 (16.7%) stddev-sans-first:25.58 05:36:13 INFO - PROCESS | 2008 | Values: 142.0 150.0 92.0 130.0 113.0 151.0 149.0 106.0 94.0 93.0 05:36:13 INFO - PROCESS | 2008 | 05:36:13 INFO - PROCESS | 2008 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:57.00 stddev:2.59 (4.5%) stddev-sans-first:2.74 05:36:13 INFO - PROCESS | 2008 | Values: 58.0 56.0 57.0 57.0 55.0 59.0 57.0 64.0 57.0 55.0 05:36:13 INFO - PROCESS | 2008 | 05:36:13 INFO - PROCESS | 2008 | [#9] json-stringify-tinderbox Cycles:10 Average:71.20 Median:71.00 stddev:4.83 (6.8%) stddev-sans-first:5.12 05:36:13 INFO - PROCESS | 2008 | Values: 71.0 66.0 77.0 82.0 71.0 71.0 67.0 69.0 69.0 69.0 05:36:13 INFO - PROCESS | 2008 | 05:36:13 INFO - PROCESS | 2008 | [#10] stanford-crypto-aes Cycles:10 Average:87.80 Median:85.00 stddev:7.27 (8.6%) stddev-sans-first:7.70 05:36:13 INFO - PROCESS | 2008 | Values: 87.0 84.0 90.0 86.0 84.0 83.0 87.0 77.0 100.0 100.0 05:36:13 INFO - PROCESS | 2008 | 05:36:13 INFO - PROCESS | 2008 | [#11] stanford-crypto-ccm Cycles:10 Average:129.20 Median:131.00 stddev:5.61 (4.3%) stddev-sans-first:5.83 05:36:13 INFO - PROCESS | 2008 | Values: 126.0 136.0 134.0 118.0 131.0 129.0 131.0 135.0 123.0 129.0 05:36:13 INFO - PROCESS | 2008 | 05:36:13 INFO - PROCESS | 2008 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.50 Median:141.50 stddev:12.00 (8.5%) stddev-sans-first:11.85 05:36:13 INFO - PROCESS | 2008 | Values: 129.0 139.0 132.0 142.0 135.0 173.0 141.0 139.0 142.0 143.0 05:36:13 INFO - PROCESS | 2008 | 05:36:13 INFO - PROCESS | 2008 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.00 Median:85.50 stddev:13.95 (16.3%) stddev-sans-first:14.22 05:36:13 INFO - PROCESS | 2008 | Values: 69.0 67.0 69.0 65.0 70.0 77.0 94.0 95.0 95.0 99.0 05:36:13 INFO - PROCESS | 2008 | -------- Summary: end -------- 05:36:13 INFO - PROCESS | 2008 | 05:36:13 INFO - TEST-INFO | 2008: exit 0 05:36:14 INFO - TEST-OK | kraken | took 58821ms 05:36:14 INFO - SUITE-END | took 1169s 05:36:14 INFO - Completed test suite (00:19:29) 05:36:14 INFO - Working with test: dromaeo_css 05:36:14 INFO - Generating results file: dromaeo_css 05:36:14 INFO - Working with test: kraken 05:36:14 INFO - Generating results file: kraken 05:36:14 INFO - javascript benchmark 05:36:14 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:36:14 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,61]] 05:36:14 INFO - process_Request line: dromaeo_css 7460.49 graph.html#tests=[[72,1,61]] 05:36:14 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:36:14 INFO - process_Request line: kraken 1561.30 graph.html#tests=[[232,1,61]] 05:36:14 INFO - RETURN: dromaeo_css: 7460.49 05:36:14 INFO - RETURN: kraken: 1561.30 05:36:14 INFO - javascript benchmark 05:36:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3453.1539772755677, 3466.532018177547, 3499.8250087495617, 3520.366334059869, 3533.2756784859107, 4334.7182433141825, 5303.469653034699, 5655.0386434306165, 5661.207430959664, 5666.546676265899, 5553.805616803413, 5635.971820140893, 5681.886362272752, 5692.430756924306, 5798.217240672508, 4183.2051910137125, 5141.254518094874, 5145.845624631248, 5173.793048278083, 5293.708846013467, 5170.0, 5183.144781111112, 5191.480851914797, 5229.686218826863, 5234.6335756497065, 5102.438731739506, 5132.3071385363055, 5166.535011848914, 5203.349581302337, 5209.374875015023, 5151.948480515184, 5161.483851614846, 5173.430922598511, 5177.611679124081, 5215.0873597120735, 4977.303177555145, 5127.282180494733, 5151.922721159186, 5156.252343410185, 5179.430262671103, 5456.699881506515, 5518.061929471959, 5582.609217354787, 5602.38373778884, 5633.80281690143, 6100.206973093514, 6132.570720049598, 6160.5687601867885, 6178.845528861814, 6210.472109870621, 6108.433136212286, 6178.10417489466, 6221.284552276501, 6251.499880009588, 6268.310485846553, 5682.659040457585, 5752.395998420147, 5766.971165144148, 5772.0, 5784.2769653793275, 6256.092866534327, 6257.342978987232, 6259.18630578031, 6267.40459656341, 6274.717637706314, 5841.357450680422, 5921.67430791302, 5957.49361304294, 6011.278646562353, 6113.969430152821, 6111.956402836248, 6136.662483563447, 6170.784022559279, 6175.3515880832765, 6201.0388389799655, 6147.139400483936, 6170.413810688067, 6192.071189321638, 6194.194754681953, 6240.375962403723, 6028.547858910511, 6216.720247588869, 6218.751249949952, 6219.937800621936, 6221.782237621662, 3786.2048969716116, 4475.328700694922, 4816.831410900601, 4893.510648935149, 4926.9014619707405, 3885.3977633466857, 4024.577419370924, 4346.521882592912, 4361.869143925687, 4387.561243875651, 4790.880227994328, 5668.829935101953, 5676.602637815313, 5712.885742285131, 5768.826935191951, 5619.353774315924, 6087.117367981707, 6157.983932651152, 6231.345708700612, 6275.6862156891975, 4785.282207668877, 5803.0, 5812.854678632983, 5820.243368362086, 5829.8251052468495, 4647.34937108805, 5325.307709997753, 5374.328208973879, 5381.1121165007335, 5390.757415916293, 5581.330240371181, 6049.969750151221, 6259.655718935503, 6272.090546870678, 6299.779507717391, 6225.190725205694, 6233.906491402723, 6263.906041409291, 6264.780732674334, 6282.685865706788, 6171.783987560414, 6203.565750397609, 6218.347073557392, 6252.718627661857, 6298.0, 6062.545309101747, 6094.714482069224, 6137.039921714347, 6159.19930409044, 6177.073438984188, 6213.0, 6218.906716399167, 6272.717727702173, 6280.403361680633, 6316.431521163117, 5646.774129034957, 5943.959807033665, 6031.668258245839, 6127.448529632355, 6170.228721409824, 6081.847953801013, 6094.939050609437, 6111.694415279129, 6112.908306375497, 6136.662483563447, 5719.771209151588, 5908.261467316585, 5914.7338369774325, 5926.851828704317, 5940.376260492586, 5942.078977758454, 5982.7307771149535, 6021.819345419644, 6052.576319657582, 6067.393260673897, 5841.649501029782, 5924.844655292177, 5925.466707996301, 5936.554758393051, 5937.168796368425], "unit": "score", "name": "dojo.html", "value": 5613.474635204356}, {"lowerIsBetter": false, "replicates": [411.32337305133075, 458.7752001519257, 503.96686792076247, 556.5575367582771, 591.449951545063, 35000.649993500054, 35478.75824346145, 35527.11182220446, 35575.0, 35591.93224203275, 36717.63282367175, 36763.0, 37279.440808387895, 37349.439758403576, 37390.626093739054, 9256.352055356128, 9415.81168376632, 9452.621895124186, 9471.194948429391, 9479.763005924839, 9339.3462457628, 9464.0, 9544.856827147598, 9615.66345177919, 9632.277579181555, 8893.644254229856, 9032.870891138607, 9542.713718588453, 9585.52072396381, 9596.616135354612, 9498.810023799555, 9510.714678559654, 9525.666601668978, 9610.423374597547, 9618.422894626345, 9345.01877302887, 9416.62333506659, 9471.715848524555, 9489.857652135224, 9502.619895204183, 36252.912412627666, 36354.0, 36604.450933236025, 36687.0, 36822.0, 3039.4377040247405, 3107.036818586223, 3270.656581058978, 3270.8528116234825, 3321.70104690579, 27104.0, 27343.0, 27495.725042749516, 27659.861700691366, 27716.72283277182, 2450.301664025762, 2757.8621068946472, 2760.5721113227482, 2771.057840334276, 2793.022442145233, 444929.99999999674, 465889.9999999966, 466127.0, 467521.0, 470269.0, 42966.14067718628, 58057.129143062884, 58253.70873145607, 58290.708546457, 58338.7083064582, 34972.825135874155, 42597.36103958443, 42621.78689106535, 42913.14173716571, 42964.14071718548, 14841.480548180762, 14989.475368362055, 15228.543143705707, 15237.923810381099, 15265.465708700141, 9465.810683786285, 11284.040856527286, 11426.542938282542, 11478.024367928652, 11503.19477636574, 13870.306484675726, 14051.367688454044, 14086.718265634834, 14115.941304402211, 14237.85762142386, 5129.281900533928, 5246.527812496817, 6248.094026366151, 6267.091271765568, 6287.49700023997, 935.3779736475168, 976.0, 981.2983716642635, 983.7048885334514, 998.7253505286104, 28585.428291434055, 28613.99851005205, 29110.12669619915, 29157.56263656047, 29422.264443389085, 997.2321312589265, 1046.6127532812757, 1097.7859317433183, 1157.8494795676509, 1230.3048777440717, 12425.875741242471, 13875.889928805671, 14526.636834079021, 14703.294945617514, 14840.777388339184, 518482.0, 524500.0, 528923.0, 529985.0, 530825.0, 53974.46025539773, 54402.72798636061, 54554.63613409697, 55094.173587396224, 55110.44889551053, 1392.1716578635696, 1409.9647508812361, 1425.6435891027243, 1430.8354539228121, 1435.067206315903, 28235.858820705766, 28240.85879570589, 28510.0, 28843.5673464894, 29249.561256581594, 46642.0, 46758.298625521325, 46831.76584117058, 46928.0, 47272.7636361816, 491517.0, 494284.0, 496937.0, 497908.0, 498597.5070124626, 31653.0, 31815.045548633578, 31874.52188217225, 32068.358632826745, 32374.190645233117, 41832.0, 42272.36591451192, 42415.93960151021, 43134.0, 43299.0, 30742.0, 30766.230844229074, 35712.28575428425, 35754.88818785769, 35910.0, 32381.838090809397, 35527.11182220362, 35627.0, 35870.8206458966, 36049.459258111674, 30108.0, 31162.0, 31605.36789264248, 33198.83804066846, 35774.926752197476, 25270.873645631655, 28274.151775446768, 29355.266118347212, 30116.647933058575, 30358.392832143676, 23282.0, 23640.29079127629, 23708.52582948297, 23967.0, 24140.39649008789], "unit": "score", "name": "ext.html", "value": 18275.777602415164}, {"lowerIsBetter": false, "replicates": [293.5816461542302, 350.3378614418749, 354.9105822505274, 356.88758041217017, 366.83492428407226, 15519.84480155198, 19353.032348382578, 19481.318153864617, 19497.415077547677, 20321.49196270094, 19732.309369172082, 19957.60084798303, 20473.590528189427, 20695.0, 20786.272480463187, 5547.805826796063, 5679.650913157672, 5736.971315143439, 5803.390643982384, 5863.5016023638045, 5703.914441283384, 5747.626404283729, 7025.789226323193, 7289.635518224094, 7344.081989751281, 7161.0, 7292.380147687453, 7347.88978165328, 7746.690132394726, 7772.650230739602, 6536.477081833442, 7552.5846078465665, 7604.5437273763755, 7648.502847314934, 7660.0, 6670.132882725263, 6910.101686780737, 6972.58164510126, 6972.895406568906, 6986.16166060076, 21784.455388615253, 26260.73739262602, 26514.072007479837, 26957.730422695717, 27399.0, 2188.420068681785, 2216.213244298267, 2351.271105957159, 2639.6436481075, 2687.5699888017825, 14758.11451312914, 15303.846961530353, 15591.37634494619, 15935.760963585555, 16249.781266405067, 1762.3567397899803, 1828.1590468384559, 1829.805228725651, 1836.036081057442, 1853.5644123630937, 94281.52859235728, 97461.51269243608, 98088.0, 98540.0, 115622.0, 17468.82531174672, 18673.90663046676, 19406.514837128903, 19715.40853774389, 19729.506762331057, 12902.161359511601, 13150.736985260433, 28286.575701364083, 28291.43417131687, 28470.288242793682, 8342.708005219789, 8511.489310641382, 8579.82840343202, 8647.178518040777, 8658.523781192094, 8853.822923541493, 8898.199162075314, 8947.910520894839, 9013.77465563353, 9039.367244292836, 4474.418325617649, 4487.506374298824, 4528.864134075983, 4544.818207271672, 4564.680472366969, 1856.6565185440736, 1914.5022294203607, 1930.4980705016517, 1934.7484826972684, 1936.244864502845, 770.4799260499141, 902.9051949545335, 970.4763521271536, 1045.2160879340495, 1049.3074570783247, 18530.722039169425, 19755.802441975684, 20517.487062823548, 20596.691049634268, 20760.169593216404, 918.3433844801, 919.544825311475, 941.4445477168366, 1004.322082594246, 1033.9172866170688, 9071.727848164566, 10761.78476430467, 10981.12151027916, 11024.944875275572, 11062.612808551663, 485041.0, 513119.0, 523582.0, 642374.0, 657020.0, 86099.5695021521, 114230.0, 123194.0, 127690.36154819353, 128361.0, 983.8376667849725, 1018.1447584029303, 1044.3890324160452, 1083.1713738989679, 1092.0990183098975, 18484.0, 18822.52943676419, 18917.0, 18949.43151705451, 18967.0, 40052.799736001136, 48942.51057489379, 50758.746206268734, 52937.47062529325, 53672.0, 54475.0933717318, 66365.0, 67682.66158669176, 69628.60742785217, 70033.64983175052, 6476.870462590816, 7729.613519323899, 8067.919320806717, 8112.22933821286, 8118.0, 5661.688607126647, 9665.951670241886, 10858.945705271422, 11033.007029367396, 11862.762744745229, 10903.781924361627, 11467.369294688871, 11572.6528204154, 11694.766104678029, 11847.76304473923, 9427.3400861939, 11106.777864442503, 11231.989120979151, 11482.655520334403, 11551.249168804, 9235.630574776933, 9832.065953734384, 11663.533458661559, 11787.528498860293, 12100.273983561014, 7003.159620845531, 7765.961170194113, 8036.276735093869, 8087.63605637736, 8091.150429205084, 10782.353058816496, 11305.491252893475, 11413.486393112496, 11656.0, 11718.23831450953], "unit": "score", "name": "jquery.html", "value": 9905.253630883593}, {"lowerIsBetter": false, "replicates": [1524.725549401108, 1534.6010037390279, 1763.5062182588872, 1880.3418803418806, 1895.914683839227, 7812.570308633023, 8336.541490218036, 8494.0, 8711.390202685807, 8734.737957861267, 8427.83144337113, 8475.957620211906, 8507.234348908598, 8550.444221125623, 8569.01456332522, 2372.5729368713623, 2394.1979436888664, 2396.4847557775074, 2405.482821193443, 2417.6857008588945, 2399.9880000599974, 2405.9759402406016, 2442.804575633954, 2452.8896199670967, 2456.1403508771964, 2399.328188107324, 2442.7068751749816, 2464.3223113643803, 2464.4208610976407, 2466.642336861154, 2421.3583400398907, 2431.817613678981, 2453.9386515337083, 2456.8403053801535, 2464.4578192797558, 2430.21018169094, 2445.3397582652583, 2446.8654224017673, 2447.877606119687, 2448.4490989527394, 8643.611037503264, 8676.566171691453, 8676.8698469523, 8711.651533938635, 8722.476651400937, 5290.259363689087, 5384.219288203189, 5431.891362172774, 5442.836714898559, 5479.506844384025, 3530.6292839251764, 3620.945685814715, 3632.2735452909524, 3674.026383008505, 3678.668919797231, 1051.4059556350637, 1076.7523469602036, 1077.380506208933, 1080.222239987208, 1083.8211695070304, 9712.61149554017, 11597.188196826226, 11691.181617286793, 11691.94154029233, 11727.589534366256, 4819.445763737145, 4822.132016237111, 4901.142300097468, 4910.0, 4917.6311776616185, 10019.348742331726, 10034.24743144267, 10049.799004020026, 10057.64798232073, 10082.747931301776, 5368.731563421891, 5393.83818485446, 5447.1829225616475, 5453.836384908459, 5460.863478412992, 4376.343548467692, 4785.994941062416, 4902.779374928065, 4905.852824415273, 4912.557869791736, 3912.882613521599, 3924.274009308287, 3952.604739526082, 3988.082740969593, 4009.3785463253244, 1100.6918062942389, 1278.8465384153776, 1289.7033682253134, 1297.6245180109115, 1301.1672529581076, 1041.6354276003337, 1044.519521020324, 1054.6045233037612, 1210.431097384228, 1380.2477649680948, 8043.477173983672, 8048.5170889746805, 8067.475614085066, 8077.232662897015, 8130.471519351223, 517.317141373391, 520.573130033369, 526.3263023330144, 526.3762441506826, 526.531387065512, 6170.5372097092895, 6187.319394866561, 6237.438630523275, 6246.437820596168, 6248.718807653667, 10254.436006019741, 10578.10086142671, 10606.310589811637, 10637.308574942605, 10648.414337211529, 8675.652973880975, 10206.795864082676, 10476.738081548023, 10480.842787358195, 10538.578456861793, 8208.794780130545, 8244.876326855101, 8276.462029968034, 8284.171582841787, 8352.540610266373, 6530.346965303432, 7833.804154896173, 7838.451308408356, 7862.253085956825, 7965.163657815846, 9212.815743685223, 9298.72103836886, 9398.765030874283, 9478.57346419399, 9590.904090959, 9466.432014079177, 9645.37305075168, 9735.150321439187, 9823.508824558601, 9850.0, 6784.728610855708, 7168.247334029852, 7376.889346659697, 7417.147028091623, 7530.0, 8124.025116985999, 8130.552819594979, 8147.9185208147155, 8183.427160098736, 8197.344212463107, 7185.101862267216, 7273.309035641606, 7323.560586364835, 7385.335319821242, 7486.101667799899, 7096.716131354688, 7112.50212485121, 7128.643567821485, 7241.131064272321, 7315.414766818535, 6639.236487803964, 7703.576303303372, 7716.729914453192, 7720.498167619086, 7796.571188584682, 6865.0732151160955, 6894.896576551256, 6968.651567421507, 6976.093107895941, 6976.895346569907, 6952.026716259828, 6971.58170509771, 7023.157221133497, 7038.190608080136, 7075.964620176866], "unit": "score", "name": "mootools.html", "value": 4779.16885422103}, {"lowerIsBetter": false, "replicates": [320.9053329267866, 325.4093819717215, 327.1363600095748, 330.4349562248556, 332.55769826131245, 6883.105196324477, 7015.473839462035, 7035.718571257156, 7040.507164498475, 7080.681369338379, 6845.486588505857, 6870.519063665545, 6897.275786042468, 6898.896516552243, 6906.896396554056, 4799.832005879794, 4888.340074090006, 4989.426215985171, 4992.725400103011, 5051.873703157414, 4997.925446029103, 5018.623603229754, 5023.799048038074, 5030.496950304959, 5035.0, 4923.236898280772, 4943.777530011158, 4963.900721985558, 4969.751512424365, 4981.850544483653, 4514.796834142471, 4863.686804562783, 4984.825531106412, 5011.699298042111, 5036.043151801146, 4290.892727681801, 4293.098449325646, 4297.935530967038, 4301.72038817479, 4306.0526684129445, 6357.268914074848, 6609.206895172562, 6620.0, 6633.535652504326, 6648.634325112117, 5829.621074630178, 5848.561357898175, 5899.233099697055, 5899.675517846516, 5916.911246331309, 7422.369098626623, 7423.220561841037, 7425.774747166711, 7441.627918604102, 7452.205422966387, 4671.85984420468, 4680.712803978899, 4685.500639795267, 4686.015936653307, 4702.200625893572, 7212.003872216869, 7777.688892444296, 7863.37093032556, 7867.9606601966625, 7873.370130389612, 4546.272596384562, 4616.330632058332, 4725.858224253209, 4733.881652958704, 4735.715857048519, 4802.615790736732, 4815.95184048155, 4819.734914579732, 4821.132196204647, 4827.0, 4917.532834380728, 5306.495882891119, 5778.7688492460675, 5786.363500014995, 5807.01280782268, 7331.156916954512, 7340.192578816326, 7363.410927125817, 7363.77908662741, 7396.630168491554, 1586.5874872533225, 1627.8372162783864, 1638.6394993101499, 1661.8338166183528, 1676.0195285757725, 1050.6847945616285, 1066.818640831045, 1078.0836289154313, 1078.9892101079047, 1079.185215162563, 6217.253929528486, 6501.284858665543, 6952.261934516371, 6961.060256865258, 6994.8950765738555, 7642.5032372895585, 7662.463627546018, 7666.923330766621, 7671.654775535114, 7688.346490548366, 6921.377076063179, 6940.757073502403, 6940.930590694028, 6949.617771022541, 6954.374106330454, 3333.9166520837175, 3726.2174943262216, 4026.879193624196, 4039.4546736190828, 4075.3683179107284, 7969.800754981055, 8006.319462845607, 8135.918640813635, 8154.592270386457, 8174.38692098095, 7184.634919365304, 7371.631418429057, 8038.196180381915, 8038.276555110068, 8109.432339736162, 6520.445762110274, 8090.676372945251, 8115.959420202979, 8119.959400203079, 8142.145074767182, 7493.478065309296, 7768.300852923038, 7796.883046754417, 7834.960825195838, 7851.764447066369, 7605.429592780453, 7648.34989025939, 7649.235076492307, 7663.693452261847, 7665.19515450892, 8092.393070519617, 8102.189781021851, 8113.8377232456205, 8134.918650813416, 8135.349172066339, 4126.979365103155, 4788.688735232199, 4795.304680821192, 4813.374261346003, 4825.831095911626, 5680.460356266148, 5725.969325521446, 5916.437938395846, 6321.988481842883, 7678.69285228607, 6140.447359737466, 7353.448491363062, 7388.1503627083575, 7462.44031697614, 7467.813304667427, 6152.569320147547, 7265.9273407267365, 7448.031755871702, 7455.739049133254, 7474.5888976106835, 6743.460523158037, 7017.947307903855, 7203.531770435115, 7225.385842203262, 7262.201157872735, 7141.178764441948, 7412.518186317872, 7448.404127669882, 7480.812979675552, 7519.1728909818785, 7231.385332246818, 7268.418526517971, 7273.890891636735, 7275.381592564691, 7280.089988751406], "unit": "score", "name": "prototype.html", "value": 5308.864846646947}, {"lowerIsBetter": false, "replicates": [669.5380187670507, 677.766465033639, 720.2149656874006, 738.8005238585582, 742.1391186223981, 14690.26548672566, 14735.705285894275, 14874.181919994397, 14911.95616306859, 15136.01615894966, 13627.386767595457, 13804.309784510784, 13807.171569705824, 13844.169349839016, 13846.169229846191, 846.128487657712, 858.9398742088056, 862.3360012790148, 865.3077537969599, 866.9046404895456, 701.169114599199, 802.6789284286274, 854.6325080215505, 882.8322618702458, 884.0408157149501, 905.3933864310894, 914.8947870994821, 917.1241464401514, 919.6827094652334, 920.5213289089669, 899.1727610598265, 908.27791905435, 908.6592527802075, 908.8136931928939, 911.3757076402685, 577.7082573300498, 665.7503436211421, 666.094112007674, 674.5547938360708, 678.3047376439189, 14398.856011439857, 14472.98689091764, 14504.202268875208, 14522.983391162623, 14538.927305363406, 11368.431578421047, 12573.622791316184, 12618.81071783924, 12729.872701272961, 13028.804567931395, 9329.953350233272, 9477.668281610111, 10142.340747851365, 10189.796204075878, 10204.540795664212, 3101.875924962999, 3532.7703699259464, 3617.3850445424077, 3635.4546817977252, 3636.7636103653176, 68297.60958366434, 71615.28384716138, 71960.6401967992, 74747.62626186889, 77196.0, 9433.433993960385, 9494.667686630935, 9668.661596844217, 9755.512224388753, 10388.013138751807, 21515.56968860614, 21827.23604673829, 21851.78148218529, 21865.12539498402, 21871.562568748537, 7315.195328513859, 7542.811429714301, 7560.168381478033, 7701.653425595861, 7794.454388192772, 4097.713160078825, 4106.67146628269, 4131.772752498581, 4134.896627584274, 4149.813258403379, 3637.94543081854, 3673.045008297862, 3673.81630918453, 3675.7978311192605, 3682.0, 656.9047488114197, 663.9269680335159, 667.6227931218846, 670.128832517725, 677.0555075669512, 568.6247076929207, 590.8906852232351, 592.2508027345411, 598.8113744170572, 616.4328817487922, 8052.315553178046, 8244.505329680238, 8314.127016663284, 8384.161583841567, 8499.532525711145, 523.2047288122109, 577.4485366475006, 577.6678409914316, 619.7056398210904, 622.2129006806393, 3865.6520913117956, 3873.24471728016, 3889.572147063821, 3929.5284565851707, 3945.2504024235304, 64033.679831600544, 83393.16606833975, 83468.0, 83810.0, 83967.0, 75178.62410687911, 78971.42057158824, 79094.0, 79604.0, 80223.99440014047, 68180.0, 68792.31207687959, 69816.30183698199, 70439.0, 71054.0, 7788.688452462065, 7797.688092476465, 7856.7250146244605, 7889.092754333095, 7937.126916039116, 37168.0, 40754.0, 50334.0, 50524.24213636725, 51703.48296517137, 62171.37828621656, 62803.37196627975, 66985.66507167433, 68056.6597167011, 69098.0, 10138.797224055625, 10153.187744980236, 10220.948895255477, 10495.52770125331, 10622.415767132881, 10841.512131953923, 10892.564297428331, 10957.56169753201, 11021.173411993972, 11856.438709038082, 10436.0, 10749.462526873782, 10800.945995269973, 11085.390303533382, 11089.22375433712, 10213.74465638365, 10620.52207650642, 10641.201909856636, 10642.8403573948, 10738.624148154777, 10058.29591928558, 10258.28192026551, 10302.948485257526, 10486.0, 10604.257701960789, 8822.735317940473, 8852.867206991772, 8908.55457227149, 9028.503432311287, 9072.95463522678, 7252.057232559733, 8902.287816974756, 8947.239484643878, 8993.910060899307, 9125.0], "unit": "score", "name": "yui.html", "value": 6687.206559123511}], "name": "dromaeo_css", "value": 7460.493462212373}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [168.0, 96.0, 169.0, 170.0, 169.0, 161.0, 110.0, 151.0, 166.0, 113.0], "unit": "score", "name": "ai-astar", "value": 147.3}, {"lowerIsBetter": true, "replicates": [155.0, 124.0, 144.0, 154.0, 123.0, 164.0, 171.0, 155.0, 163.0, 122.0], "unit": "score", "name": "audio-beat-detection", "value": 147.5}, {"lowerIsBetter": true, "replicates": [192.0, 196.0, 199.0, 219.0, 286.0, 281.0, 196.0, 194.0, 198.0, 194.0], "unit": "score", "name": "audio-dft", "value": 215.5}, {"lowerIsBetter": true, "replicates": [71.0, 82.0, 72.0, 125.0, 57.0, 61.0, 58.0, 60.0, 89.0, 56.0], "unit": "score", "name": "audio-fft", "value": 73.1}, {"lowerIsBetter": true, "replicates": [83.0, 82.0, 127.0, 79.0, 83.0, 81.0, 121.0, 79.0, 82.0, 120.0], "unit": "score", "name": "audio-oscillator", "value": 93.7}, {"lowerIsBetter": true, "replicates": [87.0, 92.0, 111.0, 93.0, 86.0, 91.0, 85.0, 93.0, 86.0, 92.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 91.6}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 96.0, 95.0, 95.0, 122.0, 152.0], "unit": "score", "name": "imaging-darkroom", "value": 103.4}, {"lowerIsBetter": true, "replicates": [142.0, 150.0, 92.0, 130.0, 113.0, 151.0, 149.0, 106.0, 94.0, 93.0], "unit": "score", "name": "imaging-desaturate", "value": 122.0}, {"lowerIsBetter": true, "replicates": [58.0, 56.0, 57.0, 57.0, 55.0, 59.0, 57.0, 64.0, 57.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.5}, {"lowerIsBetter": true, "replicates": [71.0, 66.0, 77.0, 82.0, 71.0, 71.0, 67.0, 69.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 71.2}, {"lowerIsBetter": true, "replicates": [87.0, 84.0, 90.0, 86.0, 84.0, 83.0, 87.0, 77.0, 100.0, 100.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.8}, {"lowerIsBetter": true, "replicates": [126.0, 136.0, 134.0, 118.0, 131.0, 129.0, 131.0, 135.0, 123.0, 129.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 129.2}, {"lowerIsBetter": true, "replicates": [129.0, 139.0, 132.0, 142.0, 135.0, 173.0, 141.0, 139.0, 142.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.5}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 69.0, 65.0, 70.0, 77.0, 94.0, 95.0, 95.0, 99.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 80.0}], "name": "kraken", "value": 1561.3}]} 05:36:14 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,61]]", "result": "1561.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,61]]", "result": "7460.49"}}} 05:36:14 INFO - Return code: 0 05:36:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:36:14 ERROR - # TBPL SUCCESS # 05:36:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:36:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:36:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:36:14 INFO - 2016-02-26 05:36:14.464 screenresolution[2013:65246] starting screenresolution argv=screenresolution get 05:36:14 INFO - 2016-02-26 05:36:14.466 screenresolution[2013:65246] Display 0: 1600x1200x32@60 05:36:14 INFO - 2016-02-26 05:36:14.472 screenresolution[2014:65249] starting screenresolution argv=screenresolution list 05:36:14 INFO - Available Modes on Display 0 05:36:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:36:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:36:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:36:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:36:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:36:14 INFO - Intel Iris: 05:36:14 INFO - Chipset Model: Intel Iris 05:36:14 INFO - Type: GPU 05:36:14 INFO - Bus: Built-In 05:36:14 INFO - VRAM (Dynamic, Max): 1536 MB 05:36:14 INFO - Vendor: Intel (0x8086) 05:36:14 INFO - Device ID: 0x0a2e 05:36:14 INFO - Revision ID: 0x0009 05:36:14 INFO - Displays: 05:36:14 INFO - Display: 05:36:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:36:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:36:14 INFO - Display Serial Number: 1600x1200 60 05:36:14 INFO - Main Display: Yes 05:36:14 INFO - Mirror: Off 05:36:14 INFO - Online: Yes 05:36:14 INFO - Rotation: Supported 05:36:14 INFO - Return code: 0 05:36:14 INFO - Running post-action listener: _resource_record_post_action 05:36:14 INFO - Running post-run listener: _resource_record_post_run 05:36:15 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 937984; Write bytes: 712749568; Read time: 9; Write time: 2048 05:36:15 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 404908544; Write bytes: 407341056; Read time: 30181; Write time: 742 05:36:15 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 937984; Write bytes: 304560640; Read time: 9; Write time: 1303 05:36:15 INFO - Running post-run listener: _upload_blobber_files 05:36:15 INFO - Blob upload gear active. 05:36:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:36:15 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:36:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:36:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:36:16 INFO - (blobuploader) - INFO - Open directory for files ... 05:36:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:36:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:36:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:36:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:36:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:36:17 INFO - (blobuploader) - INFO - Done attempting. 05:36:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:36:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:36:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:36:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:36:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:36:18 INFO - (blobuploader) - INFO - Done attempting. 05:36:18 INFO - (blobuploader) - INFO - Iteration through files over. 05:36:18 INFO - Return code: 0 05:36:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:36:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:36:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/901ae01d7f92187417fd0be853cb7998ef9fa6563c9249a23dfced3964bfa30a41da14db8ee1a1368a1f908474453507b18efe249b3bf9ae7d6b9480c1ec5e35", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c028e816627aeccf3b289814ec78c575b18a0cc490a087d2db2691e7358dfc25b488f2c662b9c628e21e55a1179642ebb58fd3f9e1ffd608f8517e1a9cb0eb7d"} 05:36:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:36:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:36:18 INFO - Contents: 05:36:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/901ae01d7f92187417fd0be853cb7998ef9fa6563c9249a23dfced3964bfa30a41da14db8ee1a1368a1f908474453507b18efe249b3bf9ae7d6b9480c1ec5e35", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c028e816627aeccf3b289814ec78c575b18a0cc490a087d2db2691e7358dfc25b488f2c662b9c628e21e55a1179642ebb58fd3f9e1ffd608f8517e1a9cb0eb7d"} 05:36:18 INFO - Running post-run listener: copy_logs_to_upload_dir 05:36:18 INFO - Copying logs to upload dir... 05:36:18 INFO - mkdir: /builds/slave/test/build/upload/logs 05:36:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.106102 ========= master_lag: 2.40 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-02-26 05:36:20.797697) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-26 05:36:20.801251) ========= 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.h3TF1Svj5T/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.qQrrZ6b05L/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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/901ae01d7f92187417fd0be853cb7998ef9fa6563c9249a23dfced3964bfa30a41da14db8ee1a1368a1f908474453507b18efe249b3bf9ae7d6b9480c1ec5e35", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c028e816627aeccf3b289814ec78c575b18a0cc490a087d2db2691e7358dfc25b488f2c662b9c628e21e55a1179642ebb58fd3f9e1ffd608f8517e1a9cb0eb7d"} build_url:https://queue.taskcluster.net/v1/task/ahvy7-_gSIeAa1Ym5ohl7w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011458 build_url: 'https://queue.taskcluster.net/v1/task/ahvy7-_gSIeAa1Ym5ohl7w/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/901ae01d7f92187417fd0be853cb7998ef9fa6563c9249a23dfced3964bfa30a41da14db8ee1a1368a1f908474453507b18efe249b3bf9ae7d6b9480c1ec5e35", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c028e816627aeccf3b289814ec78c575b18a0cc490a087d2db2691e7358dfc25b488f2c662b9c628e21e55a1179642ebb58fd3f9e1ffd608f8517e1a9cb0eb7d"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-26 05:36:20.850211) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 05:36:20.850531) ========= 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.h3TF1Svj5T/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.qQrrZ6b05L/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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.004704 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 05:36:20.898689) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-26 05:36:20.899009) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-26 05:36:20.899402) ========= ========= Total master_lag: 2.87 =========