builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0112 starttime: 1460029359.89 results: success (0) buildid: 20160407043448 builduid: 64d728d19247417eb078689ef6c96875 revision: 68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:39.889603) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:39.890139) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:39.890500) ========= 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.Npw9aSOVsW/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.ux9uyV21Zx/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.005780 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:39.951026) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:39.951445) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:40.198705) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:40.199126) ========= 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.Npw9aSOVsW/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.ux9uyV21Zx/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.005397 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:40.251690) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:40.252438) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:40.253305) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:40.254035) ========= 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.Npw9aSOVsW/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.ux9uyV21Zx/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-04-07 04:42:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 99.8M=0s 2016-04-07 04:42:40 (99.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.091782 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:40.364935) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:40.365674) ========= 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.Npw9aSOVsW/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.ux9uyV21Zx/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.021355 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:40.418600) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-07 04:42:40.419431) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8 --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 68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Npw9aSOVsW/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.ux9uyV21Zx/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-04-07 04:42:40,499 truncating revision to first 12 chars 2016-04-07 04:42:40,499 Setting DEBUG logging. 2016-04-07 04:42:40,499 attempt 1/10 2016-04-07 04:42:40,499 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/68c0b7d6f16c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-07 04:42:41,427 unpacking tar archive at: mozilla-central-68c0b7d6f16c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.180992 ========= master_lag: 0.44 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-07 04:42:42.042615) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:42.044905) ========= echo 68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Npw9aSOVsW/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.ux9uyV21Zx/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 68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8 program finished with exit code 0 elapsedTime=0.005719 script_repo_revision: '68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8' ========= master_lag: 0.03 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:42.076031) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:42.079141) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:42.096779) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-04-07 04:42:42.097176) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Npw9aSOVsW/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.ux9uyV21Zx/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 04:42:42 INFO - MultiFileLogger online at 20160407 04:42:42 in /builds/slave/test 04:42:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:42:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:42:42 INFO - {'append_to_log': False, 04:42:42 INFO - 'base_work_dir': '/builds/slave/test', 04:42:42 INFO - 'blob_upload_branch': 'Firefox', 04:42:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:42:42 INFO - 'branch': 'Firefox', 04:42:42 INFO - 'buildbot_json_path': 'buildprops.json', 04:42:42 INFO - 'config_files': ('talos/mac_config.py',), 04:42:42 INFO - 'default_actions': ('clobber', 04:42:42 INFO - 'read-buildbot-config', 04:42:42 INFO - 'download-and-extract', 04:42:42 INFO - 'populate-webroot', 04:42:42 INFO - 'create-virtualenv', 04:42:42 INFO - 'install', 04:42:42 INFO - 'run-tests'), 04:42:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:42:42 INFO - 'download_minidump_stackwalk': True, 04:42:42 INFO - 'download_symbols': 'ondemand', 04:42:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:42:42 INFO - 'tooltool.py': '/tools/tooltool.py', 04:42:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:42:42 INFO - '/tools/misc-python/virtualenv.py')}, 04:42:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:42:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:42:42 INFO - 'installer_path': 'installer.exe', 04:42:42 INFO - 'log_level': 'info', 04:42:42 INFO - 'log_name': 'talos', 04:42:42 INFO - 'log_to_console': True, 04:42:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:42:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:42:42 INFO - 'opt_config_files': (), 04:42:42 INFO - 'pip_index': False, 04:42:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:42:42 INFO - 'cmd': ('bash', 04:42:42 INFO - '-c', 04:42:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:42:42 INFO - 'enabled': True, 04:42:42 INFO - 'halt_on_failure': False, 04:42:42 INFO - 'name': 'check_screen_resolution'},), 04:42:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:42:42 INFO - 'cmd': ('bash', 04:42:42 INFO - '-c', 04:42:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:42:42 INFO - 'enabled': True, 04:42:42 INFO - 'halt_on_failure': False, 04:42:42 INFO - 'name': 'check_screen_resolution'},), 04:42:42 INFO - 'run_cmd_checks_enabled': True, 04:42:42 INFO - 'sps_profile': False, 04:42:42 INFO - 'sps_profile_interval': 0, 04:42:42 INFO - 'suite': 'dromaeojs', 04:42:42 INFO - 'system_bits': '32', 04:42:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:42:42 INFO - 'title': 't-yosemite-r7-0112', 04:42:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:42:42 INFO - 'use_talos_json': True, 04:42:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:42:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:42:42 INFO - 'work_dir': 'build'} 04:42:42 INFO - ##### 04:42:42 INFO - ##### Running clobber step. 04:42:42 INFO - ##### 04:42:42 INFO - Running pre-action listener: _resource_record_pre_action 04:42:42 INFO - Running main action method: clobber 04:42:42 INFO - rmtree: /builds/slave/test/build 04:42:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:42:43 INFO - Running post-action listener: _resource_record_post_action 04:42:43 INFO - ##### 04:42:43 INFO - ##### Running read-buildbot-config step. 04:42:43 INFO - ##### 04:42:43 INFO - Running pre-action listener: _resource_record_pre_action 04:42:43 INFO - Running main action method: read_buildbot_config 04:42:43 INFO - Using buildbot properties: 04:42:43 INFO - { 04:42:43 INFO - "project": "", 04:42:43 INFO - "product": "firefox", 04:42:43 INFO - "script_repo_revision": "production", 04:42:43 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:42:43 INFO - "repository": "", 04:42:43 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:42:43 INFO - "buildid": "20160407043448", 04:42:43 INFO - "stage_platform": "macosx64", 04:42:43 INFO - "basedir": "/builds/slave/test", 04:42:43 INFO - "buildnumber": 196, 04:42:43 INFO - "platform": "yosemite_r7", 04:42:43 INFO - "mozci_request": { 04:42:43 INFO - "priority": -1, 04:42:43 INFO - "type": "trigger_all_talos_jobs", 04:42:43 INFO - "times": 6 04:42:43 INFO - }, 04:42:43 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 04:42:43 INFO - "slavebuilddir": "test", 04:42:43 INFO - "branch": "mozilla-central", 04:42:43 INFO - "revision": "68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8", 04:42:43 INFO - "slavename": "t-yosemite-r7-0112", 04:42:43 INFO - "builduid": "64d728d19247417eb078689ef6c96875", 04:42:43 INFO - "repo_path": "mozilla-central" 04:42:43 INFO - } 04:42:43 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.dmg. 04:42:43 INFO - Found a test packages url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.test_packages.json. 04:42:43 INFO - Running post-action listener: _resource_record_post_action 04:42:43 INFO - ##### 04:42:43 INFO - ##### Running download-and-extract step. 04:42:43 INFO - ##### 04:42:43 INFO - Running pre-action listener: _resource_record_pre_action 04:42:43 INFO - Running main action method: download_and_extract 04:42:43 INFO - mkdir: /builds/slave/test/build/tests 04:42: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')]} 04:42:43 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.test_packages.json 04:42:43 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 04:42:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 04:42:44 INFO - Downloaded 1199 bytes. 04:42:44 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 04:42:44 INFO - Using the following test package requirements: 04:42:44 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 04:42:44 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:42:44 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 04:42:44 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:42:44 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 04:42:44 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:42:44 INFO - u'jsshell-mac.zip'], 04:42:44 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:42:44 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 04:42:44 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 04:42:44 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:42:44 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 04:42:44 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:42:44 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 04:42:44 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:42:44 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 04:42:44 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:42:44 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 04:42:44 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:42:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:44 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.common.tests.zip 04:42:44 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:42:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:42:44 INFO - Downloaded 17964225 bytes. 04:42:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:42:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:42:47 INFO - Return code: 0 04:42:47 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:42:47 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')]} 04:42:47 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.common.tests.zip 04:42:47 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:42:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:42:48 INFO - Downloaded 17964225 bytes. 04:42:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:42:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:42:51 INFO - Return code: 0 04:42:51 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')]} 04:42:51 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.talos.tests.zip 04:42:51 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 04:42:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:42:52 INFO - Downloaded 10847617 bytes. 04:42:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:42:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 04:42:52 INFO - Return code: 0 04:42:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:52 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.dmg 04:42:52 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 04:42:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 04:42:53 INFO - Downloaded 108925595 bytes. 04:42:53 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.dmg 04:42:53 INFO - mkdir: /builds/slave/test/properties 04:42:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:42:53 INFO - Writing to file /builds/slave/test/properties/build_url 04:42:53 INFO - Contents: 04:42:53 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.dmg 04:42:53 INFO - Running post-action listener: _resource_record_post_action 04:42:53 INFO - Running post-action listener: set_extra_try_arguments 04:42:53 INFO - ##### 04:42:53 INFO - ##### Running populate-webroot step. 04:42:53 INFO - ##### 04:42:53 INFO - Running pre-action listener: _resource_record_pre_action 04:42:53 INFO - Running main action method: populate_webroot 04:42:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:42:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:42:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:42:53 INFO - '--tppagecycles', 04:42:53 INFO - '7'], 04:42:53 INFO - 'tests': ['tsvgm']}}, 04:42:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:42:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:42:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:42:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:42:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:42:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:42:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:53 INFO - 'talos_options': ['--disable-e10s'], 04:42:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:42:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:42:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:53 INFO - 'talos_options': ['--disable-e10s'], 04:42:53 INFO - 'tests': ['damp', 'tps']}, 04:42:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:53 INFO - 'tests': ['damp', 'tps']}, 04:42:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:42:53 INFO - 'tests': ['dromaeo_dom']}, 04:42:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:42:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:42:53 INFO - 'tests': ['a11yr', 04:42:53 INFO - 'ts_paint', 04:42:53 INFO - 'tpaint', 04:42:53 INFO - 'sessionrestore', 04:42:53 INFO - 'sessionrestore_no_auto_restore', 04:42:53 INFO - 'tabpaint']}, 04:42:53 INFO - 'other-e10s': {'tests': ['a11yr', 04:42:53 INFO - 'ts_paint', 04:42:53 INFO - 'tpaint', 04:42:53 INFO - 'sessionrestore', 04:42:53 INFO - 'sessionrestore_no_auto_restore', 04:42:53 INFO - 'tabpaint']}, 04:42:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:42:53 INFO - 'ts_paint', 04:42:53 INFO - 'tpaint', 04:42:53 INFO - 'sessionrestore', 04:42:53 INFO - 'sessionrestore_no_auto_restore', 04:42:53 INFO - 'tabpaint']}, 04:42:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:42:53 INFO - 'ts_paint', 04:42:53 INFO - 'tpaint', 04:42:53 INFO - 'sessionrestore', 04:42:53 INFO - 'sessionrestore_no_auto_restore', 04:42:53 INFO - 'tabpaint']}, 04:42:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:42:53 INFO - 'tests': ['a11yr', 04:42:53 INFO - 'ts_paint', 04:42:53 INFO - 'tpaint', 04:42:53 INFO - 'sessionrestore', 04:42:53 INFO - 'sessionrestore_no_auto_restore', 04:42:53 INFO - 'tabpaint']}, 04:42:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:42:53 INFO - 'tests': ['a11yr', 04:42:53 INFO - 'ts_paint', 04:42:53 INFO - 'tpaint', 04:42:53 INFO - 'sessionrestore', 04:42:53 INFO - 'sessionrestore_no_auto_restore', 04:42:53 INFO - 'tabpaint']}, 04:42:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:42:53 INFO - 'tests': ['tsvgx', 04:42:53 INFO - 'tsvgr_opacity', 04:42:53 INFO - 'tart', 04:42:53 INFO - 'tscrollx', 04:42:53 INFO - 'cart']}, 04:42:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:42:53 INFO - 'tsvgr_opacity', 04:42:53 INFO - 'tart', 04:42:53 INFO - 'tscrollx', 04:42:53 INFO - 'cart']}, 04:42:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:53 INFO - 'talos_options': ['--disable-e10s'], 04:42:53 INFO - 'tests': ['tp5o']}, 04:42:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:53 INFO - 'tests': ['tp5o']}, 04:42:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:53 INFO - 'talos_options': ['--disable-e10s', 04:42:53 INFO - '--xperf_path', 04:42:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:42:53 INFO - 'tests': ['tp5n']}, 04:42:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:53 INFO - 'talos_options': ['--xperf_path', 04:42:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:42:53 INFO - 'tests': ['tp5n']}}, 04:42:53 INFO - 'talos.zip': {'path': '', 04:42:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:42:53 INFO - Running post-action listener: _resource_record_post_action 04:42:53 INFO - ##### 04:42:53 INFO - ##### Running create-virtualenv step. 04:42:53 INFO - ##### 04:42:53 INFO - Running pre-action listener: _resource_record_pre_action 04:42:53 INFO - Running main action method: create_virtualenv 04:42:53 INFO - Creating virtualenv /builds/slave/test/build/venv 04:42:53 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 04:42:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:42:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:42:53 INFO - Using real prefix '/tools/python27' 04:42:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:42:54 INFO - Installing distribute.............................................................................................................................................................................................done. 04:42:57 INFO - Installing pip.................done. 04:42:57 INFO - Return code: 0 04:42:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:42:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:57 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 0x10482da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10483d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca984c5010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046cce00>, '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 0x1044f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046c7b20>, '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.Npw9aSOVsW/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.ux9uyV21Zx/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 04:42:57 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 04:42:57 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 04:42:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Npw9aSOVsW/Render', 04:42:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:57 INFO - 'HOME': '/Users/cltbld', 04:42:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:57 INFO - 'LOGNAME': 'cltbld', 04:42:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:57 INFO - 'MOZ_NO_REMOTE': '1', 04:42:57 INFO - 'NO_EM_RESTART': '1', 04:42:57 INFO - 'PAGER': '/bin/cat', 04:42:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:57 INFO - 'PWD': '/builds/slave/test', 04:42:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:57 INFO - 'SHELL': '/bin/bash', 04:42:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ux9uyV21Zx/Listeners', 04:42:57 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 04:42:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:57 INFO - 'USER': 'cltbld', 04:42:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:57 INFO - 'XPC_FLAGS': '0x0', 04:42:57 INFO - 'XPC_SERVICE_NAME': '0', 04:42:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:57 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 04:42:57 INFO - Cleaning up... 04:42:57 INFO - Return code: 0 04:42:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:42:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:57 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 0x10482da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10483d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca984c5010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046cce00>, '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 0x1044f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046c7b20>, '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.Npw9aSOVsW/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.ux9uyV21Zx/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 04:42:57 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 04:42:57 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 04:42:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Npw9aSOVsW/Render', 04:42:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:57 INFO - 'HOME': '/Users/cltbld', 04:42:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:57 INFO - 'LOGNAME': 'cltbld', 04:42:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:57 INFO - 'MOZ_NO_REMOTE': '1', 04:42:57 INFO - 'NO_EM_RESTART': '1', 04:42:57 INFO - 'PAGER': '/bin/cat', 04:42:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:57 INFO - 'PWD': '/builds/slave/test', 04:42:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:57 INFO - 'SHELL': '/bin/bash', 04:42:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ux9uyV21Zx/Listeners', 04:42:57 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 04:42:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:57 INFO - 'USER': 'cltbld', 04:42:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:57 INFO - 'XPC_FLAGS': '0x0', 04:42:57 INFO - 'XPC_SERVICE_NAME': '0', 04:42:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:57 INFO - Downloading/unpacking psutil>=0.7.1 04:42: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 04:42: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 04:42: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 04:42: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 04:42: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 04:42: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 04:43:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:43:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:43:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:43:00 INFO - Installing collected packages: psutil 04:43:00 INFO - Running setup.py install for psutil 04:43:01 INFO - building 'psutil._psutil_osx' extension 04:43:01 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 04:43:01 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 04:43:01 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 04:43:01 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 04:43:01 INFO - building 'psutil._psutil_posix' extension 04:43:01 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 04:43:01 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:43:01 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:43:01 INFO - ^ 04:43:01 INFO - 1 warning generated. 04:43:01 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 04:43:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:43:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:43:01 INFO - Successfully installed psutil 04:43:01 INFO - Cleaning up... 04:43:01 INFO - Return code: 0 04:43:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:43:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:43:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:01 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 0x10482da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10483d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca984c5010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046cce00>, '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 0x1044f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046c7b20>, '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.Npw9aSOVsW/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.ux9uyV21Zx/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 04:43:01 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 04:43:01 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 04:43:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Npw9aSOVsW/Render', 04:43:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:01 INFO - 'HOME': '/Users/cltbld', 04:43:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:01 INFO - 'LOGNAME': 'cltbld', 04:43:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:01 INFO - 'MOZ_NO_REMOTE': '1', 04:43:01 INFO - 'NO_EM_RESTART': '1', 04:43:01 INFO - 'PAGER': '/bin/cat', 04:43:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:01 INFO - 'PWD': '/builds/slave/test', 04:43:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:01 INFO - 'SHELL': '/bin/bash', 04:43:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ux9uyV21Zx/Listeners', 04:43:01 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 04:43:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:01 INFO - 'USER': 'cltbld', 04:43:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:01 INFO - 'XPC_FLAGS': '0x0', 04:43:01 INFO - 'XPC_SERVICE_NAME': '0', 04:43:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:43:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:43:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:43:04 INFO - Installing collected packages: mozsystemmonitor 04:43:04 INFO - Running setup.py install for mozsystemmonitor 04:43:04 INFO - Successfully installed mozsystemmonitor 04:43:04 INFO - Cleaning up... 04:43:04 INFO - Return code: 0 04:43:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:43:04 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')]} 04:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:04 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')]} 04:43:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:04 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 0x10482da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10483d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca984c5010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046cce00>, '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 0x1044f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046c7b20>, '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.Npw9aSOVsW/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.ux9uyV21Zx/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 04:43:04 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 04:43:04 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 04:43:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Npw9aSOVsW/Render', 04:43:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:04 INFO - 'HOME': '/Users/cltbld', 04:43:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:04 INFO - 'LOGNAME': 'cltbld', 04:43:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:04 INFO - 'MOZ_NO_REMOTE': '1', 04:43:04 INFO - 'NO_EM_RESTART': '1', 04:43:04 INFO - 'PAGER': '/bin/cat', 04:43:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:04 INFO - 'PWD': '/builds/slave/test', 04:43:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:04 INFO - 'SHELL': '/bin/bash', 04:43:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ux9uyV21Zx/Listeners', 04:43:04 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 04:43:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:04 INFO - 'USER': 'cltbld', 04:43:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:04 INFO - 'XPC_FLAGS': '0x0', 04:43:04 INFO - 'XPC_SERVICE_NAME': '0', 04:43:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:05 INFO - Downloading/unpacking blobuploader==1.2.4 04:43:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:07 INFO - Downloading blobuploader-1.2.4.tar.gz 04:43:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:43:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:43: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 04:43: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 04:43: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 04:43: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 04:43: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 04:43: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 04:43:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:43:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:43:08 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 04:43:08 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 04:43:08 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 04:43:08 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 04:43:08 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 04:43:08 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 04:43:08 INFO - Downloading docopt-0.6.1.tar.gz 04:43:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:43:08 INFO - Installing collected packages: blobuploader, requests, docopt 04:43:08 INFO - Running setup.py install for blobuploader 04:43:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:43:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:43:08 INFO - Running setup.py install for requests 04:43:09 INFO - Running setup.py install for docopt 04:43:09 INFO - Successfully installed blobuploader requests docopt 04:43:09 INFO - Cleaning up... 04:43:09 INFO - Return code: 0 04:43:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:43:09 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')]} 04:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:09 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')]} 04:43:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:09 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 0x10482da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10483d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca984c5010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046cce00>, '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 0x1044f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046c7b20>, '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.Npw9aSOVsW/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.ux9uyV21Zx/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 04:43:09 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 04:43:09 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 04:43:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Npw9aSOVsW/Render', 04:43:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:09 INFO - 'HOME': '/Users/cltbld', 04:43:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:09 INFO - 'LOGNAME': 'cltbld', 04:43:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:09 INFO - 'MOZ_NO_REMOTE': '1', 04:43:09 INFO - 'NO_EM_RESTART': '1', 04:43:09 INFO - 'PAGER': '/bin/cat', 04:43:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:09 INFO - 'PWD': '/builds/slave/test', 04:43:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:09 INFO - 'SHELL': '/bin/bash', 04:43:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ux9uyV21Zx/Listeners', 04:43:09 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 04:43:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:09 INFO - 'USER': 'cltbld', 04:43:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:09 INFO - 'XPC_FLAGS': '0x0', 04:43:09 INFO - 'XPC_SERVICE_NAME': '0', 04:43:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:43:09 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-40GgMc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:43:10 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-wfN7B9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:43:10 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-N521ie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:43:10 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-iZi2DU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:43:10 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-JJNI6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:43:10 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-pgn0ZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:43:10 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-XrTUnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:43:10 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-ranP7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:43:10 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-Ca78tn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:43:10 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-0jTTCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:43:11 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-eT3pBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:43:11 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-9QAWzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:43:11 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-8BtLFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:43:11 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-tZzC4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:43:11 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-J0vXdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:43:11 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-3FyVOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:43:11 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-p4TfBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:43:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:43:11 INFO - Running setup.py install for manifestparser 04:43:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:43:11 INFO - Running setup.py install for mozcrash 04:43:12 INFO - Running setup.py install for mozdebug 04:43:12 INFO - Running setup.py install for mozdevice 04:43:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:43:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:43:12 INFO - Running setup.py install for mozfile 04:43:12 INFO - Running setup.py install for mozhttpd 04:43:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:43:12 INFO - Running setup.py install for mozinfo 04:43:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:43:12 INFO - Running setup.py install for mozInstall 04:43:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:43:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:43:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:43:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:43:12 INFO - Running setup.py install for mozleak 04:43:13 INFO - Running setup.py install for mozlog 04:43:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:43:13 INFO - Running setup.py install for moznetwork 04:43:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:43:13 INFO - Running setup.py install for mozprocess 04:43:13 INFO - Running setup.py install for mozprofile 04:43:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:43:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:43:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:43:13 INFO - Running setup.py install for mozrunner 04:43:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:43:13 INFO - Running setup.py install for mozscreenshot 04:43:14 INFO - Running setup.py install for moztest 04:43:14 INFO - Running setup.py install for mozversion 04:43:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:43:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:43:14 INFO - Cleaning up... 04:43:14 INFO - Return code: 0 04:43:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:43: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')]} 04:43:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43: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')]} 04:43:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:14 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 0x10482da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10483d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca984c5010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046cce00>, '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 0x1044f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046c7b20>, '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.Npw9aSOVsW/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.ux9uyV21Zx/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 04:43:14 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 04:43:14 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 04:43:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Npw9aSOVsW/Render', 04:43:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:14 INFO - 'HOME': '/Users/cltbld', 04:43:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:14 INFO - 'LOGNAME': 'cltbld', 04:43:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:14 INFO - 'MOZ_NO_REMOTE': '1', 04:43:14 INFO - 'NO_EM_RESTART': '1', 04:43:14 INFO - 'PAGER': '/bin/cat', 04:43:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:14 INFO - 'PWD': '/builds/slave/test', 04:43:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:14 INFO - 'SHELL': '/bin/bash', 04:43:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ux9uyV21Zx/Listeners', 04:43:14 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 04:43:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:14 INFO - 'USER': 'cltbld', 04:43:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:14 INFO - 'XPC_FLAGS': '0x0', 04:43:14 INFO - 'XPC_SERVICE_NAME': '0', 04:43:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:43:14 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-SZUZz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:43:14 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)) 04:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:43:14 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-IIuIa2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:43:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:43:14 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-Whmoyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:43:14 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)) 04:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:43:14 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-dOGLB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:43:15 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)) 04:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:43:15 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-jFUYqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:43:15 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)) 04:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:43:15 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-xV_qDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:43:15 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)) 04:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:43:15 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-yreWtX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:43:15 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)) 04:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:43:15 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-U169W4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:43:15 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)) 04:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:43:15 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-YDCTx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:43:15 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)) 04:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:43:15 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-QeCIDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:43:15 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)) 04:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:43:15 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-rus08R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:43:15 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)) 04:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:43:15 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-PEPUDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:43:15 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)) 04:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:43:15 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-4_VuJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:43:16 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)) 04:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:43:16 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-idBqZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:43:16 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)) 04:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:43:16 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-pNya3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:43:16 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)) 04:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:43:16 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-PNxDXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:43:16 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)) 04:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:43:16 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-LnkVEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:43:16 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)) 04:43:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:43:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:43:16 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)) 04:43:16 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)) 04:43:16 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)) 04:43:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:43:16 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 04:43:16 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 04:43:16 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 04:43:16 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 04:43:16 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 04:43:16 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 04:43:18 INFO - Downloading blessings-1.6.tar.gz 04:43:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:43:18 INFO - Installing collected packages: blessings 04:43:18 INFO - Running setup.py install for blessings 04:43:19 INFO - Successfully installed blessings 04:43:19 INFO - Cleaning up... 04:43:19 INFO - Return code: 0 04:43:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:43:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:43:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:43:19 INFO - Reading from file tmpfile_stdout 04:43:19 INFO - Current package versions: 04:43:19 INFO - blessings == 1.6 04:43:19 INFO - blobuploader == 1.2.4 04:43:19 INFO - docopt == 0.6.1 04:43:19 INFO - manifestparser == 1.1 04:43:19 INFO - mozInstall == 1.12 04:43:19 INFO - mozcrash == 0.17 04:43:19 INFO - mozdebug == 0.1 04:43:19 INFO - mozdevice == 0.48 04:43:19 INFO - mozfile == 1.2 04:43:19 INFO - mozhttpd == 0.7 04:43:19 INFO - mozinfo == 0.9 04:43:19 INFO - mozleak == 0.1 04:43:19 INFO - mozlog == 3.1 04:43:19 INFO - moznetwork == 0.27 04:43:19 INFO - mozprocess == 0.22 04:43:19 INFO - mozprofile == 0.28 04:43:19 INFO - mozrunner == 6.11 04:43:19 INFO - mozscreenshot == 0.1 04:43:19 INFO - mozsystemmonitor == 0.0 04:43:19 INFO - moztest == 0.7 04:43:19 INFO - mozversion == 1.4 04:43:19 INFO - psutil == 3.1.1 04:43:19 INFO - requests == 1.2.3 04:43:19 INFO - wsgiref == 0.1.2 04:43:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:43:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:43:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:43:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:19 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 0x10482da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10483d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca984c5010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046cce00>, '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 0x1044f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046c7b20>, '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.Npw9aSOVsW/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.ux9uyV21Zx/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 04:43:19 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 04:43:19 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 04:43:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Npw9aSOVsW/Render', 04:43:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:19 INFO - 'HOME': '/Users/cltbld', 04:43:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:19 INFO - 'LOGNAME': 'cltbld', 04:43:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:19 INFO - 'MOZ_NO_REMOTE': '1', 04:43:19 INFO - 'NO_EM_RESTART': '1', 04:43:19 INFO - 'PAGER': '/bin/cat', 04:43:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:19 INFO - 'PWD': '/builds/slave/test', 04:43:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:19 INFO - 'SHELL': '/bin/bash', 04:43:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ux9uyV21Zx/Listeners', 04:43:19 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 04:43:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:19 INFO - 'USER': 'cltbld', 04:43:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:19 INFO - 'XPC_FLAGS': '0x0', 04:43:19 INFO - 'XPC_SERVICE_NAME': '0', 04:43:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:19 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)) 04:43:19 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)) 04:43:19 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)) 04:43:19 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)) 04:43:19 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)) 04:43:19 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)) 04:43:19 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)) 04:43:19 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)) 04:43:19 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)) 04:43:19 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)) 04:43:19 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)) 04:43:19 INFO - Cleaning up... 04:43:19 INFO - Return code: 0 04:43:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:43:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:43:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:43:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10482da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10483d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca984c5010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046cce00>, '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 0x1044f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046c7b20>, '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.Npw9aSOVsW/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.ux9uyV21Zx/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 04:43:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:43:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:43:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Npw9aSOVsW/Render', 04:43:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:19 INFO - 'HOME': '/Users/cltbld', 04:43:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:19 INFO - 'LOGNAME': 'cltbld', 04:43:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:19 INFO - 'MOZ_NO_REMOTE': '1', 04:43:19 INFO - 'NO_EM_RESTART': '1', 04:43:19 INFO - 'PAGER': '/bin/cat', 04:43:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:19 INFO - 'PWD': '/builds/slave/test', 04:43:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:19 INFO - 'SHELL': '/bin/bash', 04:43:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ux9uyV21Zx/Listeners', 04:43:19 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 04:43:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:19 INFO - 'USER': 'cltbld', 04:43:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:19 INFO - 'XPC_FLAGS': '0x0', 04:43:19 INFO - 'XPC_SERVICE_NAME': '0', 04:43:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:20 INFO - Downloading/unpacking jsonschema 04:43:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:43:22 INFO - Downloading/unpacking functools32 (from jsonschema) 04:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:22 INFO - Downloading functools32-3.2.3-2.tar.gz 04:43:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:43:22 INFO - warning: no files found matching '*.txt' 04:43:22 INFO - no previously-included directories found matching 'build' 04:43:22 INFO - no previously-included directories found matching 'dist' 04:43:22 INFO - no previously-included directories found matching '.git*' 04:43:22 INFO - Installing collected packages: jsonschema, functools32 04:43:22 INFO - Running setup.py install for functools32 04:43:23 INFO - warning: no files found matching '*.txt' 04:43:23 INFO - no previously-included directories found matching 'build' 04:43:23 INFO - no previously-included directories found matching 'dist' 04:43:23 INFO - no previously-included directories found matching '.git*' 04:43:23 INFO - Successfully installed jsonschema functools32 04:43:23 INFO - Cleaning up... 04:43:23 INFO - Return code: 0 04:43:23 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:43: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')]} 04:43:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43: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')]} 04:43:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:23 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 0x10482da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10483d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca984c5010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046cce00>, '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 0x1044f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046c7b20>, '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.Npw9aSOVsW/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.ux9uyV21Zx/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 04:43:23 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 04:43:23 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 04:43:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Npw9aSOVsW/Render', 04:43:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:23 INFO - 'HOME': '/Users/cltbld', 04:43:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:23 INFO - 'LOGNAME': 'cltbld', 04:43:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:23 INFO - 'MOZ_NO_REMOTE': '1', 04:43:23 INFO - 'NO_EM_RESTART': '1', 04:43:23 INFO - 'PAGER': '/bin/cat', 04:43:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:23 INFO - 'PWD': '/builds/slave/test', 04:43:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:23 INFO - 'SHELL': '/bin/bash', 04:43:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ux9uyV21Zx/Listeners', 04:43:23 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 04:43:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:23 INFO - 'USER': 'cltbld', 04:43:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:23 INFO - 'XPC_FLAGS': '0x0', 04:43:23 INFO - 'XPC_SERVICE_NAME': '0', 04:43:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:23 INFO - Downloading/unpacking flake8 04:43:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:43:25 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:43:25 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 04:43:25 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 04:43:25 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 04:43:25 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 04:43:25 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 04:43:25 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 04:43:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:43:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:43:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:43:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:43:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:43:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:43:27 INFO - no previously-included directories found matching 'docs/_build' 04:43:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:43:27 INFO - Running setup.py install for pep8 04:43:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:43:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:43:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:43:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:43:27 INFO - no previously-included directories found matching 'docs/_build' 04:43:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:43:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:43:27 INFO - Cleaning up... 04:43:27 INFO - Return code: 0 04:43:27 INFO - Running post-action listener: _resource_record_post_action 04:43:27 INFO - Running post-action listener: _start_resource_monitoring 04:43:27 INFO - Starting resource monitoring. 04:43:27 INFO - ##### 04:43:27 INFO - ##### Running install step. 04:43:27 INFO - ##### 04:43:27 INFO - Running pre-action listener: _resource_record_pre_action 04:43:27 INFO - Running main action method: install 04:43:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:43:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:43:27 INFO - Reading from file tmpfile_stdout 04:43:27 INFO - Detecting whether we're running mozinstall >=1.0... 04:43:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:43:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:43:27 INFO - Reading from file tmpfile_stdout 04:43:27 INFO - Output received: 04:43:27 INFO - Usage: mozinstall [options] installer 04:43:27 INFO - Options: 04:43:27 INFO - -h, --help show this help message and exit 04:43:27 INFO - -d DEST, --destination=DEST 04:43:27 INFO - Directory to install application into. [default: 04:43:27 INFO - "/builds/slave/test"] 04:43:27 INFO - --app=APP Application being installed. [default: firefox] 04:43:27 INFO - mkdir: /builds/slave/test/build/application 04:43:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:43:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:44:01 INFO - Reading from file tmpfile_stdout 04:44:01 INFO - Output received: 04:44:01 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:44:01 INFO - Running post-action listener: _resource_record_post_action 04:44:01 INFO - ##### 04:44:01 INFO - ##### Running run-tests step. 04:44:01 INFO - ##### 04:44:01 INFO - Running pre-action listener: _resource_record_pre_action 04:44:01 INFO - Running main action method: run_tests 04:44:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:44:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:44:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:44:01 INFO - 2016-04-07 04:44:01.658 screenresolution[2331:15798] starting screenresolution argv=screenresolution get 04:44:01 INFO - 2016-04-07 04:44:01.661 screenresolution[2331:15798] Display 0: 1600x1200x32@60 04:44:01 INFO - 2016-04-07 04:44:01.667 screenresolution[2332:15800] starting screenresolution argv=screenresolution list 04:44:01 INFO - Available Modes on Display 0 04:44:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:44:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:44:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:44:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:44:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:44:01 INFO - Intel Iris: 04:44:01 INFO - Chipset Model: Intel Iris 04:44:01 INFO - Type: GPU 04:44:01 INFO - Bus: Built-In 04:44:01 INFO - VRAM (Dynamic, Max): 1536 MB 04:44:01 INFO - Vendor: Intel (0x8086) 04:44:01 INFO - Device ID: 0x0a2e 04:44:01 INFO - Revision ID: 0x0009 04:44:01 INFO - Displays: 04:44:01 INFO - Display: 04:44:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:44:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:44:01 INFO - Display Serial Number: 1600x1200 60 04:44:01 INFO - Main Display: Yes 04:44:01 INFO - Mirror: Off 04:44:01 INFO - Online: Yes 04:44:01 INFO - Rotation: Supported 04:44:01 INFO - Return code: 0 04:44:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:44:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:44:01 INFO - Python 2.7.3 04:44:01 INFO - Return code: 0 04:44:01 INFO - grabbing minidump binary from tooltool 04:44:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:01 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 0x1046cce00>, '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 0x1044f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046c7b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:44:01 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 04:44:01 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 04:44:01 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:44:01 INFO - Return code: 0 04:44:01 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:44:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:44:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:44:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:44:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:44:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:44:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:44:03 INFO - Return code: 0 04:44:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.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_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:44:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.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_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:44:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Npw9aSOVsW/Render', 04:44:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:03 INFO - 'HOME': '/Users/cltbld', 04:44:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:03 INFO - 'LOGNAME': 'cltbld', 04:44:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:44:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:44:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:03 INFO - 'MOZ_NO_REMOTE': '1', 04:44:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:44:03 INFO - 'NO_EM_RESTART': '1', 04:44:03 INFO - 'PAGER': '/bin/cat', 04:44:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:03 INFO - 'PWD': '/builds/slave/test', 04:44:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:44:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:03 INFO - 'SHELL': '/bin/bash', 04:44:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ux9uyV21Zx/Listeners', 04:44:03 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 04:44:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:03 INFO - 'USER': 'cltbld', 04:44:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:03 INFO - 'XPC_FLAGS': '0x0', 04:44:03 INFO - 'XPC_SERVICE_NAME': '0', 04:44:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.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_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:44:03 INFO - mozversion application_buildid: 20160406030021 04:44:03 INFO - mozversion application_changeset: 68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8 04:44:03 INFO - mozversion application_display_name: Nightly 04:44:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:44:03 INFO - mozversion application_name: Firefox 04:44:03 INFO - mozversion application_remotingname: firefox 04:44:03 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:44:03 INFO - mozversion application_vendor: Mozilla 04:44:03 INFO - mozversion application_version: 48.0a1 04:44:03 INFO - mozversion platform_buildid: 20160406030021 04:44:03 INFO - mozversion platform_changeset: 68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8 04:44:03 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:44:03 INFO - mozversion platform_version: 48.0a1 04:44:03 INFO - using testdate: 1460029443 04:44:03 INFO - actual date: 1460029443 04:44:03 INFO - starting webserver on 'localhost:49672' 04:44:03 INFO - SUITE-START | Running 2 tests 04:44:03 INFO - TEST-START | dromaeo_css 04:44:03 INFO - operating with platform_type : mac_ 04:44:03 INFO - Initialising browser for dromaeo_css test... 04:44:03 INFO - TEST-INFO | started process 2350 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmplEyJWA/profile http://localhost:49672/getInfo.html) 04:44:05 INFO - PROCESS | 2350 | __metrics Screen width/height:1600/1200 04:44:05 INFO - PROCESS | 2350 | colorDepth:24 04:44:05 INFO - PROCESS | 2350 | Browser inner width/height: 1024/689 04:44:05 INFO - PROCESS | 2350 | __metrics 04:44:05 INFO - PROCESS | 2350 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:44:05 ERROR - PROCESS | 2350 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:44:06 INFO - TEST-INFO | 2350: exit 0 04:44:06 INFO - Browser initialized. 04:44:06 INFO - Running cycle 1/1 for dromaeo_css test... 04:44:06 INFO - TEST-INFO | started process 2352 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmplEyJWA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:44:17 INFO - PROCESS | 2352 | RSS: Main: 236437504 04:44:17 INFO - PROCESS | 2352 | 04:45:08 INFO - PROCESS | 2352 | 1460029508917 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] 04:47:19 INFO - PROCESS | 2352 | Cycle 1(1): loaded http://localhost:49672/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49672/tests/dromaeo/cssquery-ext.html) 04:47:20 INFO - PROCESS | 2352 | RSS: Main: 374722560 04:47:20 INFO - PROCESS | 2352 | 04:50:23 INFO - PROCESS | 2352 | Cycle 1(1): loaded http://localhost:49672/tests/dromaeo/cssquery-ext.html (next: http://localhost:49672/tests/dromaeo/cssquery-jquery.html) 04:50:23 INFO - PROCESS | 2352 | RSS: Main: 366276608 04:50:23 INFO - PROCESS | 2352 | 04:53:25 INFO - PROCESS | 2352 | Cycle 1(1): loaded http://localhost:49672/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49672/tests/dromaeo/cssquery-mootools.html) 04:53:26 INFO - PROCESS | 2352 | RSS: Main: 365441024 04:53:26 INFO - PROCESS | 2352 | 04:56:28 INFO - PROCESS | 2352 | Cycle 1(1): loaded http://localhost:49672/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49672/tests/dromaeo/cssquery-prototype.html) 04:56:28 INFO - PROCESS | 2352 | RSS: Main: 324730880 04:56:28 INFO - PROCESS | 2352 | 04:59:31 INFO - PROCESS | 2352 | Cycle 1(1): loaded http://localhost:49672/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49672/tests/dromaeo/cssquery-yui.html) 04:59:32 INFO - PROCESS | 2352 | RSS: Main: 325988352 04:59:32 INFO - PROCESS | 2352 | 05:02:35 INFO - PROCESS | 2352 | Cycle 1(1): loaded http://localhost:49672/tests/dromaeo/cssquery-yui.html (next: http://localhost:49672/tests/dromaeo/cssquery-dojo.html) 05:02:35 INFO - PROCESS | 2352 | RSS: Main: 391593984 05:02:35 INFO - PROCESS | 2352 | 05:02:35 INFO - PROCESS | 2352 | __start_tp_report 05:02:35 INFO - PROCESS | 2352 | _x_x_mozilla_page_load 05:02:35 INFO - PROCESS | 2352 | _x_x_mozilla_page_load_details 05:02:35 INFO - PROCESS | 2352 | |i|pagename|runs| 05:02:35 INFO - PROCESS | 2352 | |0;dojo.html;3348.8827891023816;3447.603525594556;3476.6001909780366;3485.860565577377;3524.4537096750014;4474.686771925966;5620.550355971523;5725.914111288329;5730;5742.109972954188;5678.48893599576;5701.230333904921;5762.078067509199;5855.121731740241;5877.735501902424;5102.260172275018;5132.076226279269;5160.8709782255555;5165.070287348276;5264.973675131619;5231.372235331765;5272.789088436458;5275.6043296752705;5279.973600131994;5327.760250788724;5110.1312776827845;5156.278121063054;5212.218167274901;5246.737663116829;5255.710935898524;5196.324477817897;5197.090509160882;5202.92195617066;5215.739213039333;5245.186996015624;4631;4873.854644158655;5171.3277273954145;5188.584913206934;5232.947670523322;5567.610267281292;5645.661260324394;5679.574031947621;5694.060480020791;5724.685142317171;6269.216347956505;6277.497800175975;6278.089676996809;6299.0551417287315;6309.305976342599;6284.780032698879;6331.33520980295;6350.364963503659;6355.745770169187;6360.491160707133;5709.571782116358;5723.313202415737;5790;5797.507211886995;5804.593678442468;6218.31598524162;6231.532635052389;6283.937160628427;6287.931051721218;6319.968400158062;6094.7432096071825;6157.692115394212;6168.814935551941;6169.629822210682;6170.043643235305;6220.533459990519;6254.8123556293385;6274.968625156845;6278.717457714322;6289.182406287245;6135.140800782589;6137.41694539018;6184.938150618436;6208.72060757267;6227.283862355796;6238.625682459067;6277.654728989858;6280.874382512324;6301;6305.716242769086;4902.901941961212;4904.190808516555;4905.166121759309;4910.508949105061;4929.162042452792;4305.806238719265;4443.911121777546;4458.130664520388;4460.8661740147845;4462.48681401643;5607.66354018752;5635.070213414822;5644.520215781622;5652.0391533439415;5656.830295091154;6197.318294987548;6226.906596401058;6237.812865614039;6248.250209974741;6335.809925702236;5638.802641907513;5645.463680950304;5656.575756818255;5673.404292549306;5696.316442026983;5286.7356632169;5337.62636615441;5346.8128615499045;5377.247185394048;5413.079776437936;6191.628502289877;6192.783252586138;6302.905456418157;6333.2400111985935;6337.397947195009;6297.779577714758;6310.7475700971445;6319.873602528016;6321.462675672436;6335.651539165206;6198.318184999556;6247.562670613013;6298.149749783904;6304.464120549805;6321.557490975588;6133.877322453615;6155.169052177898;6214.254289485109;6216.098665693539;6239.064140378798;6274.874502510015;6279.340669229848;6286.905696414466;6289.874202516015;6301.495880329654;5986.580939334205;6102.328743838263;6111.572189946839;6155.96922015405;6158.507319414526;6121.392004143408;6125.632462052291;6130.734471166674;6131.284916201153;6133.579501509301;5909.3795151508475;5947.375525569752;5960.8807823844145;5970.910436343372;6002.33974262822;5942.940570594239;6084.69576521181;6116.853194528166;6159.784407545893;6169.1054797053275;6035.396460354105;6036.63780173191;6039.094135879654;6041.0636351363855;6068.666223357758 05:02:35 INFO - PROCESS | 2352 | |1;ext.html;484.0512595313186;569.2400645138739;578.9247397838278;631.930487646359;637.7162162837536;26991.865040674795;37780.81109594452;38270.8086459568;38336.42495362565;38501;41276.79361603188;41721.956951076165;41787.164256714845;41796.74609761712;41825.16349673005;9401.858972115406;9651.324407291493;9651.951740241324;9655.5172241388;9667.226621870268;9457.33798634096;9474.573644185994;9596.992315806845;9602.183814375787;9603.423794572313;9564;9675.516224188797;9740.269479789044;9767.609295628166;9769.560369783378;8909;9680.370775899579;9721.513924303756;9721.756956076084;9739.853902191473;9560.904390956071;9676.516174191262;9686.854697179548;9696.563654635487;9706.369086009387;40410.59589404098;40725.59274407248;40820.97947551305;40853.978650533674;40885.38671919923;3228.322052369005;3263.151580589064;3347.4811404232382;3390.2541440882965;3428.2800611871535;28644.856775716198;28917.66235064757;28962.27594310159;29387.85306073456;29480.820767169287;2696.272006558238;2715.497632937913;2736.4390299988454;2833.7874659400627;2878.975300267362;482414;484320.5783971093;485092;485206.99999999645;485384;63655.36344636494;64085;64318.678406607665;64501.677491612245;64768.35231647623;59047.70476147592;73073.63463182756;73162.90255646169;73169;73170.9024364635;16092.678146437005;16281.430149944932;16301;16304;16315.83684163167;12451.25292482454;12525.93737031309;12534.185277956904;12536.247825130338;12548.749025019448;20799.79200208009;21119.78880211209;21130.78869211319;21144.365669029954;21622.243221487173;7196.748113815991;7683.116441609175;8714.389992700577;8915.910840891638;8933.776655583662;978.3689520259393;1025.74869157057;1033.751899544104;1079.794838980591;1153.7346410325672;28811.711882880903;29167;29234;29491.820327186673;29748.55377169344;1070.5289672544056;1084.9891501084887;1095.1293721491434;1098.8296813993843;1156.4564654612318;13343.399547020408;14367.425302987973;14653.413863445556;14939.551813445614;15474.381024759108;649494;653436;660157;661406;661654;60959;61491.38508614856;61564;61603.6919815407;61604.69197654073;1325.9801102983463;1445.2412483446276;1448.826140863103;1484.9925750371394;1617.0217018703515;29854.70145298519;30304.39391212119;30426.141316530277;30554.862407298493;30701.385972280877;48361.50396688519;48399.75800120977;48824.511754882;48870.51129488659;49046;341338;405629;413601;413818;414188;23152.884235578713;28428.147155585364;33400.66397344176;33761;34126.31747365089;39688.40467393049;40373.798131009156;40381.596184037786;41116.38325425181;41846.790766045975;33876;34143.317133657685;34168.48747268843;34594;34871;33919.15202119967;34397.65602343944;34471.31057378888;35412.64587354093;35910.64089359073;30045.549316760702;34792.82603586966;35349.646503534634;35746;35814.46278305775;31038.37923241568;31378.686213137575;31417.528737068504;31419.84290078535;31483.212919677193;23219.678032196643;24270.393240168432;24328.391790205387;25003;25387.746122539276 05:02:35 INFO - PROCESS | 2352 | |2;jquery.html;359.8776416018554;359.98740044098463;367.65073180478544;368.2212121363316;372.78192257529344;19171.712424313646;19664.705029424553;19994.30019949302;20391.490212744688;20457;19450.70823937642;20093.698594521094;20380.879051652155;20706.378808635727;20744.585108297826;5780.653160810344;5949.988501954678;5999;6006;6007.429294217064;4225.323948168294;4280.5719428057255;4576.748278844662;5021.221710634857;6560.671966401685;5316.362036555619;6511.3488651134985;6518.804435866908;6547.017947307918;6549.083128362033;6161.383861613847;6444.806655800334;6461.8061458156335;6514.055461958037;6537.901931471008;5445.373782015079;5526.50261476469;5538.196961440609;5546.861328466821;5554.888902221933;24322.391940201458;24993.62509562358;25294.87352563244;25380.873095634404;25431.491370172494;2460.6801115855005;2879.1218678303107;2893.42131573684;2949.5575663650625;3055.2056465318956;11277.605283815026;14232.715345693028;14414.351354189086;14482.855171448362;14487.203203823785;1654.4374912529797;1690.9492715218564;1698.5838469575033;1718.5102245859996;1733.8439540441295;98455.50772246093;100892.49553752184;101507;101670;102017.46973795399;9876.234654296808;10095.343802652951;10195.337303075275;10217.671702678605;10277.075063244343;12557.74884502323;12567.93716031414;12600.873991260154;12602.558910438274;12661.36693165338;8102.270795628422;8265.338772898154;8269.586520673942;8355.03917049547;8361.540115293596;8431.114732952952;8513.446625969293;8520.786980325542;8620.784480387914;8627.482351058956;5946.10808378738;5954.791582294599;5959.791407300723;5966.85082872923;5972.432618901197;1563.3746501399303;1664.267722202227;1791.8387345139;1792.5787439951862;1798.9910050449926;384.66149788186215;419.26837668269064;424.27660838270674;794.7178751543119;923.4320892651106;11270;11743.236689615147;11779.293242405483;11886.940565297118;11934;439.86734159539316;441.5496193882222;443.1380964025005;457.06758213245274;465.43217274924535;5416.268803711528;6044.9395506044375;6130.448259656652;6141.293751218578;6158.538109641795;506336;609019;615502;629256;632697;84871;103017;105530.47234763777;112449;114264;432.56311125763204;450.8174189453277;467.13113608687814;469.2562288772266;471.09784762180726;10839.729006774578;10925.890741092488;11042.668719938414;11122.88877111251;11156.44217789091;46931.53068469271;46981;47310;47360.052798943136;47972.7601361991;64243;72033.55932881418;72130.27869721236;72608.63695681699;72909.27090729238;7435.330820226206;7655.808604784925;7774.339181169664;7794.986651735238;7950.363970882431;9457.527123643928;11341;12252.816207756712;12358;12565.120441569003;9268.490233037248;10603.257771955889;10679.78131163105;10846.794516719636;10897;10229.74425639365;10397.428141452292;10699.94650026745;10749.086327662237;11007.284526505751;10585.311954722918;10886.401247931122;10950.945245273722;11064;11076;7463.962680186564;7585.886211706718;7628.42786791004;7638.083429988437;7893.605319733875;8056.83886322282;10530.684079477627;10784.19118566095;10790.568377265135;10822.621208257673 05:02:35 INFO - PROCESS | 2352 | |3;mootools.html;1571.9292631831565;1601.9118948457838;1862.7764668239804;1935.7096435534659;2000.2099170827514;8647.610857511412;8708.172723591264;8854.513001784899;8870.46777193368;8881.023087460375;7215.314545118218;7753;7931.127575966639;8502.91497085029;8722.433041852275;2416.8549887006748;2457.0294733580226;2459.8401103928277;2462.753724627541;2463.938401539958;2153.720016397866;2420.5312025489825;2465.4452748131616;2472.9629055564183;2479.4917042006437;2158.0936006877073;2197.7802219778055;2200.515886504966;2400.867952262625;2459.606462965926;2358.84667496613;2422.261210330857;2435.817313701462;2438.0979037755965;2439.3901524618846;2355.9175428859908;2411.4333131714034;2413.4207790130417;2416.9274921752376;2422.2491027781266;8752.387332886701;8807.867881981776;8871.24594409476;8871.604666740008;8872.11278872114;5360.303160589137;5464.590155738296;5514.283143191399;5554.028045092133;5554.333479982388;3474.8262586870555;3475.131217195701;3653.926921461556;3655.3603119453987;3669.3030622492447;1034.4103860799348;1038.5638032026568;1039.070032321076;1053.1416895230363;1065.5471424644572;11840.171188016757;11906.880931190664;11906.880931190664;11907;11998.880011199864;4717.908199797495;4802.759862006886;4847.394075740533;4866.46468888422;4883.804647814048;9999.950000249952;10077.848832267522;10078.59685612582;10092.74768130788;10104;5407.945450637088;5457.890842183214;5464.3442786865835;5467.125259958388;5470.261514695465;4325.961769175438;4828.686135401258;4942.5304596063315;4998.350214472168;4999.550040496373;3698.6116457772087;3702.777833330009;3711.92354217274;3741.2330472253125;3749.1376983293994;1180.6044974933322;1183.9348835814112;1195.1275568834799;1196.2642974570576;1201.6875612340855;987.1609132237684;988.0267936082953;1014.3052009373603;1033.4987531047586;1107.5680484611007;7839.25527074927;8072.8385432291025;8077.313428358538;8083.838323233503;8087.797805054921;1183.662656142995;1199.1785626845638;1199.3703305764543;1203.8615559210627;1235.308227392645;6259.78090766821;6266.216722909637;6335.936640633627;6339.270983836917;6350.110984462179;10527.631532896312;10903.34579925207;11012.944935275433;11014.944925275482;11018.779624407467;10542.789144217073;10785.514651840685;10869.945650271698;10870;10887.23789334739;8190.918090819135;8378.581070946428;8428.789280268042;8438.704645337384;8440.57797110142;7789.883151752615;7856.7250146244605;7907.2488113629115;7928.84142317162;7930.563818990011;9202.953985230031;9466.242700584075;9722.75693107678;9723.611055557698;9741.123298903132;9733.124018838338;9946.751331216778;9961.950190249003;10052.44711540843;10110.747231319276;6941.687624056828;7024.086868707035;7049.224585295716;7741.380689544935;7929;8242.752717418487;8279.95860020696;8293.83412331762;8313.168683131638;8326.916730832856;7225.891611625935;7310.342069213796;7334.926650733424;7516.098068231847;7541.019667443197;6212.285587157535;7144.464165187528;7199.1361036675935;7270.527415717961;7372.115346158495;7588.165301816685;7697.923020769721;7705.113911899979;7705.499142555716;7706.961465192639;6790.354916282945;6881.311868813279;6903.447724182154;6903.620300883299;6923.792286231421;6866.588004719732;7042.859142817012;7048.436125110082;7064;7093.716251349888 05:02:35 INFO - PROCESS | 2352 | |4;prototype.html;318.4951851315665;319.72982829509056;324.3011310625603;324.9756268279878;330.08566271428157;5166.302549155863;6475.255345635253;6536.771213007546;6538.967305163474;6546.149000629917;6350.110984462179;6444.806655800322;6453.225612926455;6466.900626893427;6472.9029064564065;4234.877757394285;4252.702310838243;4647.256438969765;4734.786934587952;4791.856244312658;3822.503074600298;4730.645201609876;4734.6685731998605;4756.738379389132;4761.119192949298;4698.90602187956;4710.246360582308;4710.670253082286;4717.457492388367;4726.881827954294;4512.932306015412;4613.077384523109;4693.859184224479;4725.952740472586;4734.053189362141;4072.1448495815916;4077.1234184650443;4080.367543030835;4087.4686290782306;4104.4664193654935;6083.756649734005;6159.3224745277985;6165.445109940127;6182.5363097767395;6207.6275423474735;5585.162225666142;5598.076317407623;5599.412061733541;5601.887962240773;5604.775808967636;6857.931420685779;6861.348171923659;6862.656867156672;6863.691133898987;6875.965620171917;4292.29177185764;4456.46522417312;4457.710248833815;4464.6428285737065;4465.82136714531;5884.676342801187;7067.823304417379;7278.672459739324;7284.417246620258;7300.890486642705;3946.2699400610977;4554.521775213621;4562.178807814559;4562.292844609091;4565.931511027337;4612.3542704021465;4622.306654001926;4622.352870598119;4625.283081122431;4635.2120139576355;5469.288992431038;5480.177973303957;5480.3971563128025;5481.177823326453;5481.643693159932;6636.469082473391;6863.2793556676825;6901.240863505011;6906.447484201251;6921;1312.2913626641507;1577.597712583284;1583.8891277610687;1594.6970075685583;1595.7446808510583;957.129012598546;1002.6691191906654;1006.4866917871938;1026.8870424253325;1031.5306535526317;6206.565540412128;6307.653079080603;6497.805065848032;6525.510586706016;6635.900461493082;7214.855702885913;7238.963805181046;7257.52826066304;7265.09186351706;7275.708971641075;6460.127882735865;6461.676916154173;6463.935360646427;6471.158749362647;6480.837979050467;3779.3197224499854;3816.2749077675153;3818.6181381861593;3825.713071519647;3828.1003964068423;7226.205117437078;7513.661885215179;7532.7740167795055;7534.3595794357;7537.170911199763;7378.114626244885;7396.852062958711;7413.740519081806;7422.443316751265;7434.665440055211;7489.475736698488;7509.098908131059;7512.737054203077;7517.17311095779;7539.283768042027;5813.709314534171;6869.587824730532;7168.928310716826;7171.1394632644415;7179.066721326194;7060.823479413056;7067.151941767021;7068.71725130989;7076.575405475688;7092.468064895051;7444.888326674996;7494.775156745306;7499;7507.249275072449;7510.061242344707;3881.8835434936996;4098.9342770880385;4168.24971505132;4464.3973063637295;4472.9105417892115;7083.327083927019;7104.644767761694;7116.786496405116;7121.323474269936;7131.82324916383;6576.177977752781;6958.234594194736;6960.686769095504;6966.686499107451;6969.58182509051;6888.896666549906;6937.687804048729;6948.756793512202;6952.270011648907;6965.860682786417;6766.4248538874745;6768.221654509597;6772.221194562689;6786.287439818748;6787.389134977876;5959.463648271676;6607.239114376418;6934.133233345832;6938.5143039986715;6941.583504989717;5900.734466949083;6669.433098186514;6702.36327548882;6747.730090796509;6802.01370801241 05:02:35 INFO - PROCESS | 2352 | |5;yui.html;672.1799404726233;736.4513437489068;744.2148533297373;754.2871985973258;755.5768769489086;14826.629334266649;14901;15147.77278340823;15157.772633410494;15183;13920.30398480077;14117;14128.22294773787;14137.151770893754;14145.222012789318;743.6579173580133;754.581207429879;901.4636291406603;932.0446542294169;933.9206167475738;749.887516872468;755.0109356742685;755.6977209116343;904.8054668246326;928.9502861766194;967.5936106835146;969.3747532841313;971.3491960386558;972.0182615558266;974.2887691984855;961.8509131084693;962.5139304651176;964.4213471916864;965.3098034905006;967.1440774914216;565.666256908426;573.5497634357051;573.8565358660335;704.3660705365161;717.5622870049266;14967.625809354744;15007;15049.172295523742;15055;15076.849231507655;12527.310997895112;12584.622461326175;12585;12688.936555317257;12772.61682149537;8730.646749753798;9827.213822894151;9921.950390248076;9965.75085622858;10246.18030557561;3317.2370354818527;3532.8410221540094;3629.764065335745;3636.909077273063;3693.9076523087138;78498.60750696267;78597;78958;79237;79705.20294797036;9433.292503062297;9465;9573.808523829484;9644.373115747454;9797.951010244904;20310.593788124155;21617.67573486399;21650.891745541172;21751.78248217529;21796.564068718537;7427.888581671279;7485.663145158481;7491.700331986768;7552.131504876899;7649.082110146818;4071.185762847442;4119.97940010298;4223.155368926227;4253.21315556623;4284.1645879053285;3522.031441353597;3574.0171452850673;3574.088607405095;3575.481555174485;3580.749347545699;645.2740666749906;661.5270081891471;663;666.4801454865213;682.1643486728817;582.020057306593;593.77139801176;595.3867516458055;606.1725744358919;611.6727550760322;7806.68773249075;8093.757187284391;8158.632861521246;8251.463654862415;8349.874751878726;422.5964204184996;526.5445389737926;537.3283395755305;551.4650788734921;551.7517117297232;3775.905602359963;3786.6213378661914;3833.9424908626393;3858.112634094174;3879.728419010642;86931.56534217288;88069.55965220132;89269;89393;89637.55181224183;73415.53168936592;73990.26009739941;74933.62533187299;75762;75995.62002189954;62090.68954655288;62892;63381.04928426077;64056.03915941265;67671.99999999901;7580.752135736824;7639.083310002835;7659.502132361378;7820.804479888048;7971.362291016821;44031;44686.10627787491;45482.09035819199;45821.77089114533;45991.850203745176;56808.43191568032;69418.65290673514;69470;69790.25524361932;70425.59148817098;10777.784444311226;10856.837147442953;10980.560777568808;11269.154813388865;11668.824967625662;12244.693882653006;12299.262044277371;12304.630861074182;12325.568605098779;12542.937285313516;11338.433078346216;11509;11599.681655391827;11817.940910295394;11907.76184476323;11463.254888432226;11492.195546311677;11605.76788464243;11800.232984855957;11825.172237943261;11140.442977850913;11456.599019034295;11489.482973266056;11618.572521106125;12263.509459621515;9386.906130938603;9577.220019376067;9648.276379271723;9700.805983880142;9816.018398160413;8081.313088387553;8616.698415555426;8883.911160888309;9662;9680.27397945143 05:02:35 INFO - PROCESS | 2352 | __end_tp_report 05:02:35 INFO - PROCESS | 2352 | __start_cc_report 05:02:35 INFO - PROCESS | 2352 | _x_x_mozilla_cycle_collect,1342 05:02:35 INFO - PROCESS | 2352 | __end_cc_report 05:02:35 INFO - PROCESS | 2352 | __startTimestamp1460030555671__endTimestamp 05:02:35 INFO - PROCESS | 2352 | 05:02:35 INFO - PROCESS | 2352 | ------- Summary: start ------- 05:02:35 INFO - PROCESS | 2352 | Number of tests: 6 05:02:35 INFO - PROCESS | 2352 | 05:02:35 INFO - PROCESS | 2352 | [#0] dojo.html Cycles:165 Average:5747.37 Median:6035.40 stddev:652.06 (10.8%) stddev-sans-first:626.33 05:02:35 INFO - PROCESS | 2352 | Values: 3348.9 3447.6 3476.6 3485.9 3524.5 4474.7 5620.6 5725.9 5730.0 5742.1 5678.5 5701.2 5762.1 5855.1 5877.7 5102.3 5132.1 5160.9 5165.1 5265.0 5231.4 5272.8 5275.6 5280.0 5327.8 5110.1 5156.3 5212.2 5246.7 5255.7 5196.3 5197.1 5202.9 5215.7 5245.2 4631.0 4873.9 5171.3 5188.6 5232.9 5567.6 5645.7 5679.6 5694.1 5724.7 6269.2 6277.5 6278.1 6299.1 6309.3 6284.8 6331.3 6350.4 6355.7 6360.5 5709.6 5723.3 5790.0 5797.5 5804.6 6218.3 6231.5 6283.9 6287.9 6320.0 6094.7 6157.7 6168.8 6169.6 6170.0 6220.5 6254.8 6275.0 6278.7 6289.2 6135.1 6137.4 6184.9 6208.7 6227.3 6238.6 6277.7 6280.9 6301.0 6305.7 4902.9 4904.2 4905.2 4910.5 4929.2 4305.8 4443.9 4458.1 4460.9 4462.5 5607.7 5635.1 5644.5 5652.0 5656.8 6197.3 6226.9 6237.8 6248.3 6335.8 5638.8 5645.5 5656.6 5673.4 5696.3 5286.7 5337.6 5346.8 5377.2 5413.1 6191.6 6192.8 6302.9 6333.2 6337.4 6297.8 6310.7 6319.9 6321.5 6335.7 6198.3 6247.6 6298.1 6304.5 6321.6 6133.9 6155.2 6214.3 6216.1 6239.1 6274.9 6279.3 6286.9 6289.9 6301.5 5986.6 6102.3 6111.6 6156.0 6158.5 6121.4 6125.6 6130.7 6131.3 6133.6 5909.4 5947.4 5960.9 5970.9 6002.3 5942.9 6084.7 6116.9 6159.8 6169.1 6035.4 6036.6 6039.1 6041.1 6068.7 05:02:35 INFO - PROCESS | 2352 | 05:02:35 INFO - PROCESS | 2352 | [#1] ext.html Cycles:180 Average:65361.42 Median:36845.73 stddev:140219.34 (380.6%) stddev-sans-first:140528.09 05:02:35 INFO - PROCESS | 2352 | Values: 484.1 569.2 578.9 631.9 637.7 26991.9 37780.8 38270.8 38336.4 38501.0 41276.8 41722.0 41787.2 41796.7 41825.2 9401.9 9651.3 9652.0 9655.5 9667.2 9457.3 9474.6 9597.0 9602.2 9603.4 9564.0 9675.5 9740.3 9767.6 9769.6 8909.0 9680.4 9721.5 9721.8 9739.9 9560.9 9676.5 9686.9 9696.6 9706.4 40410.6 40725.6 40821.0 40854.0 40885.4 3228.3 3263.2 3347.5 3390.3 3428.3 28644.9 28917.7 28962.3 29387.9 29480.8 2696.3 2715.5 2736.4 2833.8 2879.0 482414.0 484320.6 485092.0 485207.0 485384.0 63655.4 64085.0 64318.7 64501.7 64768.4 59047.7 73073.6 73162.9 73169.0 73170.9 16092.7 16281.4 16301.0 16304.0 16315.8 12451.3 12525.9 12534.2 12536.2 12548.7 20799.8 21119.8 21130.8 21144.4 21622.2 7196.7 7683.1 8714.4 8915.9 8933.8 978.4 1025.7 1033.8 1079.8 1153.7 28811.7 29167.0 29234.0 29491.8 29748.6 1070.5 1085.0 1095.1 1098.8 1156.5 13343.4 14367.4 14653.4 14939.6 15474.4 649494.0 653436.0 660157.0 661406.0 661654.0 60959.0 61491.4 61564.0 61603.7 61604.7 1326.0 1445.2 1448.8 1485.0 1617.0 29854.7 30304.4 30426.1 30554.9 30701.4 48361.5 48399.8 48824.5 48870.5 49046.0 341338.0 405629.0 413601.0 413818.0 414188.0 23152.9 28428.1 33400.7 33761.0 34126.3 39688.4 40373.8 40381.6 41116.4 41846.8 33876.0 34143.3 34168.5 34594.0 34871.0 33919.2 34397.7 34471.3 35412.6 35910.6 30045.5 34792.8 35349.6 35746.0 35814.5 31038.4 31378.7 31417.5 31419.8 31483.2 23219.7 24270.4 24328.4 25003.0 25387.7 05:02:35 INFO - PROCESS | 2352 | 05:02:35 INFO - PROCESS | 2352 | [#2] jquery.html Cycles:180 Average:32813.40 Median:2322.30 stddev:99347.24 (4278.0%) stddev-sans-first:99596.05 05:02:35 INFO - PROCESS | 2352 | Values: 359.9 360.0 367.7 368.2 372.8 19171.7 19664.7 19994.3 20391.5 20457.0 19450.7 20093.7 20380.9 20706.4 20744.6 5780.7 5950.0 5999.0 6006.0 6007.4 4225.3 4280.6 4576.7 5021.2 6560.7 5316.4 6511.3 6518.8 6547.0 6549.1 6161.4 6444.8 6461.8 6514.1 6537.9 5445.4 5526.5 5538.2 5546.9 5554.9 24322.4 24993.6 25294.9 25380.9 25431.5 2460.7 2879.1 2893.4 2949.6 3055.2 11277.6 14232.7 14414.4 14482.9 14487.2 1654.4 1690.9 1698.6 1718.5 1733.8 98455.5 100892.5 101507.0 101670.0 102017.5 9876.2 10095.3 10195.3 10217.7 10277.1 12557.7 12567.9 12600.9 12602.6 12661.4 8102.3 8265.3 8269.6 8355.0 8361.5 8431.1 8513.4 8520.8 8620.8 8627.5 5946.1 5954.8 5959.8 5966.9 5972.4 1563.4 1664.3 1791.8 1792.6 1799.0 384.7 419.3 424.3 794.7 923.4 11270.0 11743.2 11779.3 11886.9 11934.0 439.9 441.5 443.1 457.1 465.4 5416.3 6044.9 6130.4 6141.3 6158.5 506336.0 609019.0 615502.0 629256.0 632697.0 84871.0 103017.0 105530.5 112449.0 114264.0 432.6 450.8 467.1 469.3 471.1 10839.7 10925.9 11042.7 11122.9 11156.4 46931.5 46981.0 47310.0 47360.1 47972.8 64243.0 72033.6 72130.3 72608.6 72909.3 7435.3 7655.8 7774.3 7795.0 7950.4 9457.5 11341.0 12252.8 12358.0 12565.1 9268.5 10603.3 10679.8 10846.8 10897.0 10229.7 10397.4 10699.9 10749.1 11007.3 10585.3 10886.4 10950.9 11064.0 11076.0 7464.0 7585.9 7628.4 7638.1 7893.6 8056.8 10530.7 10784.2 10790.6 10822.6 05:02:35 INFO - PROCESS | 2352 | 05:02:35 INFO - PROCESS | 2352 | [#3] mootools.html Cycles:180 Average:6033.45 Median:5432.92 stddev:3207.97 (59.0%) stddev-sans-first:3199.44 05:02:35 INFO - PROCESS | 2352 | Values: 1571.9 1601.9 1862.8 1935.7 2000.2 8647.6 8708.2 8854.5 8870.5 8881.0 7215.3 7753.0 7931.1 8502.9 8722.4 2416.9 2457.0 2459.8 2462.8 2463.9 2153.7 2420.5 2465.4 2473.0 2479.5 2158.1 2197.8 2200.5 2400.9 2459.6 2358.8 2422.3 2435.8 2438.1 2439.4 2355.9 2411.4 2413.4 2416.9 2422.2 8752.4 8807.9 8871.2 8871.6 8872.1 5360.3 5464.6 5514.3 5554.0 5554.3 3474.8 3475.1 3653.9 3655.4 3669.3 1034.4 1038.6 1039.1 1053.1 1065.5 11840.2 11906.9 11906.9 11907.0 11998.9 4717.9 4802.8 4847.4 4866.5 4883.8 10000.0 10077.8 10078.6 10092.7 10104.0 5407.9 5457.9 5464.3 5467.1 5470.3 4326.0 4828.7 4942.5 4998.4 4999.6 3698.6 3702.8 3711.9 3741.2 3749.1 1180.6 1183.9 1195.1 1196.3 1201.7 987.2 988.0 1014.3 1033.5 1107.6 7839.3 8072.8 8077.3 8083.8 8087.8 1183.7 1199.2 1199.4 1203.9 1235.3 6259.8 6266.2 6335.9 6339.3 6350.1 10527.6 10903.3 11012.9 11014.9 11018.8 10542.8 10785.5 10869.9 10870.0 10887.2 8190.9 8378.6 8428.8 8438.7 8440.6 7789.9 7856.7 7907.2 7928.8 7930.6 9203.0 9466.2 9722.8 9723.6 9741.1 9733.1 9946.8 9962.0 10052.4 10110.7 6941.7 7024.1 7049.2 7741.4 7929.0 8242.8 8280.0 8293.8 8313.2 8326.9 7225.9 7310.3 7334.9 7516.1 7541.0 6212.3 7144.5 7199.1 7270.5 7372.1 7588.2 7697.9 7705.1 7705.5 7707.0 6790.4 6881.3 6903.4 6903.6 6923.8 6866.6 7042.9 7048.4 7064.0 7093.7 05:02:35 INFO - PROCESS | 2352 | 05:02:35 INFO - PROCESS | 2352 | [#4] prototype.html Cycles:180 Average:5623.05 Median:6462.81 stddev:1827.39 (28.3%) stddev-sans-first:1788.61 05:02:35 INFO - PROCESS | 2352 | Values: 318.5 319.7 324.3 325.0 330.1 5166.3 6475.3 6536.8 6539.0 6546.1 6350.1 6444.8 6453.2 6466.9 6472.9 4234.9 4252.7 4647.3 4734.8 4791.9 3822.5 4730.6 4734.7 4756.7 4761.1 4698.9 4710.2 4710.7 4717.5 4726.9 4512.9 4613.1 4693.9 4726.0 4734.1 4072.1 4077.1 4080.4 4087.5 4104.5 6083.8 6159.3 6165.4 6182.5 6207.6 5585.2 5598.1 5599.4 5601.9 5604.8 6857.9 6861.3 6862.7 6863.7 6876.0 4292.3 4456.5 4457.7 4464.6 4465.8 5884.7 7067.8 7278.7 7284.4 7300.9 3946.3 4554.5 4562.2 4562.3 4565.9 4612.4 4622.3 4622.4 4625.3 4635.2 5469.3 5480.2 5480.4 5481.2 5481.6 6636.5 6863.3 6901.2 6906.4 6921.0 1312.3 1577.6 1583.9 1594.7 1595.7 957.1 1002.7 1006.5 1026.9 1031.5 6206.6 6307.7 6497.8 6525.5 6635.9 7214.9 7239.0 7257.5 7265.1 7275.7 6460.1 6461.7 6463.9 6471.2 6480.8 3779.3 3816.3 3818.6 3825.7 3828.1 7226.2 7513.7 7532.8 7534.4 7537.2 7378.1 7396.9 7413.7 7422.4 7434.7 7489.5 7509.1 7512.7 7517.2 7539.3 5813.7 6869.6 7168.9 7171.1 7179.1 7060.8 7067.2 7068.7 7076.6 7092.5 7444.9 7494.8 7499.0 7507.2 7510.1 3881.9 4098.9 4168.2 4464.4 4472.9 7083.3 7104.6 7116.8 7121.3 7131.8 6576.2 6958.2 6960.7 6966.7 6969.6 6888.9 6937.7 6948.8 6952.3 6965.9 6766.4 6768.2 6772.2 6786.3 6787.4 5959.5 6607.2 6934.1 6938.5 6941.6 5900.7 6669.4 6702.4 6747.7 6802.0 05:02:35 INFO - PROCESS | 2352 | 05:02:35 INFO - PROCESS | 2352 | [#5] yui.html Cycles:180 Average:17739.82 Median:62491.34 stddev:24572.41 (39.3%) stddev-sans-first:24607.92 05:02:35 INFO - PROCESS | 2352 | Values: 672.2 736.5 744.2 754.3 755.6 14826.6 14901.0 15147.8 15157.8 15183.0 13920.3 14117.0 14128.2 14137.2 14145.2 743.7 754.6 901.5 932.0 933.9 749.9 755.0 755.7 904.8 929.0 967.6 969.4 971.3 972.0 974.3 961.9 962.5 964.4 965.3 967.1 565.7 573.5 573.9 704.4 717.6 14967.6 15007.0 15049.2 15055.0 15076.8 12527.3 12584.6 12585.0 12688.9 12772.6 8730.6 9827.2 9922.0 9965.8 10246.2 3317.2 3532.8 3629.8 3636.9 3693.9 78498.6 78597.0 78958.0 79237.0 79705.2 9433.3 9465.0 9573.8 9644.4 9798.0 20310.6 21617.7 21650.9 21751.8 21796.6 7427.9 7485.7 7491.7 7552.1 7649.1 4071.2 4120.0 4223.2 4253.2 4284.2 3522.0 3574.0 3574.1 3575.5 3580.7 645.3 661.5 663.0 666.5 682.2 582.0 593.8 595.4 606.2 611.7 7806.7 8093.8 8158.6 8251.5 8349.9 422.6 526.5 537.3 551.5 551.8 3775.9 3786.6 3833.9 3858.1 3879.7 86931.6 88069.6 89269.0 89393.0 89637.6 73415.5 73990.3 74933.6 75762.0 75995.6 62090.7 62892.0 63381.0 64056.0 67672.0 7580.8 7639.1 7659.5 7820.8 7971.4 44031.0 44686.1 45482.1 45821.8 45991.9 56808.4 69418.7 69470.0 69790.3 70425.6 10777.8 10856.8 10980.6 11269.2 11668.8 12244.7 12299.3 12304.6 12325.6 12542.9 11338.4 11509.0 11599.7 11817.9 11907.8 11463.3 11492.2 11605.8 11800.2 11825.2 11140.4 11456.6 11489.5 11618.6 12263.5 9386.9 9577.2 9648.3 9700.8 9816.0 8081.3 8616.7 8883.9 9662.0 9680.3 05:02:35 INFO - PROCESS | 2352 | -------- Summary: end -------- 05:02:35 INFO - PROCESS | 2352 | 05:02:36 INFO - TEST-INFO | 2352: exit 0 05:02:36 INFO - TEST-OK | dromaeo_css | took 1112733ms 05:02:36 INFO - TEST-START | kraken 05:02:36 INFO - operating with platform_type : mac_ 05:02:36 INFO - Initialising browser for kraken test... 05:02:36 INFO - TEST-INFO | started process 2355 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmplaK3RC/profile http://localhost:49672/getInfo.html) 05:02:38 INFO - PROCESS | 2355 | __metrics Screen width/height:1600/1200 05:02:38 INFO - PROCESS | 2355 | colorDepth:24 05:02:38 INFO - PROCESS | 2355 | Browser inner width/height: 1024/689 05:02:38 INFO - PROCESS | 2355 | __metrics 05:02:38 INFO - PROCESS | 2355 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:02:38 ERROR - PROCESS | 2355 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:02:38 INFO - TEST-INFO | 2355: exit 0 05:02:38 INFO - Browser initialized. 05:02:38 INFO - Running cycle 1/1 for kraken test... 05:02:38 INFO - TEST-INFO | started process 2357 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmplaK3RC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:02:50 INFO - PROCESS | 2357 | RSS: Main: 236638208 05:02:50 INFO - PROCESS | 2357 | 05:02:53 INFO - PROCESS | 2357 | Cycle 1(1): loaded http://localhost:49672/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49672/tests/kraken/driver.html?testName=audio-beat-detection) 05:02:53 INFO - PROCESS | 2357 | RSS: Main: 282873856 05:02:53 INFO - PROCESS | 2357 | 05:02:56 INFO - PROCESS | 2357 | Cycle 1(1): loaded http://localhost:49672/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49672/tests/kraken/driver.html?testName=audio-dft) 05:02:57 INFO - PROCESS | 2357 | RSS: Main: 293232640 05:02:57 INFO - PROCESS | 2357 | 05:03:00 INFO - PROCESS | 2357 | Cycle 1(1): loaded http://localhost:49672/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49672/tests/kraken/driver.html?testName=audio-fft) 05:03:01 INFO - PROCESS | 2357 | RSS: Main: 278663168 05:03:01 INFO - PROCESS | 2357 | 05:03:03 INFO - PROCESS | 2357 | Cycle 1(1): loaded http://localhost:49672/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49672/tests/kraken/driver.html?testName=audio-oscillator) 05:03:03 INFO - PROCESS | 2357 | RSS: Main: 281378816 05:03:03 INFO - PROCESS | 2357 | 05:03:05 INFO - PROCESS | 2357 | Cycle 1(1): loaded http://localhost:49672/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49672/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:03:06 INFO - PROCESS | 2357 | RSS: Main: 282357760 05:03:06 INFO - PROCESS | 2357 | 05:03:09 INFO - PROCESS | 2357 | Cycle 1(1): loaded http://localhost:49672/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49672/tests/kraken/driver.html?testName=imaging-darkroom) 05:03:09 INFO - PROCESS | 2357 | RSS: Main: 282574848 05:03:09 INFO - PROCESS | 2357 | 05:03:12 INFO - PROCESS | 2357 | Cycle 1(1): loaded http://localhost:49672/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49672/tests/kraken/driver.html?testName=imaging-desaturate) 05:03:13 INFO - PROCESS | 2357 | RSS: Main: 282759168 05:03:13 INFO - PROCESS | 2357 | 05:03:15 INFO - PROCESS | 2357 | Cycle 1(1): loaded http://localhost:49672/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49672/tests/kraken/driver.html?testName=json-parse-financial) 05:03:16 INFO - PROCESS | 2357 | RSS: Main: 283004928 05:03:16 INFO - PROCESS | 2357 | 05:03:18 INFO - PROCESS | 2357 | Cycle 1(1): loaded http://localhost:49672/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49672/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:03:18 INFO - PROCESS | 2357 | RSS: Main: 316706816 05:03:18 INFO - PROCESS | 2357 | 05:03:20 INFO - PROCESS | 2357 | Cycle 1(1): loaded http://localhost:49672/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49672/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:03:21 INFO - PROCESS | 2357 | RSS: Main: 316477440 05:03:21 INFO - PROCESS | 2357 | 05:03:23 INFO - PROCESS | 2357 | Cycle 1(1): loaded http://localhost:49672/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49672/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:03:24 INFO - PROCESS | 2357 | RSS: Main: 323346432 05:03:24 INFO - PROCESS | 2357 | 05:03:26 INFO - PROCESS | 2357 | Cycle 1(1): loaded http://localhost:49672/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49672/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:03:27 INFO - PROCESS | 2357 | RSS: Main: 324341760 05:03:27 INFO - PROCESS | 2357 | 05:03:29 INFO - PROCESS | 2357 | Cycle 1(1): loaded http://localhost:49672/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49672/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:03:30 INFO - PROCESS | 2357 | RSS: Main: 324460544 05:03:30 INFO - PROCESS | 2357 | 05:03:31 INFO - PROCESS | 2357 | Cycle 1(1): loaded http://localhost:49672/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49672/tests/kraken/driver.html?testName=ai-astar) 05:03:32 INFO - PROCESS | 2357 | RSS: Main: 387067904 05:03:32 INFO - PROCESS | 2357 | 05:03:32 INFO - PROCESS | 2357 | __start_tp_report 05:03:32 INFO - PROCESS | 2357 | _x_x_mozilla_page_load 05:03:32 INFO - PROCESS | 2357 | _x_x_mozilla_page_load_details 05:03:32 INFO - PROCESS | 2357 | |i|pagename|runs| 05:03:32 INFO - PROCESS | 2357 | |0;ai-astar;111;106;111;112;111;112;117;116;162;107 05:03:32 INFO - PROCESS | 2357 | |1;audio-beat-detection;159;127;148;166;120;143;143;121;163;118 05:03:32 INFO - PROCESS | 2357 | |2;audio-dft;190;189;187;188;184;187;187;186;186;221 05:03:32 INFO - PROCESS | 2357 | |3;audio-fft;76;85;86;80;55;58;55;80;80;55 05:03:32 INFO - PROCESS | 2357 | |4;audio-oscillator;93;91;126;78;79;83;120;112;120;158 05:03:32 INFO - PROCESS | 2357 | |5;imaging-gaussian-blur;90;85;89;87;89;85;90;85;88;85 05:03:32 INFO - PROCESS | 2357 | |6;imaging-darkroom;93;94;94;94;94;95;94;95;93;94 05:03:32 INFO - PROCESS | 2357 | |7;imaging-desaturate;85;85;87;83;87;88;85;84;87;86 05:03:32 INFO - PROCESS | 2357 | |8;json-parse-financial;55;55;54;54;53;54;54;65;55;52 05:03:32 INFO - PROCESS | 2357 | |9;json-stringify-tinderbox;65;70;81;79;78;71;69;93;104;104 05:03:32 INFO - PROCESS | 2357 | |10;stanford-crypto-aes;84;82;83;84;83;83;84;83;85;85 05:03:32 INFO - PROCESS | 2357 | |11;stanford-crypto-ccm;108;161;136;141;137;122;120;122;122;122 05:03:32 INFO - PROCESS | 2357 | |12;stanford-crypto-pbkdf2;145;131;140;137;141;129;141;140;138;138 05:03:32 INFO - PROCESS | 2357 | |13;stanford-crypto-sha256-iterative;68;67;70;67;66;68;67;68;68;67 05:03:32 INFO - PROCESS | 2357 | __end_tp_report 05:03:32 INFO - PROCESS | 2357 | __start_cc_report 05:03:32 INFO - PROCESS | 2357 | _x_x_mozilla_cycle_collect,1308 05:03:32 INFO - PROCESS | 2357 | __end_cc_report 05:03:32 INFO - PROCESS | 2357 | __startTimestamp1460030612243__endTimestamp 05:03:32 INFO - PROCESS | 2357 | 05:03:32 INFO - PROCESS | 2357 | ------- Summary: start ------- 05:03:32 INFO - PROCESS | 2357 | Number of tests: 14 05:03:32 INFO - PROCESS | 2357 | 05:03:32 INFO - PROCESS | 2357 | [#0] ai-astar Cycles:10 Average:116.50 Median:112.00 stddev:16.34 (14.6%) stddev-sans-first:17.21 05:03:32 INFO - PROCESS | 2357 | Values: 111.0 106.0 111.0 112.0 111.0 112.0 117.0 116.0 162.0 107.0 05:03:32 INFO - PROCESS | 2357 | 05:03:32 INFO - PROCESS | 2357 | [#1] audio-beat-detection Cycles:10 Average:140.80 Median:145.50 stddev:18.43 (12.7%) stddev-sans-first:18.33 05:03:32 INFO - PROCESS | 2357 | Values: 159.0 127.0 148.0 166.0 120.0 143.0 143.0 121.0 163.0 118.0 05:03:32 INFO - PROCESS | 2357 | 05:03:32 INFO - PROCESS | 2357 | [#2] audio-dft Cycles:10 Average:190.50 Median:187.50 stddev:10.84 (5.8%) stddev-sans-first:11.50 05:03:32 INFO - PROCESS | 2357 | Values: 190.0 189.0 187.0 188.0 184.0 187.0 187.0 186.0 186.0 221.0 05:03:32 INFO - PROCESS | 2357 | 05:03:32 INFO - PROCESS | 2357 | [#3] audio-fft Cycles:10 Average:71.00 Median:80.00 stddev:13.44 (16.8%) stddev-sans-first:14.13 05:03:32 INFO - PROCESS | 2357 | Values: 76.0 85.0 86.0 80.0 55.0 58.0 55.0 80.0 80.0 55.0 05:03:32 INFO - PROCESS | 2357 | 05:03:32 INFO - PROCESS | 2357 | [#4] audio-oscillator Cycles:10 Average:106.00 Median:78.50 stddev:25.75 (32.8%) stddev-sans-first:26.88 05:03:32 INFO - PROCESS | 2357 | Values: 93.0 91.0 126.0 78.0 79.0 83.0 120.0 112.0 120.0 158.0 05:03:32 INFO - PROCESS | 2357 | 05:03:32 INFO - PROCESS | 2357 | [#5] imaging-gaussian-blur Cycles:10 Average:87.30 Median:88.50 stddev:2.16 (2.4%) stddev-sans-first:2.06 05:03:32 INFO - PROCESS | 2357 | Values: 90.0 85.0 89.0 87.0 89.0 85.0 90.0 85.0 88.0 85.0 05:03:32 INFO - PROCESS | 2357 | 05:03:32 INFO - PROCESS | 2357 | [#6] imaging-darkroom Cycles:10 Average:94.00 Median:94.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 05:03:32 INFO - PROCESS | 2357 | Values: 93.0 94.0 94.0 94.0 94.0 95.0 94.0 95.0 93.0 94.0 05:03:32 INFO - PROCESS | 2357 | 05:03:32 INFO - PROCESS | 2357 | [#7] imaging-desaturate Cycles:10 Average:85.70 Median:86.50 stddev:1.57 (1.8%) stddev-sans-first:1.64 05:03:32 INFO - PROCESS | 2357 | Values: 85.0 85.0 87.0 83.0 87.0 88.0 85.0 84.0 87.0 86.0 05:03:32 INFO - PROCESS | 2357 | 05:03:32 INFO - PROCESS | 2357 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:54.50 stddev:3.60 (6.6%) stddev-sans-first:3.82 05:03:32 INFO - PROCESS | 2357 | Values: 55.0 55.0 54.0 54.0 53.0 54.0 54.0 65.0 55.0 52.0 05:03:32 INFO - PROCESS | 2357 | 05:03:32 INFO - PROCESS | 2357 | [#9] json-stringify-tinderbox Cycles:10 Average:81.40 Median:74.50 stddev:14.28 (19.2%) stddev-sans-first:13.85 05:03:32 INFO - PROCESS | 2357 | Values: 65.0 70.0 81.0 79.0 78.0 71.0 69.0 93.0 104.0 104.0 05:03:32 INFO - PROCESS | 2357 | 05:03:32 INFO - PROCESS | 2357 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:84.00 stddev:0.97 (1.2%) stddev-sans-first:1.01 05:03:32 INFO - PROCESS | 2357 | Values: 84.0 82.0 83.0 84.0 83.0 83.0 84.0 83.0 85.0 85.0 05:03:32 INFO - PROCESS | 2357 | 05:03:32 INFO - PROCESS | 2357 | [#11] stanford-crypto-ccm Cycles:10 Average:129.10 Median:129.00 stddev:14.90 (11.6%) stddev-sans-first:13.71 05:03:32 INFO - PROCESS | 2357 | Values: 108.0 161.0 136.0 141.0 137.0 122.0 120.0 122.0 122.0 122.0 05:03:32 INFO - PROCESS | 2357 | 05:03:32 INFO - PROCESS | 2357 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.00 Median:140.00 stddev:4.78 (3.4%) stddev-sans-first:4.35 05:03:32 INFO - PROCESS | 2357 | Values: 145.0 131.0 140.0 137.0 141.0 129.0 141.0 140.0 138.0 138.0 05:03:32 INFO - PROCESS | 2357 | 05:03:32 INFO - PROCESS | 2357 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:1.07 (1.6%) stddev-sans-first:1.13 05:03:32 INFO - PROCESS | 2357 | Values: 68.0 67.0 70.0 67.0 66.0 68.0 67.0 68.0 68.0 67.0 05:03:32 INFO - PROCESS | 2357 | -------- Summary: end -------- 05:03:32 INFO - PROCESS | 2357 | 05:03:32 INFO - TEST-INFO | 2357: exit 0 05:03:32 INFO - TEST-OK | kraken | took 56705ms 05:03:32 INFO - SUITE-END | took 1169s 05:03:32 INFO - Completed test suite (00:19:29) 05:03:32 INFO - javascript benchmark 05:03:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3348.8827891023816, 3447.603525594556, 3476.6001909780366, 3485.860565577377, 3524.4537096750014, 4474.686771925966, 5620.550355971523, 5725.914111288329, 5730.0, 5742.109972954188, 5678.48893599576, 5701.230333904921, 5762.078067509199, 5855.121731740241, 5877.735501902424, 5102.260172275018, 5132.076226279269, 5160.8709782255555, 5165.070287348276, 5264.973675131619, 5231.372235331765, 5272.789088436458, 5275.6043296752705, 5279.973600131994, 5327.760250788724, 5110.1312776827845, 5156.278121063054, 5212.218167274901, 5246.737663116829, 5255.710935898524, 5196.324477817897, 5197.090509160882, 5202.92195617066, 5215.739213039333, 5245.186996015624, 4631.0, 4873.854644158655, 5171.3277273954145, 5188.584913206934, 5232.947670523322, 5567.610267281292, 5645.661260324394, 5679.574031947621, 5694.060480020791, 5724.685142317171, 6269.216347956505, 6277.497800175975, 6278.089676996809, 6299.0551417287315, 6309.305976342599, 6284.780032698879, 6331.33520980295, 6350.364963503659, 6355.745770169187, 6360.491160707133, 5709.571782116358, 5723.313202415737, 5790.0, 5797.507211886995, 5804.593678442468, 6218.31598524162, 6231.532635052389, 6283.937160628427, 6287.931051721218, 6319.968400158062, 6094.7432096071825, 6157.692115394212, 6168.814935551941, 6169.629822210682, 6170.043643235305, 6220.533459990519, 6254.8123556293385, 6274.968625156845, 6278.717457714322, 6289.182406287245, 6135.140800782589, 6137.41694539018, 6184.938150618436, 6208.72060757267, 6227.283862355796, 6238.625682459067, 6277.654728989858, 6280.874382512324, 6301.0, 6305.716242769086, 4902.901941961212, 4904.190808516555, 4905.166121759309, 4910.508949105061, 4929.162042452792, 4305.806238719265, 4443.911121777546, 4458.130664520388, 4460.8661740147845, 4462.48681401643, 5607.66354018752, 5635.070213414822, 5644.520215781622, 5652.0391533439415, 5656.830295091154, 6197.318294987548, 6226.906596401058, 6237.812865614039, 6248.250209974741, 6335.809925702236, 5638.802641907513, 5645.463680950304, 5656.575756818255, 5673.404292549306, 5696.316442026983, 5286.7356632169, 5337.62636615441, 5346.8128615499045, 5377.247185394048, 5413.079776437936, 6191.628502289877, 6192.783252586138, 6302.905456418157, 6333.2400111985935, 6337.397947195009, 6297.779577714758, 6310.7475700971445, 6319.873602528016, 6321.462675672436, 6335.651539165206, 6198.318184999556, 6247.562670613013, 6298.149749783904, 6304.464120549805, 6321.557490975588, 6133.877322453615, 6155.169052177898, 6214.254289485109, 6216.098665693539, 6239.064140378798, 6274.874502510015, 6279.340669229848, 6286.905696414466, 6289.874202516015, 6301.495880329654, 5986.580939334205, 6102.328743838263, 6111.572189946839, 6155.96922015405, 6158.507319414526, 6121.392004143408, 6125.632462052291, 6130.734471166674, 6131.284916201153, 6133.579501509301, 5909.3795151508475, 5947.375525569752, 5960.8807823844145, 5970.910436343372, 6002.33974262822, 5942.940570594239, 6084.69576521181, 6116.853194528166, 6159.784407545893, 6169.1054797053275, 6035.396460354105, 6036.63780173191, 6039.094135879654, 6041.0636351363855, 6068.666223357758], "unit": "score", "name": "dojo.html", "value": 5705.535903175468}, {"lowerIsBetter": false, "replicates": [484.0512595313186, 569.2400645138739, 578.9247397838278, 631.930487646359, 637.7162162837536, 26991.865040674795, 37780.81109594452, 38270.8086459568, 38336.42495362565, 38501.0, 41276.79361603188, 41721.956951076165, 41787.164256714845, 41796.74609761712, 41825.16349673005, 9401.858972115406, 9651.324407291493, 9651.951740241324, 9655.5172241388, 9667.226621870268, 9457.33798634096, 9474.573644185994, 9596.992315806845, 9602.183814375787, 9603.423794572313, 9564.0, 9675.516224188797, 9740.269479789044, 9767.609295628166, 9769.560369783378, 8909.0, 9680.370775899579, 9721.513924303756, 9721.756956076084, 9739.853902191473, 9560.904390956071, 9676.516174191262, 9686.854697179548, 9696.563654635487, 9706.369086009387, 40410.59589404098, 40725.59274407248, 40820.97947551305, 40853.978650533674, 40885.38671919923, 3228.322052369005, 3263.151580589064, 3347.4811404232382, 3390.2541440882965, 3428.2800611871535, 28644.856775716198, 28917.66235064757, 28962.27594310159, 29387.85306073456, 29480.820767169287, 2696.272006558238, 2715.497632937913, 2736.4390299988454, 2833.7874659400627, 2878.975300267362, 482414.0, 484320.5783971093, 485092.0, 485206.99999999645, 485384.0, 63655.36344636494, 64085.0, 64318.678406607665, 64501.677491612245, 64768.35231647623, 59047.70476147592, 73073.63463182756, 73162.90255646169, 73169.0, 73170.9024364635, 16092.678146437005, 16281.430149944932, 16301.0, 16304.0, 16315.83684163167, 12451.25292482454, 12525.93737031309, 12534.185277956904, 12536.247825130338, 12548.749025019448, 20799.79200208009, 21119.78880211209, 21130.78869211319, 21144.365669029954, 21622.243221487173, 7196.748113815991, 7683.116441609175, 8714.389992700577, 8915.910840891638, 8933.776655583662, 978.3689520259393, 1025.74869157057, 1033.751899544104, 1079.794838980591, 1153.7346410325672, 28811.711882880903, 29167.0, 29234.0, 29491.820327186673, 29748.55377169344, 1070.5289672544056, 1084.9891501084887, 1095.1293721491434, 1098.8296813993843, 1156.4564654612318, 13343.399547020408, 14367.425302987973, 14653.413863445556, 14939.551813445614, 15474.381024759108, 649494.0, 653436.0, 660157.0, 661406.0, 661654.0, 60959.0, 61491.38508614856, 61564.0, 61603.6919815407, 61604.69197654073, 1325.9801102983463, 1445.2412483446276, 1448.826140863103, 1484.9925750371394, 1617.0217018703515, 29854.70145298519, 30304.39391212119, 30426.141316530277, 30554.862407298493, 30701.385972280877, 48361.50396688519, 48399.75800120977, 48824.511754882, 48870.51129488659, 49046.0, 341338.0, 405629.0, 413601.0, 413818.0, 414188.0, 23152.884235578713, 28428.147155585364, 33400.66397344176, 33761.0, 34126.31747365089, 39688.40467393049, 40373.798131009156, 40381.596184037786, 41116.38325425181, 41846.790766045975, 33876.0, 34143.317133657685, 34168.48747268843, 34594.0, 34871.0, 33919.15202119967, 34397.65602343944, 34471.31057378888, 35412.64587354093, 35910.64089359073, 30045.549316760702, 34792.82603586966, 35349.646503534634, 35746.0, 35814.46278305775, 31038.37923241568, 31378.686213137575, 31417.528737068504, 31419.84290078535, 31483.212919677193, 23219.678032196643, 24270.393240168432, 24328.391790205387, 25003.0, 25387.746122539276], "unit": "score", "name": "ext.html", "value": 19720.46808199098}, {"lowerIsBetter": false, "replicates": [359.8776416018554, 359.98740044098463, 367.65073180478544, 368.2212121363316, 372.78192257529344, 19171.712424313646, 19664.705029424553, 19994.30019949302, 20391.490212744688, 20457.0, 19450.70823937642, 20093.698594521094, 20380.879051652155, 20706.378808635727, 20744.585108297826, 5780.653160810344, 5949.988501954678, 5999.0, 6006.0, 6007.429294217064, 4225.323948168294, 4280.5719428057255, 4576.748278844662, 5021.221710634857, 6560.671966401685, 5316.362036555619, 6511.3488651134985, 6518.804435866908, 6547.017947307918, 6549.083128362033, 6161.383861613847, 6444.806655800334, 6461.8061458156335, 6514.055461958037, 6537.901931471008, 5445.373782015079, 5526.50261476469, 5538.196961440609, 5546.861328466821, 5554.888902221933, 24322.391940201458, 24993.62509562358, 25294.87352563244, 25380.873095634404, 25431.491370172494, 2460.6801115855005, 2879.1218678303107, 2893.42131573684, 2949.5575663650625, 3055.2056465318956, 11277.605283815026, 14232.715345693028, 14414.351354189086, 14482.855171448362, 14487.203203823785, 1654.4374912529797, 1690.9492715218564, 1698.5838469575033, 1718.5102245859996, 1733.8439540441295, 98455.50772246093, 100892.49553752184, 101507.0, 101670.0, 102017.46973795399, 9876.234654296808, 10095.343802652951, 10195.337303075275, 10217.671702678605, 10277.075063244343, 12557.74884502323, 12567.93716031414, 12600.873991260154, 12602.558910438274, 12661.36693165338, 8102.270795628422, 8265.338772898154, 8269.586520673942, 8355.03917049547, 8361.540115293596, 8431.114732952952, 8513.446625969293, 8520.786980325542, 8620.784480387914, 8627.482351058956, 5946.10808378738, 5954.791582294599, 5959.791407300723, 5966.85082872923, 5972.432618901197, 1563.3746501399303, 1664.267722202227, 1791.8387345139, 1792.5787439951862, 1798.9910050449926, 384.66149788186215, 419.26837668269064, 424.27660838270674, 794.7178751543119, 923.4320892651106, 11270.0, 11743.236689615147, 11779.293242405483, 11886.940565297118, 11934.0, 439.86734159539316, 441.5496193882222, 443.1380964025005, 457.06758213245274, 465.43217274924535, 5416.268803711528, 6044.9395506044375, 6130.448259656652, 6141.293751218578, 6158.538109641795, 506336.0, 609019.0, 615502.0, 629256.0, 632697.0, 84871.0, 103017.0, 105530.47234763777, 112449.0, 114264.0, 432.56311125763204, 450.8174189453277, 467.13113608687814, 469.2562288772266, 471.09784762180726, 10839.729006774578, 10925.890741092488, 11042.668719938414, 11122.88877111251, 11156.44217789091, 46931.53068469271, 46981.0, 47310.0, 47360.052798943136, 47972.7601361991, 64243.0, 72033.55932881418, 72130.27869721236, 72608.63695681699, 72909.27090729238, 7435.330820226206, 7655.808604784925, 7774.339181169664, 7794.986651735238, 7950.363970882431, 9457.527123643928, 11341.0, 12252.816207756712, 12358.0, 12565.120441569003, 9268.490233037248, 10603.257771955889, 10679.78131163105, 10846.794516719636, 10897.0, 10229.74425639365, 10397.428141452292, 10699.94650026745, 10749.086327662237, 11007.284526505751, 10585.311954722918, 10886.401247931122, 10950.945245273722, 11064.0, 11076.0, 7463.962680186564, 7585.886211706718, 7628.42786791004, 7638.083429988437, 7893.605319733875, 8056.83886322282, 10530.684079477627, 10784.19118566095, 10790.568377265135, 10822.621208257673], "unit": "score", "name": "jquery.html", "value": 8468.639809177923}, {"lowerIsBetter": false, "replicates": [1571.9292631831565, 1601.9118948457838, 1862.7764668239804, 1935.7096435534659, 2000.2099170827514, 8647.610857511412, 8708.172723591264, 8854.513001784899, 8870.46777193368, 8881.023087460375, 7215.314545118218, 7753.0, 7931.127575966639, 8502.91497085029, 8722.433041852275, 2416.8549887006748, 2457.0294733580226, 2459.8401103928277, 2462.753724627541, 2463.938401539958, 2153.720016397866, 2420.5312025489825, 2465.4452748131616, 2472.9629055564183, 2479.4917042006437, 2158.0936006877073, 2197.7802219778055, 2200.515886504966, 2400.867952262625, 2459.606462965926, 2358.84667496613, 2422.261210330857, 2435.817313701462, 2438.0979037755965, 2439.3901524618846, 2355.9175428859908, 2411.4333131714034, 2413.4207790130417, 2416.9274921752376, 2422.2491027781266, 8752.387332886701, 8807.867881981776, 8871.24594409476, 8871.604666740008, 8872.11278872114, 5360.303160589137, 5464.590155738296, 5514.283143191399, 5554.028045092133, 5554.333479982388, 3474.8262586870555, 3475.131217195701, 3653.926921461556, 3655.3603119453987, 3669.3030622492447, 1034.4103860799348, 1038.5638032026568, 1039.070032321076, 1053.1416895230363, 1065.5471424644572, 11840.171188016757, 11906.880931190664, 11906.880931190664, 11907.0, 11998.880011199864, 4717.908199797495, 4802.759862006886, 4847.394075740533, 4866.46468888422, 4883.804647814048, 9999.950000249952, 10077.848832267522, 10078.59685612582, 10092.74768130788, 10104.0, 5407.945450637088, 5457.890842183214, 5464.3442786865835, 5467.125259958388, 5470.261514695465, 4325.961769175438, 4828.686135401258, 4942.5304596063315, 4998.350214472168, 4999.550040496373, 3698.6116457772087, 3702.777833330009, 3711.92354217274, 3741.2330472253125, 3749.1376983293994, 1180.6044974933322, 1183.9348835814112, 1195.1275568834799, 1196.2642974570576, 1201.6875612340855, 987.1609132237684, 988.0267936082953, 1014.3052009373603, 1033.4987531047586, 1107.5680484611007, 7839.25527074927, 8072.8385432291025, 8077.313428358538, 8083.838323233503, 8087.797805054921, 1183.662656142995, 1199.1785626845638, 1199.3703305764543, 1203.8615559210627, 1235.308227392645, 6259.78090766821, 6266.216722909637, 6335.936640633627, 6339.270983836917, 6350.110984462179, 10527.631532896312, 10903.34579925207, 11012.944935275433, 11014.944925275482, 11018.779624407467, 10542.789144217073, 10785.514651840685, 10869.945650271698, 10870.0, 10887.23789334739, 8190.918090819135, 8378.581070946428, 8428.789280268042, 8438.704645337384, 8440.57797110142, 7789.883151752615, 7856.7250146244605, 7907.2488113629115, 7928.84142317162, 7930.563818990011, 9202.953985230031, 9466.242700584075, 9722.75693107678, 9723.611055557698, 9741.123298903132, 9733.124018838338, 9946.751331216778, 9961.950190249003, 10052.44711540843, 10110.747231319276, 6941.687624056828, 7024.086868707035, 7049.224585295716, 7741.380689544935, 7929.0, 8242.752717418487, 8279.95860020696, 8293.83412331762, 8313.168683131638, 8326.916730832856, 7225.891611625935, 7310.342069213796, 7334.926650733424, 7516.098068231847, 7541.019667443197, 6212.285587157535, 7144.464165187528, 7199.1361036675935, 7270.527415717961, 7372.115346158495, 7588.165301816685, 7697.923020769721, 7705.113911899979, 7705.499142555716, 7706.961465192639, 6790.354916282945, 6881.311868813279, 6903.447724182154, 6903.620300883299, 6923.792286231421, 6866.588004719732, 7042.859142817012, 7048.436125110082, 7064.0, 7093.716251349888], "unit": "score", "name": "mootools.html", "value": 4891.724742296951}, {"lowerIsBetter": false, "replicates": [318.4951851315665, 319.72982829509056, 324.3011310625603, 324.9756268279878, 330.08566271428157, 5166.302549155863, 6475.255345635253, 6536.771213007546, 6538.967305163474, 6546.149000629917, 6350.110984462179, 6444.806655800322, 6453.225612926455, 6466.900626893427, 6472.9029064564065, 4234.877757394285, 4252.702310838243, 4647.256438969765, 4734.786934587952, 4791.856244312658, 3822.503074600298, 4730.645201609876, 4734.6685731998605, 4756.738379389132, 4761.119192949298, 4698.90602187956, 4710.246360582308, 4710.670253082286, 4717.457492388367, 4726.881827954294, 4512.932306015412, 4613.077384523109, 4693.859184224479, 4725.952740472586, 4734.053189362141, 4072.1448495815916, 4077.1234184650443, 4080.367543030835, 4087.4686290782306, 4104.4664193654935, 6083.756649734005, 6159.3224745277985, 6165.445109940127, 6182.5363097767395, 6207.6275423474735, 5585.162225666142, 5598.076317407623, 5599.412061733541, 5601.887962240773, 5604.775808967636, 6857.931420685779, 6861.348171923659, 6862.656867156672, 6863.691133898987, 6875.965620171917, 4292.29177185764, 4456.46522417312, 4457.710248833815, 4464.6428285737065, 4465.82136714531, 5884.676342801187, 7067.823304417379, 7278.672459739324, 7284.417246620258, 7300.890486642705, 3946.2699400610977, 4554.521775213621, 4562.178807814559, 4562.292844609091, 4565.931511027337, 4612.3542704021465, 4622.306654001926, 4622.352870598119, 4625.283081122431, 4635.2120139576355, 5469.288992431038, 5480.177973303957, 5480.3971563128025, 5481.177823326453, 5481.643693159932, 6636.469082473391, 6863.2793556676825, 6901.240863505011, 6906.447484201251, 6921.0, 1312.2913626641507, 1577.597712583284, 1583.8891277610687, 1594.6970075685583, 1595.7446808510583, 957.129012598546, 1002.6691191906654, 1006.4866917871938, 1026.8870424253325, 1031.5306535526317, 6206.565540412128, 6307.653079080603, 6497.805065848032, 6525.510586706016, 6635.900461493082, 7214.855702885913, 7238.963805181046, 7257.52826066304, 7265.09186351706, 7275.708971641075, 6460.127882735865, 6461.676916154173, 6463.935360646427, 6471.158749362647, 6480.837979050467, 3779.3197224499854, 3816.2749077675153, 3818.6181381861593, 3825.713071519647, 3828.1003964068423, 7226.205117437078, 7513.661885215179, 7532.7740167795055, 7534.3595794357, 7537.170911199763, 7378.114626244885, 7396.852062958711, 7413.740519081806, 7422.443316751265, 7434.665440055211, 7489.475736698488, 7509.098908131059, 7512.737054203077, 7517.17311095779, 7539.283768042027, 5813.709314534171, 6869.587824730532, 7168.928310716826, 7171.1394632644415, 7179.066721326194, 7060.823479413056, 7067.151941767021, 7068.71725130989, 7076.575405475688, 7092.468064895051, 7444.888326674996, 7494.775156745306, 7499.0, 7507.249275072449, 7510.061242344707, 3881.8835434936996, 4098.9342770880385, 4168.24971505132, 4464.3973063637295, 4472.9105417892115, 7083.327083927019, 7104.644767761694, 7116.786496405116, 7121.323474269936, 7131.82324916383, 6576.177977752781, 6958.234594194736, 6960.686769095504, 6966.686499107451, 6969.58182509051, 6888.896666549906, 6937.687804048729, 6948.756793512202, 6952.270011648907, 6965.860682786417, 6766.4248538874745, 6768.221654509597, 6772.221194562689, 6786.287439818748, 6787.389134977876, 5959.463648271676, 6607.239114376418, 6934.133233345832, 6938.5143039986715, 6941.583504989717, 5900.734466949083, 6669.433098186514, 6702.36327548882, 6747.730090796509, 6802.01370801241], "unit": "score", "name": "prototype.html", "value": 5008.347314347704}, {"lowerIsBetter": false, "replicates": [672.1799404726233, 736.4513437489068, 744.2148533297373, 754.2871985973258, 755.5768769489086, 14826.629334266649, 14901.0, 15147.77278340823, 15157.772633410494, 15183.0, 13920.30398480077, 14117.0, 14128.22294773787, 14137.151770893754, 14145.222012789318, 743.6579173580133, 754.581207429879, 901.4636291406603, 932.0446542294169, 933.9206167475738, 749.887516872468, 755.0109356742685, 755.6977209116343, 904.8054668246326, 928.9502861766194, 967.5936106835146, 969.3747532841313, 971.3491960386558, 972.0182615558266, 974.2887691984855, 961.8509131084693, 962.5139304651176, 964.4213471916864, 965.3098034905006, 967.1440774914216, 565.666256908426, 573.5497634357051, 573.8565358660335, 704.3660705365161, 717.5622870049266, 14967.625809354744, 15007.0, 15049.172295523742, 15055.0, 15076.849231507655, 12527.310997895112, 12584.622461326175, 12585.0, 12688.936555317257, 12772.61682149537, 8730.646749753798, 9827.213822894151, 9921.950390248076, 9965.75085622858, 10246.18030557561, 3317.2370354818527, 3532.8410221540094, 3629.764065335745, 3636.909077273063, 3693.9076523087138, 78498.60750696267, 78597.0, 78958.0, 79237.0, 79705.20294797036, 9433.292503062297, 9465.0, 9573.808523829484, 9644.373115747454, 9797.951010244904, 20310.593788124155, 21617.67573486399, 21650.891745541172, 21751.78248217529, 21796.564068718537, 7427.888581671279, 7485.663145158481, 7491.700331986768, 7552.131504876899, 7649.082110146818, 4071.185762847442, 4119.97940010298, 4223.155368926227, 4253.21315556623, 4284.1645879053285, 3522.031441353597, 3574.0171452850673, 3574.088607405095, 3575.481555174485, 3580.749347545699, 645.2740666749906, 661.5270081891471, 663.0, 666.4801454865213, 682.1643486728817, 582.020057306593, 593.77139801176, 595.3867516458055, 606.1725744358919, 611.6727550760322, 7806.68773249075, 8093.757187284391, 8158.632861521246, 8251.463654862415, 8349.874751878726, 422.5964204184996, 526.5445389737926, 537.3283395755305, 551.4650788734921, 551.7517117297232, 3775.905602359963, 3786.6213378661914, 3833.9424908626393, 3858.112634094174, 3879.728419010642, 86931.56534217288, 88069.55965220132, 89269.0, 89393.0, 89637.55181224183, 73415.53168936592, 73990.26009739941, 74933.62533187299, 75762.0, 75995.62002189954, 62090.68954655288, 62892.0, 63381.04928426077, 64056.03915941265, 67671.99999999901, 7580.752135736824, 7639.083310002835, 7659.502132361378, 7820.804479888048, 7971.362291016821, 44031.0, 44686.10627787491, 45482.09035819199, 45821.77089114533, 45991.850203745176, 56808.43191568032, 69418.65290673514, 69470.0, 69790.25524361932, 70425.59148817098, 10777.784444311226, 10856.837147442953, 10980.560777568808, 11269.154813388865, 11668.824967625662, 12244.693882653006, 12299.262044277371, 12304.630861074182, 12325.568605098779, 12542.937285313516, 11338.433078346216, 11509.0, 11599.681655391827, 11817.940910295394, 11907.76184476323, 11463.254888432226, 11492.195546311677, 11605.76788464243, 11800.232984855957, 11825.172237943261, 11140.442977850913, 11456.599019034295, 11489.482973266056, 11618.572521106125, 12263.509459621515, 9386.906130938603, 9577.220019376067, 9648.276379271723, 9700.805983880142, 9816.018398160413, 8081.313088387553, 8616.698415555426, 8883.911160888309, 9662.0, 9680.27397945143], "unit": "score", "name": "yui.html", "value": 6796.503822511677}], "name": "dromaeo_css", "value": 7357.845541362375}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 106.0, 111.0, 112.0, 111.0, 112.0, 117.0, 116.0, 162.0, 107.0], "unit": "score", "name": "ai-astar", "value": 116.5}, {"lowerIsBetter": true, "replicates": [159.0, 127.0, 148.0, 166.0, 120.0, 143.0, 143.0, 121.0, 163.0, 118.0], "unit": "score", "name": "audio-beat-detection", "value": 140.8}, {"lowerIsBetter": true, "replicates": [190.0, 189.0, 187.0, 188.0, 184.0, 187.0, 187.0, 186.0, 186.0, 221.0], "unit": "score", "name": "audio-dft", "value": 190.5}, {"lowerIsBetter": true, "replicates": [76.0, 85.0, 86.0, 80.0, 55.0, 58.0, 55.0, 80.0, 80.0, 55.0], "unit": "score", "name": "audio-fft", "value": 71.0}, {"lowerIsBetter": true, "replicates": [93.0, 91.0, 126.0, 78.0, 79.0, 83.0, 120.0, 112.0, 120.0, 158.0], "unit": "score", "name": "audio-oscillator", "value": 106.0}, {"lowerIsBetter": true, "replicates": [90.0, 85.0, 89.0, 87.0, 89.0, 85.0, 90.0, 85.0, 88.0, 85.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 87.3}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 95.0, 93.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 94.0}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 87.0, 83.0, 87.0, 88.0, 85.0, 84.0, 87.0, 86.0], "unit": "score", "name": "imaging-desaturate", "value": 85.7}, {"lowerIsBetter": true, "replicates": [55.0, 55.0, 54.0, 54.0, 53.0, 54.0, 54.0, 65.0, 55.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 55.1}, {"lowerIsBetter": true, "replicates": [65.0, 70.0, 81.0, 79.0, 78.0, 71.0, 69.0, 93.0, 104.0, 104.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 81.4}, {"lowerIsBetter": true, "replicates": [84.0, 82.0, 83.0, 84.0, 83.0, 83.0, 84.0, 83.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.6}, {"lowerIsBetter": true, "replicates": [108.0, 161.0, 136.0, 141.0, 137.0, 122.0, 120.0, 122.0, 122.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 129.1}, {"lowerIsBetter": true, "replicates": [145.0, 131.0, 140.0, 137.0, 141.0, 129.0, 141.0, 140.0, 138.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.0}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 70.0, 67.0, 66.0, 68.0, 67.0, 68.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.6}], "name": "kraken", "value": 1446.5999999999997}]} 05:03:33 INFO - Return code: 0 05:03:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:03:33 ERROR - # TBPL SUCCESS # 05:03:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:03:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:03:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:03:33 INFO - 2016-04-07 05:03:33.084 screenresolution[2361:17646] starting screenresolution argv=screenresolution get 05:03:33 INFO - 2016-04-07 05:03:33.087 screenresolution[2361:17646] Display 0: 1600x1200x32@60 05:03:33 INFO - 2016-04-07 05:03:33.093 screenresolution[2362:17650] starting screenresolution argv=screenresolution list 05:03:33 INFO - Available Modes on Display 0 05:03:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:03:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:03:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:03:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:03:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:03:33 INFO - Intel Iris: 05:03:33 INFO - Chipset Model: Intel Iris 05:03:33 INFO - Type: GPU 05:03:33 INFO - Bus: Built-In 05:03:33 INFO - VRAM (Dynamic, Max): 1536 MB 05:03:33 INFO - Vendor: Intel (0x8086) 05:03:33 INFO - Device ID: 0x0a2e 05:03:33 INFO - Revision ID: 0x0009 05:03:33 INFO - Displays: 05:03:33 INFO - Display: 05:03:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:03:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:03:33 INFO - Display Serial Number: 1600x1200 60 05:03:33 INFO - Main Display: Yes 05:03:33 INFO - Mirror: Off 05:03:33 INFO - Online: Yes 05:03:33 INFO - Rotation: Supported 05:03:33 INFO - Return code: 0 05:03:33 INFO - Running post-action listener: _resource_record_post_action 05:03:33 INFO - Running post-run listener: _resource_record_post_run 05:03:34 INFO - Total resource usage - Wall time: 1205s; CPU: 53.0%; Read bytes: 258048; Write bytes: 694567936; Read time: 8; Write time: 2109 05:03:34 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 0; Write bytes: 398626816; Read time: 0; Write time: 799 05:03:34 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 258048; Write bytes: 295093248; Read time: 8; Write time: 1306 05:03:34 INFO - Running post-run listener: _upload_blobber_files 05:03:34 INFO - Blob upload gear active. 05:03:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:03:34 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:03:34 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:03:34 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:03:35 INFO - (blobuploader) - INFO - Open directory for files ... 05:03:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:03:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:03:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:03:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:03:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:03:36 INFO - (blobuploader) - INFO - Done attempting. 05:03:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:03:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:03:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:03:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:03:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:03:38 INFO - (blobuploader) - INFO - Done attempting. 05:03:38 INFO - (blobuploader) - INFO - Iteration through files over. 05:03:38 INFO - Return code: 0 05:03:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:03:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:03:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86b468705e7828952f4a5f8b1c684c29940f6309469673dba3979b41ee88111aaccc57d2ddeac4b8a6f4fb534551d7079d9d98c5ca57fd2d7ae7b05de56e1288", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39c157c4f7f59b9d43d20d75d0ffbc2b8e4c02fd960276d87894c22a4a3a79ab919759dcc4eaab60f179aeacc084ed3fc94a4ad88ec106ed4cc118ad04362f04"} 05:03:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:03:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:03:38 INFO - Contents: 05:03:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86b468705e7828952f4a5f8b1c684c29940f6309469673dba3979b41ee88111aaccc57d2ddeac4b8a6f4fb534551d7079d9d98c5ca57fd2d7ae7b05de56e1288", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39c157c4f7f59b9d43d20d75d0ffbc2b8e4c02fd960276d87894c22a4a3a79ab919759dcc4eaab60f179aeacc084ed3fc94a4ad88ec106ed4cc118ad04362f04"} 05:03:38 INFO - Running post-run listener: copy_logs_to_upload_dir 05:03:38 INFO - Copying logs to upload dir... 05:03:38 INFO - mkdir: /builds/slave/test/build/upload/logs 05:03:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.160616 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-04-07 05:03:38.315782) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-07 05:03:38.319325) ========= 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.Npw9aSOVsW/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.ux9uyV21Zx/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86b468705e7828952f4a5f8b1c684c29940f6309469673dba3979b41ee88111aaccc57d2ddeac4b8a6f4fb534551d7079d9d98c5ca57fd2d7ae7b05de56e1288", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39c157c4f7f59b9d43d20d75d0ffbc2b8e4c02fd960276d87894c22a4a3a79ab919759dcc4eaab60f179aeacc084ed3fc94a4ad88ec106ed4cc118ad04362f04"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011645 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86b468705e7828952f4a5f8b1c684c29940f6309469673dba3979b41ee88111aaccc57d2ddeac4b8a6f4fb534551d7079d9d98c5ca57fd2d7ae7b05de56e1288", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39c157c4f7f59b9d43d20d75d0ffbc2b8e4c02fd960276d87894c22a4a3a79ab919759dcc4eaab60f179aeacc084ed3fc94a4ad88ec106ed4cc118ad04362f04"}' ========= master_lag: 0.08 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-07 05:03:38.407162) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 05:03:38.407535) ========= 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.Npw9aSOVsW/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.ux9uyV21Zx/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.005334 ========= master_lag: 0.16 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 05:03:38.568538) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-07 05:03:38.568909) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-07 05:03:38.569367) ========= ========= Total master_lag: 0.91 =========